156 snapshot errors on Windows 2003 client

[nbustarter380]

Hello we are getting 156 errors on a windows 2003

VSS open file backups is activated

Here is the

Bpcd log

00:11:24.304 [5384.5268] <2> setup_debug_log: switched debug log file for bpcd

00:11:24.304 [5384.5268] <2> bpcd main: VERBOSE = 0

00:11:24.304 [5384.5268] <2> logparams: bpcd

00:11:24.304 [5384.5268] <2> bpcd main: Got socket for input 592

00:11:24.304 [5384.5268] <2> process_requests: offset to GMT 18000

00:11:24.304 [5384.5268] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.37905 TO 333.33.70.70.13724

00:11:24.304 [5384.5268] <2> process_requests: setup_sockopts complete

00:11:24.319 [5384.5268] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 37905

00:11:24.319 [5384.5268] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:11:24.319 [5384.5268] <4> bpcd valid_server: hostname comparison succeeded

00:11:24.319 [5384.5268] <2> process_requests: output socket port number = 1

00:11:24.335 [5384.5268] <2> process_requests: Duplicated vnetd socket on stderr

00:11:24.335 [5384.5268] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:11:24.335 [5384.5268] <2> process_requests: VERBOSE = 0

00:11:24.335 [5384.5268] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:11:24.366 [5384.5268] <2> process_requests: BPCD_FORK_CMD_RQST

00:11:24.366 [5384.5268] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpmount bpmount -i -streams

00:11:24.366 [5384.5268] <2> process_requests: filter type = -1

00:11:24.366 [5384.5268] <2> process_requests: Convert args to CreateProcess format

00:11:24.366 [5384.5268] <2> process_requests: Done converting args to CreateProcess format

00:11:24.366 [5384.5268] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpmount.exe -i -streams

00:11:24.366 [5384.5268] <2> process_requests: Before CreateProcess

00:11:24.366 [5384.5268] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:11:24.366 [5384.5268] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpmount.exe" -i -streams

00:11:24.491 [5384.5268] <2> process_requests: After CreateProcess, pid = 580

00:11:24.491 [5384.5268] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:11:25.319 [5984.5840] <2> setup_debug_log: switched debug log file for bpcd

00:11:25.319 [5984.5840] <2> bpcd main: VERBOSE = 0

00:11:25.319 [5984.5840] <2> logparams: bpcd

00:11:25.319 [5984.5840] <2> bpcd main: Got socket for input 588

00:11:25.319 [5984.5840] <2> process_requests: offset to GMT 18000

00:11:25.319 [5984.5840] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.60760 TO 333.33.70.70.13724

00:11:25.319 [5984.5840] <2> process_requests: setup_sockopts complete

00:11:25.319 [5984.5840] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 60760

00:11:25.319 [5984.5840] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:11:25.319 [5984.5840] <4> bpcd valid_server: hostname comparison succeeded

00:11:25.319 [5984.5840] <2> process_requests: output socket port number = 1

00:11:25.460 [5984.5840] <2> process_requests: Duplicated vnetd socket on stderr

00:11:25.475 [5984.5840] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:11:25.475 [5984.5840] <2> process_requests: VERBOSE = 0

00:11:25.475 [5984.5840] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:11:25.507 [5984.5840] <2> process_requests: BPCD_DISCONNECT_RQST

00:11:25.507 [5984.5840] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:11:26.085 [4928.5848] <2> setup_debug_log: switched debug log file for bpcd

00:11:26.085 [4928.5848] <2> bpcd main: VERBOSE = 0

00:11:26.085 [4928.5848] <2> logparams: bpcd

00:11:26.085 [4928.5848] <2> bpcd main: Got socket for input 604

00:11:26.085 [4928.5848] <2> process_requests: offset to GMT 18000

00:11:26.085 [4928.5848] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.58088 TO 333.33.70.70.13724

00:11:26.085 [4928.5848] <2> process_requests: setup_sockopts complete

00:11:26.085 [4928.5848] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 58088

00:11:26.085 [4928.5848] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:11:26.085 [4928.5848] <4> bpcd valid_server: hostname comparison succeeded

00:11:26.085 [4928.5848] <2> process_requests: output socket port number = 1

00:11:26.241 [4928.5848] <2> process_requests: Duplicated vnetd socket on stderr

00:11:26.241 [4928.5848] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:11:26.241 [4928.5848] <2> process_requests: VERBOSE = 0

00:11:26.241 [4928.5848] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:11:26.272 [4928.5848] <2> process_requests: BPCD_GET_VERSION_RQST

00:11:26.272 [4928.5848] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:11:26.304 [4928.5848] <2> process_requests: BPCD_GET_VERSION_RQST

00:11:26.304 [4928.5848] <2> process_requests: BPCD_GET_NB_VERSION_RQST

00:11:26.304 [4928.5848] <4> process_requests: Version string is NetBackup          7.0         700000               "D:\Program Files\Veritas\NetBackup\bin"

00:11:26.304 [4928.5848] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:11:26.304 [4928.5848] <2> process_requests: BPCD_GET_UNAME_RQST

00:11:26.304 [4928.5848] <2> getUnameInfo: UNAME_SYSNAME = Windows2003

00:11:26.304 [4928.5848] <2> getUnameInfo: UNAME_NODENAME = SPAA170

00:11:26.304 [4928.5848] <2> getUnameInfo: UNAME_RELEASE = 5

00:11:26.304 [4928.5848] <2> getUnameInfo: UNAME_VERSION = 2

00:11:26.304 [4928.5848] <2> getUnameInfo: UNAME_MACHINE = Intel x86 - Unknown - Revision x209

00:11:26.304 [4928.5848] <2> getUnameInfo: END

00:11:26.304 [4928.5848] <2> process_requests: BPCD_GET_VERSION_RQST

00:11:26.304 [4928.5848] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:11:26.304 [4928.5848] <2> read_text_file: .\bpcd_util.c.2278: file_id = 3

00:11:26.304 [4928.5848] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\bin\version.txt>

00:11:26.304 [4928.5848] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:11:26.304 [4928.5848] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:11:26.304 [4928.5848] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:11:26.304 [4928.5848] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:11:26.319 [4928.5848] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:11:26.319 [4928.5848] <2> read_text_file: .\bpcd_util.c.2278: file_id = 4

00:11:26.319 [4928.5848] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\share\ciphers.txt>

00:11:26.335 [4928.5848] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:11:26.335 [4928.5848] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:11:26.350 [4928.5848] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:11:26.350 [4928.5848] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:11:26.350 [4928.5848] <2> process_requests: BPCD_OPEN_FOR_READ_RQST

00:11:26.350 [4928.5848] <2> process_requests: open for read file name = D:\Program Files\Veritas\NetBackup\bin\version.txt

00:11:26.350 [4928.5848] <2> process_requests: buffer length = 16383

00:11:26.350 [4928.5848] <2> process_requests: our open flags = 0x0

00:11:26.350 [4928.5848] <2> process_requests: client open flags = 0x8000

00:11:26.350 [4928.5848] <2> process_requests: file size = 109

00:11:26.350 [4928.5848] <2> process_requests: completed the write of the open file number 4 to the output socket

00:11:26.350 [4928.5848] <2> process_requests: BPCD_READ_RQST

00:11:26.350 [4928.5848] <2> process_requests: read request on file number 4

00:11:26.350 [4928.5848] <2> process_requests: read request of 16383 bytes

00:11:26.350 [4928.5848] <2> process_requests: read 109 bytes

00:11:26.350 [4928.5848] <2> process_requests: Before write of read_count = 109

00:11:26.350 [4928.5848] <2> process_requests: After write of read_count

00:11:26.350 [4928.5848] <2> process_requests: completed write of file info

00:11:26.350 [4928.5848] <2> process_requests: BPCD_CLOSE_FILE_RQST

00:11:26.350 [4928.5848] <2> process_requests: BPCD_DISCONNECT_RQST

00:11:26.350 [4928.5848] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:11:26.929 [5648.2928] <2> setup_debug_log: switched debug log file for bpcd

00:11:26.929 [5648.2928] <2> bpcd main: VERBOSE = 0

00:11:26.929 [5648.2928] <2> logparams: bpcd

00:11:26.929 [5648.2928] <2> bpcd main: Got socket for input 592

00:11:26.929 [5648.2928] <2> process_requests: offset to GMT 18000

00:11:26.929 [5648.2928] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.53019 TO 333.33.70.70.13724

00:11:26.929 [5648.2928] <2> process_requests: setup_sockopts complete

00:11:26.944 [5648.2928] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 53019

00:11:26.944 [5648.2928] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:11:26.944 [5648.2928] <4> bpcd valid_server: hostname comparison succeeded

00:11:26.944 [5648.2928] <2> process_requests: output socket port number = 1

00:11:27.132 [5648.2928] <2> process_requests: Duplicated vnetd socket on stderr

00:11:27.132 [5648.2928] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:11:27.132 [5648.2928] <2> process_requests: VERBOSE = 0

00:11:27.132 [5648.2928] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:11:27.163 [5648.2928] <2> process_requests: BPCD_GET_STDOUT_SOCKET_RQST

00:11:27.163 [5648.2928] <2> process_requests: socket port number = 1

00:11:27.569 [5648.2928] <2> process_requests: Connected on output socket

00:11:27.569 [5648.2928] <2> process_requests: Skipping shutdown of send side of stdout.

00:11:27.569 [5648.2928] <2> process_requests: Duplicated socket on stdout

00:11:27.569 [5648.2928] <2> process_requests: BPCD_GET_BMR_CONFIG

00:11:27.569 [5648.2928] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bmrsavecfg bmrsavecfg -c spaa170.my.company.com -p spaa170.my.company.com -s incremental -t INCR -g 546656

00:11:27.569 [5648.2928] <2> process_requests: filter type = -1

00:11:27.569 [5648.2928] <2> process_requests: Convert args to CreateProcess format

00:11:27.569 [5648.2928] <2> process_requests: Done converting args to CreateProcess format

00:11:27.569 [5648.2928] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bmrsavecfg.exe -c spaa170.my.company.com -p spaa170.my.company.com -s incremental -t INCR -g 546656

00:11:27.569 [5648.2928] <2> process_requests: Before CreateProcess

00:11:27.569 [5648.2928] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:11:27.569 [5648.2928] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bmrsavecfg.exe" -c spaa170.my.company.com -p spaa170.my.company.com -s incremental -t INCR -g 546656

00:11:27.882 [5648.2928] <2> process_requests: After CreateProcess, pid = 5720

00:11:27.882 [5648.2928] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:11:36.272 [5028.2508] <2> setup_debug_log: switched debug log file for bpcd

00:11:36.272 [5028.2508] <2> bpcd main: VERBOSE = 0

00:11:36.272 [5028.2508] <2> logparams: bpcd

00:11:36.272 [5028.2508] <2> bpcd main: Got socket for input 584

00:11:36.272 [5028.2508] <2> process_requests: offset to GMT 18000

00:11:36.272 [5028.2508] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.41934 TO 333.33.70.70.13724

00:11:36.272 [5028.2508] <2> process_requests: setup_sockopts complete

00:11:36.272 [5028.2508] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 41934

00:11:36.272 [5028.2508] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:11:36.272 [5028.2508] <4> bpcd valid_server: hostname comparison succeeded

00:11:36.272 [5028.2508] <2> process_requests: output socket port number = 1

00:11:36.413 [5028.2508] <2> process_requests: Duplicated vnetd socket on stderr

00:11:36.413 [5028.2508] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:11:36.413 [5028.2508] <2> process_requests: VERBOSE = 0

00:11:36.413 [5028.2508] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:11:36.460 [5028.2508] <2> process_requests: BPCD_GET_VERSION_RQST

00:11:36.460 [5028.2508] <2> process_requests: BPCD_DISCONNECT_RQST

00:11:36.460 [5028.2508] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:11:37.116 [2016.5116] <2> setup_debug_log: switched debug log file for bpcd

00:11:37.116 [2016.5116] <2> bpcd main: VERBOSE = 0

00:11:37.116 [2016.5116] <2> logparams: bpcd

00:11:37.116 [2016.5116] <2> bpcd main: Got socket for input 600

00:11:37.116 [2016.5116] <2> process_requests: offset to GMT 18000

00:11:37.116 [2016.5116] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.49082 TO 333.33.70.70.13724

00:11:37.116 [2016.5116] <2> process_requests: setup_sockopts complete

00:11:37.116 [2016.5116] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 49082

00:11:37.116 [2016.5116] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:11:37.116 [2016.5116] <4> bpcd valid_server: hostname comparison succeeded

00:11:37.116 [2016.5116] <2> process_requests: output socket port number = 1

00:11:37.413 [2016.5116] <2> process_requests: Duplicated vnetd socket on stderr

00:11:37.413 [2016.5116] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:11:37.413 [2016.5116] <2> process_requests: VERBOSE = 0

00:11:37.413 [2016.5116] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:11:37.444 [2016.5116] <2> process_requests: BPCD_GET_VERSION_RQST

00:11:37.444 [2016.5116] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:11:37.475 [2016.5116] <2> process_requests: BPCD_GET_VERSION_RQST

00:11:37.475 [2016.5116] <2> process_requests: BPCD_GET_NB_VERSION_RQST

00:11:37.475 [2016.5116] <4> process_requests: Version string is NetBackup          7.0         700000               "D:\Program Files\Veritas\NetBackup\bin"

00:11:37.475 [2016.5116] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:11:37.475 [2016.5116] <2> process_requests: BPCD_GET_UNAME_RQST

00:11:37.475 [2016.5116] <2> getUnameInfo: UNAME_SYSNAME = Windows2003

00:11:37.475 [2016.5116] <2> getUnameInfo: UNAME_NODENAME = SPAA170

00:11:37.475 [2016.5116] <2> getUnameInfo: UNAME_RELEASE = 5

00:11:37.475 [2016.5116] <2> getUnameInfo: UNAME_VERSION = 2

00:11:37.475 [2016.5116] <2> getUnameInfo: UNAME_MACHINE = Intel x86 - Unknown - Revision x209

00:11:37.475 [2016.5116] <2> getUnameInfo: END

00:11:37.475 [2016.5116] <2> process_requests: BPCD_GET_VERSION_RQST

00:11:37.475 [2016.5116] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2278: file_id = 3

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\bin\version.txt>

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:11:37.475 [2016.5116] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2278: file_id = 4

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\share\ciphers.txt>

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:11:37.475 [2016.5116] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:11:37.475 [2016.5116] <2> process_requests: BPCD_OPEN_FOR_READ_RQST

00:11:37.475 [2016.5116] <2> process_requests: open for read file name = D:\Program Files\Veritas\NetBackup\bin\version.txt

00:11:37.475 [2016.5116] <2> process_requests: buffer length = 16383

00:11:37.475 [2016.5116] <2> process_requests: our open flags = 0x0

00:11:37.475 [2016.5116] <2> process_requests: client open flags = 0x8000

00:11:37.475 [2016.5116] <2> process_requests: file size = 109

00:11:37.475 [2016.5116] <2> process_requests: completed the write of the open file number 4 to the output socket

00:11:37.475 [2016.5116] <2> process_requests: BPCD_READ_RQST

00:11:37.475 [2016.5116] <2> process_requests: read request on file number 4

00:11:37.475 [2016.5116] <2> process_requests: read request of 16383 bytes

00:11:37.475 [2016.5116] <2> process_requests: read 109 bytes

00:11:37.475 [2016.5116] <2> process_requests: Before write of read_count = 109

00:11:37.475 [2016.5116] <2> process_requests: After write of read_count

00:11:37.475 [2016.5116] <2> process_requests: completed write of file info

00:11:37.475 [2016.5116] <2> process_requests: BPCD_CLOSE_FILE_RQST

00:11:37.491 [2016.5116] <2> process_requests: BPCD_DISCONNECT_RQST

00:11:37.491 [2016.5116] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:11:38.210 [4428.5528] <2> setup_debug_log: switched debug log file for bpcd

00:11:38.210 [4428.5528] <2> bpcd main: VERBOSE = 0

00:11:38.210 [4428.5528] <2> logparams: bpcd

00:11:38.210 [4428.5528] <2> bpcd main: Got socket for input 596

00:11:38.210 [4428.5528] <2> process_requests: offset to GMT 18000

00:11:38.210 [4428.5528] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.51108 TO 333.33.70.70.13724

00:11:38.210 [4428.5528] <2> process_requests: setup_sockopts complete

00:11:38.210 [4428.5528] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 51108

00:11:38.210 [4428.5528] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:11:38.225 [4428.5528] <4> bpcd valid_server: hostname comparison succeeded

00:11:38.225 [4428.5528] <2> process_requests: output socket port number = 1

00:11:38.366 [4428.5528] <2> process_requests: Duplicated vnetd socket on stderr

00:11:38.366 [4428.5528] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:11:38.366 [4428.5528] <2> process_requests: VERBOSE = 0

00:11:38.366 [4428.5528] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:11:38.413 [4428.5528] <2> process_requests: BPCD_FORK_CMD_RQST

00:11:38.413 [4428.5528] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpfis bpfis create -nbu -owner NBU -id spaa170.my.company.com_1379304680 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 13 -clnt spaa170.my.company.com -rg root -class spaa170.my.company.com -sched incremental -fso -S nbupub1 -jobid 546656 -WOFB -fim VSS

00:11:38.413 [4428.5528] <2> process_requests: filter type = -1

00:11:38.413 [4428.5528] <2> process_requests: Convert args to CreateProcess format

00:11:38.413 [4428.5528] <2> process_requests: Done converting args to CreateProcess format

00:11:38.413 [4428.5528] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpfis.exe create -nbu -owner NBU -id spaa170.my.company.com_1379304680 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 13 -clnt spaa170.my.company.com -rg root -class spaa170.my.company.com -sched incremental -fso -S nbupub1 -jobid 546656 -WOFB -fim VSS

00:11:38.413 [4428.5528] <2> process_requests: Before CreateProcess

00:11:38.413 [4428.5528] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:11:38.413 [4428.5528] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpfis.exe" create -nbu -owner NBU -id spaa170.my.company.com_1379304680 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 13 -clnt spaa170.my.company.com -rg root -class spaa170.my.company.com -sched incremental -fso -S nbupub1 -jobid 546656 -WOFB -fim VSS

00:11:38.538 [4428.5528] <2> process_requests: After CreateProcess, pid = 6072

00:11:38.538 [4428.5528] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:12:40.663 [4404.5968] <2> setup_debug_log: switched debug log file for bpcd

00:12:40.663 [4404.5968] <2> bpcd main: VERBOSE = 0

00:12:40.663 [4404.5968] <2> logparams: bpcd

00:12:40.663 [4404.5968] <2> bpcd main: Got socket for input 584

00:12:40.663 [4404.5968] <2> process_requests: offset to GMT 18000

00:12:40.663 [4404.5968] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.52935 TO 333.33.70.70.13724

00:12:40.663 [4404.5968] <2> process_requests: setup_sockopts complete

00:12:40.663 [4404.5968] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 52935

00:12:40.679 [4404.5968] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:12:40.679 [4404.5968] <4> bpcd valid_server: hostname comparison succeeded

00:12:40.679 [4404.5968] <2> process_requests: output socket port number = 1

00:12:40.835 [4404.5968] <2> process_requests: Duplicated vnetd socket on stderr

00:12:40.835 [4404.5968] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:12:40.835 [4404.5968] <2> process_requests: VERBOSE = 0

00:12:40.835 [4404.5968] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:12:40.866 [4404.5968] <2> process_requests: BPCD_GET_VERSION_RQST

00:12:40.866 [4404.5968] <2> process_requests: BPCD_DISCONNECT_RQST

00:12:40.866 [4404.5968] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:12:41.757 [2664.5564] <2> setup_debug_log: switched debug log file for bpcd

00:12:41.757 [2664.5564] <2> bpcd main: VERBOSE = 0

00:12:41.757 [2664.5564] <2> logparams: bpcd

00:12:41.757 [2664.5564] <2> bpcd main: Got socket for input 600

00:12:41.757 [2664.5564] <2> process_requests: offset to GMT 18000

00:12:41.757 [2664.5564] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.47113 TO 333.33.70.70.13724

00:12:41.757 [2664.5564] <2> process_requests: setup_sockopts complete

00:12:41.772 [2664.5564] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 47113

00:12:41.772 [2664.5564] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:12:41.772 [2664.5564] <4> bpcd valid_server: hostname comparison succeeded

00:12:41.772 [2664.5564] <2> process_requests: output socket port number = 1

00:12:41.929 [2664.5564] <2> process_requests: Duplicated vnetd socket on stderr

00:12:41.929 [2664.5564] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:12:41.929 [2664.5564] <2> process_requests: VERBOSE = 0

00:12:41.929 [2664.5564] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:12:41.975 [2664.5564] <2> process_requests: BPCD_GET_VERSION_RQST

00:12:41.975 [2664.5564] <2> process_requests: BPCD_DISCONNECT_RQST

00:12:41.975 [2664.5564] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:12:42.522 [1392.1724] <2> setup_debug_log: switched debug log file for bpcd

00:12:42.522 [1392.1724] <2> bpcd main: VERBOSE = 0

00:12:42.522 [1392.1724] <2> logparams: bpcd

00:12:42.522 [1392.1724] <2> bpcd main: Got socket for input 596

00:12:42.522 [1392.1724] <2> process_requests: offset to GMT 18000

00:12:42.522 [1392.1724] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.39960 TO 333.33.70.70.13724

00:12:42.522 [1392.1724] <2> process_requests: setup_sockopts complete

00:12:42.522 [1392.1724] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 39960

00:12:42.522 [1392.1724] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:12:42.522 [1392.1724] <4> bpcd valid_server: hostname comparison succeeded

00:12:42.522 [1392.1724] <2> process_requests: output socket port number = 1

00:12:42.694 [1392.1724] <2> process_requests: Duplicated vnetd socket on stderr

00:12:42.694 [1392.1724] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:12:42.694 [1392.1724] <2> process_requests: VERBOSE = 0

00:12:42.694 [1392.1724] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:12:42.741 [1392.1724] <2> process_requests: BPCD_GET_VERSION_RQST

00:12:42.741 [1392.1724] <2> process_requests: BPCD_DISCONNECT_RQST

00:12:42.741 [1392.1724] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:12:43.288 [2620.3984] <2> setup_debug_log: switched debug log file for bpcd

00:12:43.288 [2620.3984] <2> bpcd main: VERBOSE = 0

00:12:43.288 [2620.3984] <2> logparams: bpcd

00:12:43.288 [2620.3984] <2> bpcd main: Got socket for input 584

00:12:43.288 [2620.3984] <2> process_requests: offset to GMT 18000

00:12:43.288 [2620.3984] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.33541 TO 333.33.70.70.13724

00:12:43.288 [2620.3984] <2> process_requests: setup_sockopts complete

00:12:43.288 [2620.3984] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 33541

00:12:43.304 [2620.3984] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:12:43.304 [2620.3984] <4> bpcd valid_server: hostname comparison succeeded

00:12:43.304 [2620.3984] <2> process_requests: output socket port number = 1

00:12:43.460 [2620.3984] <2> process_requests: Duplicated vnetd socket on stderr

00:12:43.460 [2620.3984] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:12:43.460 [2620.3984] <2> process_requests: VERBOSE = 0

00:12:43.460 [2620.3984] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:12:43.491 [2620.3984] <2> process_requests: BPCD_GET_VERSION_RQST

00:12:43.507 [2620.3984] <2> process_requests: BPCD_GET_CHARSET_RQST

00:12:43.741 [2620.3984] <16> process_requests: put_long of locale code succeeded.  locale code is: 84

00:12:43.741 [2620.3984] <2> process_requests: BPCD_DISCONNECT_RQST

00:12:43.741 [2620.3984] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:12:44.491 [5236.4948] <2> setup_debug_log: switched debug log file for bpcd

00:12:44.491 [5236.4948] <2> bpcd main: VERBOSE = 0

00:12:44.491 [5236.4948] <2> logparams: bpcd

00:12:44.491 [5236.4948] <2> bpcd main: Got socket for input 600

00:12:44.491 [5236.4948] <2> process_requests: offset to GMT 18000

00:12:44.491 [5236.4948] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.41012 TO 333.33.70.70.13724

00:12:44.491 [5236.4948] <2> process_requests: setup_sockopts complete

00:12:44.491 [5236.4948] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 41012

00:12:44.491 [5236.4948] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:12:44.491 [5236.4948] <4> bpcd valid_server: hostname comparison succeeded

00:12:44.491 [5236.4948] <2> process_requests: output socket port number = 1

00:12:44.663 [5236.4948] <2> process_requests: Duplicated vnetd socket on stderr

00:12:44.663 [5236.4948] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:12:44.663 [5236.4948] <2> process_requests: VERBOSE = 0

00:12:44.663 [5236.4948] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:12:44.694 [5236.4948] <2> process_requests: BPCD_GET_VERSION_RQST

00:12:44.710 [5236.4948] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:12:44.710 [5236.4948] <2> process_requests: BPCD_FORK_CMD_RQST

00:12:44.710 [5236.4948] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpbkar bpbkar -r 4838400 -ru root -dt 86674 -to 0 -bpstart_time 1379305060 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 1 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304760 -kl 28 -ct 13 -use_ofb

00:12:44.710 [5236.4948] <2> process_requests: filter type = -1

00:12:44.710 [5236.4948] <2> process_requests: Convert args to CreateProcess format

00:12:44.710 [5236.4948] <2> process_requests: Done converting args to CreateProcess format

00:12:44.710 [5236.4948] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe -r 4838400 -ru root -dt 86674 -to 0 -bpstart_time 1379305060 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 1 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304760 -kl 28 -ct 13 -use_ofb

00:12:44.710 [5236.4948] <2> process_requests: Before CreateProcess

00:12:44.710 [5236.4948] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:12:44.710 [5236.4948] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe" -r 4838400 -ru root -dt 86674 -to 0 -bpstart_time 1379305060 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 1 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304760 -kl 28 -ct 13 -use_ofb

00:12:45.132 [5236.4948] <2> process_requests: After CreateProcess, pid = 1540

00:12:45.132 [5236.4948] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:22.288 [156.3244] <2> setup_debug_log: switched debug log file for bpcd

00:13:22.288 [156.3244] <2> bpcd main: VERBOSE = 0

00:13:22.288 [156.3244] <2> logparams: bpcd

00:13:22.288 [156.3244] <2> bpcd main: Got socket for input 596

00:13:22.304 [156.3244] <2> process_requests: offset to GMT 18000

00:13:22.304 [156.3244] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.47326 TO 333.33.70.70.13724

00:13:22.304 [156.3244] <2> process_requests: setup_sockopts complete

00:13:22.304 [156.3244] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 47326

00:13:22.304 [156.3244] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:22.304 [156.3244] <4> bpcd valid_server: hostname comparison succeeded

00:13:22.304 [156.3244] <2> process_requests: output socket port number = 1

00:13:22.507 [156.3244] <2> process_requests: Duplicated vnetd socket on stderr

00:13:22.507 [156.3244] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:22.507 [156.3244] <2> process_requests: VERBOSE = 0

00:13:22.507 [156.3244] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:22.538 [156.3244] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:22.538 [156.3244] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:22.538 [156.3244] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:23.147 [5064.4960] <2> setup_debug_log: switched debug log file for bpcd

00:13:23.147 [5064.4960] <2> bpcd main: VERBOSE = 0

00:13:23.147 [5064.4960] <2> logparams: bpcd

00:13:23.147 [5064.4960] <2> bpcd main: Got socket for input 584

00:13:23.147 [5064.4960] <2> process_requests: offset to GMT 18000

00:13:23.147 [5064.4960] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.56983 TO 333.33.70.70.13724

00:13:23.147 [5064.4960] <2> process_requests: setup_sockopts complete

00:13:23.147 [5064.4960] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 56983

00:13:23.147 [5064.4960] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:23.147 [5064.4960] <4> bpcd valid_server: hostname comparison succeeded

00:13:23.147 [5064.4960] <2> process_requests: output socket port number = 1

00:13:23.382 [5064.4960] <2> process_requests: Duplicated vnetd socket on stderr

00:13:23.382 [5064.4960] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:23.382 [5064.4960] <2> process_requests: VERBOSE = 0

00:13:23.382 [5064.4960] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:23.413 [5064.4960] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:23.413 [5064.4960] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:13:23.460 [5064.4960] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:23.460 [5064.4960] <2> process_requests: BPCD_GET_NB_VERSION_RQST

00:13:23.460 [5064.4960] <4> process_requests: Version string is NetBackup          7.0         700000               "D:\Program Files\Veritas\NetBackup\bin"

00:13:23.460 [5064.4960] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:13:23.460 [5064.4960] <2> process_requests: BPCD_GET_UNAME_RQST

00:13:23.460 [5064.4960] <2> getUnameInfo: UNAME_SYSNAME = Windows2003

00:13:23.460 [5064.4960] <2> getUnameInfo: UNAME_NODENAME = SPAA170

00:13:23.460 [5064.4960] <2> getUnameInfo: UNAME_RELEASE = 5

00:13:23.460 [5064.4960] <2> getUnameInfo: UNAME_VERSION = 2

00:13:23.460 [5064.4960] <2> getUnameInfo: UNAME_MACHINE = Intel x86 - Unknown - Revision x209

00:13:23.460 [5064.4960] <2> getUnameInfo: END

00:13:23.460 [5064.4960] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:23.460 [5064.4960] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2278: file_id = 3

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\bin\version.txt>

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:13:23.460 [5064.4960] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2278: file_id = 4

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\share\ciphers.txt>

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:13:23.460 [5064.4960] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:13:23.460 [5064.4960] <2> process_requests: BPCD_OPEN_FOR_READ_RQST

00:13:23.460 [5064.4960] <2> process_requests: open for read file name = D:\Program Files\Veritas\NetBackup\bin\version.txt

00:13:23.460 [5064.4960] <2> process_requests: buffer length = 16383

00:13:23.460 [5064.4960] <2> process_requests: our open flags = 0x0

00:13:23.460 [5064.4960] <2> process_requests: client open flags = 0x8000

00:13:23.460 [5064.4960] <2> process_requests: file size = 109

00:13:23.460 [5064.4960] <2> process_requests: completed the write of the open file number 4 to the output socket

00:13:23.460 [5064.4960] <2> process_requests: BPCD_READ_RQST

00:13:23.460 [5064.4960] <2> process_requests: read request on file number 4

00:13:23.460 [5064.4960] <2> process_requests: read request of 16383 bytes

00:13:23.460 [5064.4960] <2> process_requests: read 109 bytes

00:13:23.460 [5064.4960] <2> process_requests: Before write of read_count = 109

00:13:23.460 [5064.4960] <2> process_requests: After write of read_count

00:13:23.460 [5064.4960] <2> process_requests: completed write of file info

00:13:23.460 [5064.4960] <2> process_requests: BPCD_CLOSE_FILE_RQST

00:13:23.460 [5064.4960] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:23.460 [5064.4960] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:23.944 [4796.5392] <2> setup_debug_log: switched debug log file for bpcd

00:13:23.944 [4796.5392] <2> bpcd main: VERBOSE = 0

00:13:23.944 [4796.5392] <2> logparams: bpcd

00:13:23.944 [4796.5392] <2> bpcd main: Got socket for input 600

00:13:23.944 [4796.5392] <2> process_requests: offset to GMT 18000

00:13:23.944 [4796.5392] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.44319 TO 333.33.70.70.13724

00:13:23.944 [4796.5392] <2> process_requests: setup_sockopts complete

00:13:23.944 [4796.5392] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 44319

00:13:23.960 [4796.5392] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:23.960 [4796.5392] <4> bpcd valid_server: hostname comparison succeeded

00:13:23.960 [4796.5392] <2> process_requests: output socket port number = 1

00:13:24.054 [2296.4940] <2> setup_debug_log: switched debug log file for bpcd

00:13:24.054 [2296.4940] <2> bpcd main: VERBOSE = 0

00:13:24.054 [2296.4940] <2> logparams: bpcd

00:13:24.054 [2296.4940] <2> bpcd main: Got socket for input 592

00:13:24.054 [2296.4940] <2> process_requests: offset to GMT 18000

00:13:24.054 [2296.4940] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.58483 TO 333.33.70.70.13724

00:13:24.054 [2296.4940] <2> process_requests: setup_sockopts complete

00:13:24.069 [2296.4940] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 58483

00:13:24.069 [2296.4940] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:24.069 [2296.4940] <4> bpcd valid_server: hostname comparison succeeded

00:13:24.069 [2296.4940] <2> process_requests: output socket port number = 1

00:13:24.163 [4796.5392] <2> process_requests: Duplicated vnetd socket on stderr

00:13:24.163 [4796.5392] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:24.163 [4796.5392] <2> process_requests: VERBOSE = 0

00:13:24.163 [4796.5392] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:24.194 [4796.5392] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:24.194 [4796.5392] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:24.194 [4796.5392] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:24.257 [2296.4940] <2> process_requests: Duplicated vnetd socket on stderr

00:13:24.257 [2296.4940] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:24.257 [2296.4940] <2> process_requests: VERBOSE = 0

00:13:24.257 [2296.4940] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:24.288 [2296.4940] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:24.288 [2296.4940] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:24.288 [2296.4940] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:24.850 [4912.2304] <2> setup_debug_log: switched debug log file for bpcd

00:13:24.850 [4912.2304] <2> bpcd main: VERBOSE = 0

00:13:24.850 [4912.2304] <2> logparams: bpcd

00:13:24.850 [4912.2304] <2> bpcd main: Got socket for input 584

00:13:24.850 [4912.2304] <2> process_requests: offset to GMT 18000

00:13:24.850 [4912.2304] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.48627 TO 333.33.70.70.13724

00:13:24.850 [4912.2304] <2> process_requests: setup_sockopts complete

00:13:24.866 [4912.2304] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 48627

00:13:24.866 [4912.2304] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:24.866 [4912.2304] <4> bpcd valid_server: hostname comparison succeeded

00:13:24.866 [4912.2304] <2> process_requests: output socket port number = 1

00:13:24.975 [1732.5124] <2> setup_debug_log: switched debug log file for bpcd

00:13:24.975 [1732.5124] <2> bpcd main: VERBOSE = 0

00:13:24.975 [1732.5124] <2> logparams: bpcd

00:13:24.975 [1732.5124] <2> bpcd main: Got socket for input 604

00:13:24.975 [1732.5124] <2> process_requests: offset to GMT 18000

00:13:24.975 [1732.5124] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.43722 TO 333.33.70.70.13724

00:13:24.975 [1732.5124] <2> process_requests: setup_sockopts complete

00:13:24.991 [1732.5124] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 43722

00:13:24.991 [1732.5124] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:24.991 [1732.5124] <4> bpcd valid_server: hostname comparison succeeded

00:13:24.991 [1732.5124] <2> process_requests: output socket port number = 1

00:13:25.022 [4912.2304] <2> process_requests: Duplicated vnetd socket on stderr

00:13:25.022 [4912.2304] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:25.022 [4912.2304] <2> process_requests: VERBOSE = 0

00:13:25.022 [4912.2304] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:25.054 [4912.2304] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:25.054 [4912.2304] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:13:25.085 [4912.2304] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:25.085 [4912.2304] <2> process_requests: BPCD_GET_NB_VERSION_RQST

00:13:25.085 [4912.2304] <4> process_requests: Version string is NetBackup          7.0         700000               "D:\Program Files\Veritas\NetBackup\bin"

00:13:25.085 [4912.2304] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:13:25.085 [4912.2304] <2> process_requests: BPCD_GET_UNAME_RQST

00:13:25.085 [4912.2304] <2> getUnameInfo: UNAME_SYSNAME = Windows2003

00:13:25.085 [4912.2304] <2> getUnameInfo: UNAME_NODENAME = SPAA170

00:13:25.085 [4912.2304] <2> getUnameInfo: UNAME_RELEASE = 5

00:13:25.085 [4912.2304] <2> getUnameInfo: UNAME_VERSION = 2

00:13:25.085 [4912.2304] <2> getUnameInfo: UNAME_MACHINE = Intel x86 - Unknown - Revision x209

00:13:25.085 [4912.2304] <2> getUnameInfo: END

00:13:25.085 [4912.2304] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:25.085 [4912.2304] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2278: file_id = 3

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\bin\version.txt>

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:13:25.085 [4912.2304] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2278: file_id = 4

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\share\ciphers.txt>

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:13:25.085 [4912.2304] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:13:25.100 [4912.2304] <2> process_requests: BPCD_OPEN_FOR_READ_RQST

00:13:25.100 [4912.2304] <2> process_requests: open for read file name = D:\Program Files\Veritas\NetBackup\bin\version.txt

00:13:25.100 [4912.2304] <2> process_requests: buffer length = 16383

00:13:25.100 [4912.2304] <2> process_requests: our open flags = 0x0

00:13:25.100 [4912.2304] <2> process_requests: client open flags = 0x8000

00:13:25.100 [4912.2304] <2> process_requests: file size = 109

00:13:25.100 [4912.2304] <2> process_requests: completed the write of the open file number 4 to the output socket

00:13:25.100 [4912.2304] <2> process_requests: BPCD_READ_RQST

00:13:25.100 [4912.2304] <2> process_requests: read request on file number 4

00:13:25.100 [4912.2304] <2> process_requests: read request of 16383 bytes

00:13:25.100 [4912.2304] <2> process_requests: read 109 bytes

00:13:25.100 [4912.2304] <2> process_requests: Before write of read_count = 109

00:13:25.100 [4912.2304] <2> process_requests: After write of read_count

00:13:25.100 [4912.2304] <2> process_requests: completed write of file info

00:13:25.100 [4912.2304] <2> process_requests: BPCD_CLOSE_FILE_RQST

00:13:25.100 [4912.2304] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:25.100 [4912.2304] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:25.132 [1732.5124] <2> process_requests: Duplicated vnetd socket on stderr

00:13:25.132 [1732.5124] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:25.132 [1732.5124] <2> process_requests: VERBOSE = 0

00:13:25.132 [1732.5124] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:25.163 [1732.5124] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:25.163 [1732.5124] <2> process_requests: BPCD_GET_CHARSET_RQST

00:13:25.163 [1732.5124] <16> process_requests: put_long of locale code succeeded.  locale code is: 84

00:13:25.163 [1732.5124] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:25.163 [1732.5124] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:25.835 [5180.592] <2> setup_debug_log: switched debug log file for bpcd

00:13:25.835 [5180.592] <2> bpcd main: VERBOSE = 0

00:13:25.835 [5180.592] <2> logparams: bpcd

00:13:25.835 [5180.592] <2> bpcd main: Got socket for input 596

00:13:25.835 [5180.592] <2> process_requests: offset to GMT 18000

00:13:25.835 [5180.592] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.56944 TO 333.33.70.70.13724

00:13:25.835 [5180.592] <2> process_requests: setup_sockopts complete

00:13:25.850 [5180.592] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 56944

00:13:25.850 [5180.592] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:25.850 [5180.592] <4> bpcd valid_server: hostname comparison succeeded

00:13:25.850 [5180.592] <2> process_requests: output socket port number = 1

00:13:25.944 [5316.2420] <2> setup_debug_log: switched debug log file for bpcd

00:13:25.944 [5316.2420] <2> bpcd main: VERBOSE = 0

00:13:25.944 [5316.2420] <2> logparams: bpcd

00:13:25.944 [5316.2420] <2> bpcd main: Got socket for input 588

00:13:25.944 [5316.2420] <2> process_requests: offset to GMT 18000

00:13:25.944 [5316.2420] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.51550 TO 333.33.70.70.13724

00:13:25.944 [5316.2420] <2> process_requests: setup_sockopts complete

00:13:25.960 [5316.2420] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 51550

00:13:25.960 [5316.2420] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:25.960 [5316.2420] <4> bpcd valid_server: hostname comparison succeeded

00:13:25.960 [5316.2420] <2> process_requests: output socket port number = 1

00:13:26.007 [5180.592] <2> process_requests: Duplicated vnetd socket on stderr

00:13:26.007 [5180.592] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:26.007 [5180.592] <2> process_requests: VERBOSE = 0

00:13:26.007 [5180.592] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:26.038 [5180.592] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:26.038 [5180.592] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:26.038 [5180.592] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:26.132 [5316.2420] <2> process_requests: Duplicated vnetd socket on stderr

00:13:26.132 [5316.2420] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:26.132 [5316.2420] <2> process_requests: VERBOSE = 0

00:13:26.132 [5316.2420] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:26.163 [5316.2420] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:26.163 [5316.2420] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:13:26.163 [5316.2420] <2> process_requests: BPCD_FORK_CMD_RQST

00:13:26.163 [5316.2420] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpbkar bpbkar -r 4838400 -ru root -dt 431008 -to 0 -bpstart_time 1379305101 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 2 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304801 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:13:26.163 [5316.2420] <2> process_requests: filter type = -1

00:13:26.163 [5316.2420] <2> process_requests: Convert args to CreateProcess format

00:13:26.163 [5316.2420] <2> process_requests: Done converting args to CreateProcess format

00:13:26.163 [5316.2420] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe -r 4838400 -ru root -dt 431008 -to 0 -bpstart_time 1379305101 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 2 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304801 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:13:26.163 [5316.2420] <2> process_requests: Before CreateProcess

00:13:26.163 [5316.2420] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:13:26.163 [5316.2420] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe" -r 4838400 -ru root -dt 431008 -to 0 -bpstart_time 1379305101 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 2 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304801 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:13:26.179 [5316.2420] <2> process_requests: After CreateProcess, pid = 5652

00:13:26.179 [5316.2420] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:26.694 [2328.4680] <2> setup_debug_log: switched debug log file for bpcd

00:13:26.694 [2328.4680] <2> bpcd main: VERBOSE = 0

00:13:26.694 [2328.4680] <2> logparams: bpcd

00:13:26.694 [2328.4680] <2> bpcd main: Got socket for input 600

00:13:26.694 [2328.4680] <2> process_requests: offset to GMT 18000

00:13:26.694 [2328.4680] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.40760 TO 333.33.70.70.13724

00:13:26.694 [2328.4680] <2> process_requests: setup_sockopts complete

00:13:26.694 [2328.4680] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 40760

00:13:26.694 [2328.4680] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:26.694 [2328.4680] <4> bpcd valid_server: hostname comparison succeeded

00:13:26.694 [2328.4680] <2> process_requests: output socket port number = 1

00:13:26.991 [2328.4680] <2> process_requests: Duplicated vnetd socket on stderr

00:13:26.991 [2328.4680] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:26.991 [2328.4680] <2> process_requests: VERBOSE = 0

00:13:26.991 [2328.4680] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:27.022 [2328.4680] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:27.022 [2328.4680] <2> process_requests: BPCD_GET_CHARSET_RQST

00:13:27.038 [2328.4680] <16> process_requests: put_long of locale code succeeded.  locale code is: 84

00:13:27.038 [2328.4680] <2> process_requests: BPCD_DISCONNECT_RQST

00:13:27.038 [2328.4680] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:13:27.757 [4828.6028] <2> setup_debug_log: switched debug log file for bpcd

00:13:27.757 [4828.6028] <2> bpcd main: VERBOSE = 0

00:13:27.757 [4828.6028] <2> logparams: bpcd

00:13:27.757 [4828.6028] <2> bpcd main: Got socket for input 596

00:13:27.757 [4828.6028] <2> process_requests: offset to GMT 18000

00:13:27.757 [4828.6028] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.43212 TO 333.33.70.70.13724

00:13:27.757 [4828.6028] <2> process_requests: setup_sockopts complete

00:13:27.757 [4828.6028] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 43212

00:13:27.757 [4828.6028] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:13:27.757 [4828.6028] <4> bpcd valid_server: hostname comparison succeeded

00:13:27.772 [4828.6028] <2> process_requests: output socket port number = 1

00:13:27.975 [4828.6028] <2> process_requests: Duplicated vnetd socket on stderr

00:13:27.975 [4828.6028] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:13:27.975 [4828.6028] <2> process_requests: VERBOSE = 0

00:13:27.975 [4828.6028] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:13:28.007 [4828.6028] <2> process_requests: BPCD_GET_VERSION_RQST

00:13:28.007 [4828.6028] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:13:28.007 [4828.6028] <2> process_requests: BPCD_FORK_CMD_RQST

00:13:28.007 [4828.6028] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpbkar bpbkar -r 4838400 -ru root -dt 86716 -to 0 -bpstart_time 1379305102 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 3 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304802 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:13:28.007 [4828.6028] <2> process_requests: filter type = -1

00:13:28.007 [4828.6028] <2> process_requests: Convert args to CreateProcess format

00:13:28.007 [4828.6028] <2> process_requests: Done converting args to CreateProcess format

00:13:28.007 [4828.6028] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe -r 4838400 -ru root -dt 86716 -to 0 -bpstart_time 1379305102 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 3 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304802 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:13:28.007 [4828.6028] <2> process_requests: Before CreateProcess

00:13:28.007 [4828.6028] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:13:28.007 [4828.6028] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe" -r 4838400 -ru root -dt 86716 -to 0 -bpstart_time 1379305102 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 3 -jobgrpid 546656 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379304802 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:13:28.022 [4828.6028] <2> process_requests: After CreateProcess, pid = 3480

00:13:28.022 [4828.6028] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:14:20.757 [5164.5188] <2> setup_debug_log: switched debug log file for bpcd

00:14:20.757 [5164.5188] <2> bpcd main: VERBOSE = 0

00:14:20.757 [5164.5188] <2> logparams: bpcd

00:14:20.757 [5164.5188] <2> bpcd main: Got socket for input 584

00:14:20.757 [5164.5188] <2> process_requests: offset to GMT 18000

00:14:20.772 [5164.5188] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.48408 TO 333.33.70.70.13724

00:14:20.772 [5164.5188] <2> process_requests: setup_sockopts complete

00:14:20.772 [5164.5188] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 48408

00:14:20.772 [5164.5188] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:14:20.772 [5164.5188] <4> bpcd valid_server: hostname comparison succeeded

00:14:20.772 [5164.5188] <2> process_requests: output socket port number = 1

00:14:20.913 [5164.5188] <2> process_requests: Duplicated vnetd socket on stderr

00:14:20.913 [5164.5188] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:14:20.913 [5164.5188] <2> process_requests: VERBOSE = 0

00:14:20.913 [5164.5188] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:14:20.944 [5164.5188] <2> process_requests: BPCD_GET_VERSION_RQST

00:14:20.944 [5164.5188] <2> process_requests: BPCD_GET_VERSION_RQST

00:14:20.944 [5164.5188] <2> process_requests: BPCD_READ_USERS_CONFIG_RQST

00:14:20.991 [5164.5188] <2> process_requests: BPCD_GET_VERSION_RQST

00:14:20.991 [5164.5188] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:14:21.038 [5164.5188] <2> process_requests: BPCD_DISCONNECT_RQST

00:14:21.038 [5164.5188] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:15:05.741 [5840.332] <2> setup_debug_log: switched debug log file for bpcd

00:15:05.741 [5840.332] <2> bpcd main: VERBOSE = 0

00:15:05.741 [5840.332] <2> logparams: bpcd

00:15:05.741 [5840.332] <2> bpcd main: Got socket for input 600

00:15:05.741 [5840.332] <2> process_requests: offset to GMT 18000

00:15:05.741 [5840.332] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.51891 TO 333.33.70.70.13724

00:15:05.741 [5840.332] <2> process_requests: setup_sockopts complete

00:15:05.757 [5840.332] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 51891

00:15:05.757 [5840.332] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:15:05.757 [5840.332] <4> bpcd valid_server: hostname comparison succeeded

00:15:05.772 [5840.332] <2> process_requests: output socket port number = 1

00:15:05.866 [5840.332] <2> process_requests: Duplicated vnetd socket on stderr

00:15:05.882 [5840.332] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:15:05.882 [5840.332] <2> process_requests: VERBOSE = 0

00:15:05.882 [5840.332] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:15:05.897 [5840.332] <2> process_requests: BPCD_GET_VERSION_RQST

00:15:05.897 [5840.332] <2> process_requests: BPCD_GET_VERSION_RQST

00:15:05.897 [5840.332] <2> process_requests: BPCD_READ_USERS_CONFIG_RQST

00:15:05.975 [5840.332] <2> process_requests: BPCD_GET_VERSION_RQST

00:15:05.975 [5840.332] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:15:06.022 [5840.332] <2> process_requests: BPCD_DISCONNECT_RQST

00:15:06.022 [5840.332] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:19:30.460 [2360.5356] <2> setup_debug_log: switched debug log file for bpcd

00:19:30.460 [2360.5356] <2> bpcd main: VERBOSE = 0

00:19:30.460 [2360.5356] <2> logparams: bpcd

00:19:30.460 [2360.5356] <2> bpcd main: Got socket for input 596

00:19:30.460 [2360.5356] <2> process_requests: offset to GMT 18000

00:19:30.460 [2360.5356] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.51448 TO 333.33.70.70.13724

00:19:30.460 [2360.5356] <2> process_requests: setup_sockopts complete

00:19:30.475 [2360.5356] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 51448

00:19:30.475 [2360.5356] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:19:30.475 [2360.5356] <4> bpcd valid_server: hostname comparison succeeded

00:19:30.491 [2360.5356] <2> process_requests: output socket port number = 1

00:19:30.772 [2360.5356] <2> process_requests: Duplicated vnetd socket on stderr

00:19:30.772 [2360.5356] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:19:30.772 [2360.5356] <2> process_requests: VERBOSE = 0

00:19:30.772 [2360.5356] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:19:30.804 [2360.5356] <2> process_requests: BPCD_GET_VERSION_RQST

00:19:30.819 [2360.5356] <2> process_requests: BPCD_GET_VERSION_RQST

00:19:30.819 [2360.5356] <2> process_requests: BPCD_READ_USERS_CONFIG_RQST

00:19:30.850 [2360.5356] <2> process_requests: BPCD_GET_VERSION_RQST

00:19:30.850 [2360.5356] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:19:30.882 [2360.5356] <2> process_requests: BPCD_DISCONNECT_RQST

00:19:30.882 [2360.5356] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:19:31.679 [5056.2928] <2> setup_debug_log: switched debug log file for bpcd

00:19:31.679 [5056.2928] <2> bpcd main: VERBOSE = 0

00:19:31.679 [5056.2928] <2> logparams: bpcd

00:19:31.679 [5056.2928] <2> bpcd main: Got socket for input 584

00:19:31.679 [5056.2928] <2> process_requests: offset to GMT 18000

00:19:31.679 [5056.2928] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.60963 TO 333.33.70.70.13724

00:19:31.679 [5056.2928] <2> process_requests: setup_sockopts complete

00:19:31.694 [5056.2928] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 60963

00:19:31.694 [5056.2928] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:19:31.694 [5056.2928] <4> bpcd valid_server: hostname comparison succeeded

00:19:31.694 [5056.2928] <2> process_requests: output socket port number = 1

00:19:31.866 [5056.2928] <2> process_requests: Duplicated vnetd socket on stderr

00:19:31.866 [5056.2928] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:19:31.866 [5056.2928] <2> process_requests: VERBOSE = 0

00:19:31.866 [5056.2928] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:19:31.897 [5056.2928] <2> process_requests: BPCD_GET_VERSION_RQST

00:19:31.897 [5056.2928] <2> process_requests: BPCD_DISCONNECT_RQST

00:19:31.897 [5056.2928] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:19:32.350 [1892.1808] <2> setup_debug_log: switched debug log file for bpcd

00:19:32.350 [1892.1808] <2> bpcd main: VERBOSE = 0

00:19:32.350 [1892.1808] <2> logparams: bpcd

00:19:32.350 [1892.1808] <2> bpcd main: Got socket for input 600

00:19:32.350 [1892.1808] <2> process_requests: offset to GMT 18000

00:19:32.350 [1892.1808] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.39459 TO 333.33.70.70.13724

00:19:32.350 [1892.1808] <2> process_requests: setup_sockopts complete

00:19:32.350 [1892.1808] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 39459

00:19:32.350 [1892.1808] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:19:32.350 [1892.1808] <4> bpcd valid_server: hostname comparison succeeded

00:19:32.350 [1892.1808] <2> process_requests: output socket port number = 1

00:19:32.538 [1892.1808] <2> process_requests: Duplicated vnetd socket on stderr

00:19:32.538 [1892.1808] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:19:32.538 [1892.1808] <2> process_requests: VERBOSE = 0

00:19:32.538 [1892.1808] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:19:32.569 [1892.1808] <2> process_requests: BPCD_FORK_CMD_RQST

00:19:32.569 [1892.1808] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpfis bpfis delete -nbu -id spaa170.my.company.com_1379304680 -bpstart_to 300 -bpend_to 300 -clnt spaa170.my.company.com -S nbupub1 -jobid 546656 -copy 1

00:19:32.569 [1892.1808] <2> process_requests: filter type = -1

00:19:32.569 [1892.1808] <2> process_requests: Convert args to CreateProcess format

00:19:32.569 [1892.1808] <2> process_requests: Done converting args to CreateProcess format

00:19:32.569 [1892.1808] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpfis.exe delete -nbu -id spaa170.my.company.com_1379304680 -bpstart_to 300 -bpend_to 300 -clnt spaa170.my.company.com -S nbupub1 -jobid 546656 -copy 1

00:19:32.569 [1892.1808] <2> process_requests: Before CreateProcess

00:19:32.569 [1892.1808] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:19:32.569 [1892.1808] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpfis.exe" delete -nbu -id spaa170.my.company.com_1379304680 -bpstart_to 300 -bpend_to 300 -clnt spaa170.my.company.com -S nbupub1 -jobid 546656 -copy 1

00:19:32.569 [1892.1808] <2> process_requests: After CreateProcess, pid = 5992

00:19:32.569 [1892.1808] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:19:52.350 [2908.4636] <2> setup_debug_log: switched debug log file for bpcd

00:19:52.350 [2908.4636] <2> bpcd main: VERBOSE = 0

00:19:52.350 [2908.4636] <2> logparams: bpcd

00:19:52.350 [2908.4636] <2> bpcd main: Got socket for input 596

00:19:52.350 [2908.4636] <2> process_requests: offset to GMT 18000

00:19:52.350 [2908.4636] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.54929 TO 333.33.70.70.13724

00:19:52.350 [2908.4636] <2> process_requests: setup_sockopts complete

00:19:52.366 [2908.4636] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 54929

00:19:52.366 [2908.4636] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:19:52.366 [2908.4636] <4> bpcd valid_server: hostname comparison succeeded

00:19:52.366 [2908.4636] <2> process_requests: output socket port number = 1

00:19:52.522 [2908.4636] <2> process_requests: Duplicated vnetd socket on stderr

00:19:52.522 [2908.4636] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:19:52.522 [2908.4636] <2> process_requests: VERBOSE = 0

00:19:52.522 [2908.4636] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:19:52.569 [2908.4636] <2> process_requests: BPCD_GET_VERSION_RQST

00:19:52.569 [2908.4636] <2> process_requests: BPCD_GET_VERSION_RQST

00:19:52.569 [2908.4636] <2> process_requests: BPCD_READ_USERS_CONFIG_RQST

00:19:52.600 [2908.4636] <2> process_requests: BPCD_GET_VERSION_RQST

00:19:52.600 [2908.4636] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:19:52.632 [2908.4636] <2> process_requests: BPCD_DISCONNECT_RQST

00:19:52.632 [2908.4636] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:20:53.116 [2980.2492] <2> setup_debug_log: switched debug log file for bpcd

00:20:53.116 [2980.2492] <2> bpcd main: VERBOSE = 0

00:20:53.116 [2980.2492] <2> logparams: bpcd

00:20:53.116 [2980.2492] <2> bpcd main: Got socket for input 584

00:20:53.116 [2980.2492] <2> process_requests: offset to GMT 18000

00:20:53.116 [2980.2492] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.42173 TO 333.33.70.70.13724

00:20:53.116 [2980.2492] <2> process_requests: setup_sockopts complete

00:20:53.116 [2980.2492] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 42173

00:20:53.116 [2980.2492] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:20:53.116 [2980.2492] <4> bpcd valid_server: hostname comparison succeeded

00:20:53.116 [2980.2492] <2> process_requests: output socket port number = 1

00:20:53.366 [2980.2492] <2> process_requests: Duplicated vnetd socket on stderr

00:20:53.366 [2980.2492] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:20:53.366 [2980.2492] <2> process_requests: VERBOSE = 0

00:20:53.366 [2980.2492] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:20:53.397 [2980.2492] <2> process_requests: BPCD_DISCONNECT_RQST

00:20:53.397 [2980.2492] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:20:53.960 [5132.808] <2> setup_debug_log: switched debug log file for bpcd

00:20:53.960 [5132.808] <2> bpcd main: VERBOSE = 0

00:20:53.960 [5132.808] <2> logparams: bpcd

00:20:53.960 [5132.808] <2> bpcd main: Got socket for input 600

00:20:53.960 [5132.808] <2> process_requests: offset to GMT 18000

00:20:53.960 [5132.808] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.49116 TO 333.33.70.70.13724

00:20:53.960 [5132.808] <2> process_requests: setup_sockopts complete

00:20:53.975 [5132.808] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 49116

00:20:53.975 [5132.808] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:20:53.975 [5132.808] <4> bpcd valid_server: hostname comparison succeeded

00:20:53.975 [5132.808] <2> process_requests: output socket port number = 1

00:20:54.132 [5132.808] <2> process_requests: Duplicated vnetd socket on stderr

00:20:54.132 [5132.808] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:20:54.132 [5132.808] <2> process_requests: VERBOSE = 0

00:20:54.132 [5132.808] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:20:54.163 [5132.808] <2> process_requests: BPCD_GET_VERSION_RQST

00:20:54.163 [5132.808] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:20:54.194 [5132.808] <2> process_requests: BPCD_GET_VERSION_RQST

00:20:54.194 [5132.808] <2> process_requests: BPCD_GET_NB_VERSION_RQST

00:20:54.194 [5132.808] <4> process_requests: Version string is NetBackup             7.0         700000               "D:\Program Files\Veritas\NetBackup\bin"

00:20:54.194 [5132.808] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:20:54.194 [5132.808] <2> process_requests: BPCD_GET_UNAME_RQST

00:20:54.194 [5132.808] <2> getUnameInfo: UNAME_SYSNAME = Windows2003

00:20:54.194 [5132.808] <2> getUnameInfo: UNAME_NODENAME = SPAA170

00:20:54.194 [5132.808] <2> getUnameInfo: UNAME_RELEASE = 5

00:20:54.194 [5132.808] <2> getUnameInfo: UNAME_VERSION = 2

00:20:54.194 [5132.808] <2> getUnameInfo: UNAME_MACHINE = Intel x86 - Unknown - Revision x209

00:20:54.194 [5132.808] <2> getUnameInfo: END

00:20:54.194 [5132.808] <2> process_requests: BPCD_GET_VERSION_RQST

00:20:54.194 [5132.808] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2278: file_id = 3

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\bin\version.txt>

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:20:54.194 [5132.808] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2278: file_id = 4

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\share\ciphers.txt>

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:20:54.194 [5132.808] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:20:54.194 [5132.808] <2> process_requests: BPCD_OPEN_FOR_READ_RQST

00:20:54.194 [5132.808] <2> process_requests: open for read file name = D:\Program Files\Veritas\NetBackup\bin\version.txt

00:20:54.194 [5132.808] <2> process_requests: buffer length = 16383

00:20:54.194 [5132.808] <2> process_requests: our open flags = 0x0

00:20:54.194 [5132.808] <2> process_requests: client open flags = 0x8000

00:20:54.194 [5132.808] <2> process_requests: file size = 109

00:20:54.194 [5132.808] <2> process_requests: completed the write of the open file number 4 to the output socket

00:20:54.194 [5132.808] <2> process_requests: BPCD_READ_RQST

00:20:54.194 [5132.808] <2> process_requests: read request on file number 4

00:20:54.194 [5132.808] <2> process_requests: read request of 16383 bytes

00:20:54.194 [5132.808] <2> process_requests: read 109 bytes

00:20:54.194 [5132.808] <2> process_requests: Before write of read_count = 109

00:20:54.194 [5132.808] <2> process_requests: After write of read_count

00:20:54.194 [5132.808] <2> process_requests: completed write of file info

00:20:54.194 [5132.808] <2> process_requests: BPCD_CLOSE_FILE_RQST

00:20:54.194 [5132.808] <2> process_requests: BPCD_DISCONNECT_RQST

00:20:54.194 [5132.808] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:20:54.757 [3984.4644] <2> setup_debug_log: switched debug log file for bpcd

00:20:54.757 [3984.4644] <2> bpcd main: VERBOSE = 0

00:20:54.757 [3984.4644] <2> logparams: bpcd

00:20:54.757 [3984.4644] <2> bpcd main: Got socket for input 596

00:20:54.772 [3984.4644] <2> process_requests: offset to GMT 18000

00:20:54.772 [3984.4644] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.58641 TO 333.33.70.70.13724

00:20:54.772 [3984.4644] <2> process_requests: setup_sockopts complete

00:20:54.772 [3984.4644] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 58641

00:20:54.772 [3984.4644] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:20:54.772 [3984.4644] <4> bpcd valid_server: hostname comparison succeeded

00:20:54.772 [3984.4644] <2> process_requests: output socket port number = 1

00:20:54.882 [3984.4644] <2> process_requests: Duplicated vnetd socket on stderr

00:20:54.882 [3984.4644] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:20:54.882 [3984.4644] <2> process_requests: VERBOSE = 0

00:20:54.882 [3984.4644] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:20:54.913 [3984.4644] <2> process_requests: BPCD_GET_STDOUT_SOCKET_RQST

00:20:54.913 [3984.4644] <2> process_requests: socket port number = 1

00:20:55.210 [3984.4644] <2> process_requests: Connected on output socket

00:20:55.210 [3984.4644] <2> process_requests: Skipping shutdown of send side of stdout.

00:20:55.210 [3984.4644] <2> process_requests: Duplicated socket on stdout

00:20:55.210 [3984.4644] <2> process_requests: BPCD_GET_BMR_CONFIG

00:20:55.210 [3984.4644] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bmrsavecfg bmrsavecfg -c spaa170.my.company.com -p spaa170.my.company.com -s incremental -t INCR -g 547216

00:20:55.210 [3984.4644] <2> process_requests: filter type = -1

00:20:55.210 [3984.4644] <2> process_requests: Convert args to CreateProcess format

00:20:55.210 [3984.4644] <2> process_requests: Done converting args to CreateProcess format

00:20:55.210 [3984.4644] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bmrsavecfg.exe -c spaa170.my.company.com -p spaa170.my.company.com -s incremental -t INCR -g 547216

00:20:55.210 [3984.4644] <2> process_requests: Before CreateProcess

00:20:55.210 [3984.4644] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:20:55.210 [3984.4644] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bmrsavecfg.exe" -c spaa170.my.company.com -p spaa170.my.company.com -s incremental -t INCR -g 547216

00:20:55.210 [3984.4644] <2> process_requests: After CreateProcess, pid = 4548

00:20:55.210 [3984.4644] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:20:59.522 [428.5316] <2> setup_debug_log: switched debug log file for bpcd

00:20:59.522 [428.5316] <2> bpcd main: VERBOSE = 0

00:20:59.522 [428.5316] <2> logparams: bpcd

00:20:59.522 [428.5316] <2> bpcd main: Got socket for input 604

00:20:59.538 [428.5316] <2> process_requests: offset to GMT 18000

00:20:59.538 [428.5316] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.37069 TO 333.33.70.70.13724

00:20:59.538 [428.5316] <2> process_requests: setup_sockopts complete

00:20:59.538 [428.5316] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 37069

00:20:59.538 [428.5316] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:20:59.538 [428.5316] <4> bpcd valid_server: hostname comparison succeeded

00:20:59.538 [428.5316] <2> process_requests: output socket port number = 1

00:20:59.710 [428.5316] <2> process_requests: Duplicated vnetd socket on stderr

00:20:59.710 [428.5316] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:20:59.710 [428.5316] <2> process_requests: VERBOSE = 0

00:20:59.710 [428.5316] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:20:59.741 [428.5316] <2> process_requests: BPCD_GET_VERSION_RQST

00:20:59.741 [428.5316] <2> process_requests: BPCD_DISCONNECT_RQST

00:20:59.741 [428.5316] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:21:00.304 [5596.4804] <2> setup_debug_log: switched debug log file for bpcd

00:21:00.304 [5596.4804] <2> bpcd main: VERBOSE = 0

00:21:00.304 [5596.4804] <2> logparams: bpcd

00:21:00.304 [5596.4804] <2> bpcd main: Got socket for input 592

00:21:00.304 [5596.4804] <2> process_requests: offset to GMT 18000

00:21:00.304 [5596.4804] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.41100 TO 333.33.70.70.13724

00:21:00.304 [5596.4804] <2> process_requests: setup_sockopts complete

00:21:00.304 [5596.4804] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 41100

00:21:00.304 [5596.4804] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:21:00.304 [5596.4804] <4> bpcd valid_server: hostname comparison succeeded

00:21:00.304 [5596.4804] <2> process_requests: output socket port number = 1

00:21:00.460 [5596.4804] <2> process_requests: Duplicated vnetd socket on stderr

00:21:00.460 [5596.4804] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:21:00.460 [5596.4804] <2> process_requests: VERBOSE = 0

00:21:00.460 [5596.4804] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:21:00.491 [5596.4804] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:00.491 [5596.4804] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:21:00.522 [5596.4804] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:00.522 [5596.4804] <2> process_requests: BPCD_GET_NB_VERSION_RQST

00:21:00.522 [5596.4804] <4> process_requests: Version string is NetBackup          7.0         700000               "D:\Program Files\Veritas\NetBackup\bin"

00:21:00.522 [5596.4804] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:21:00.522 [5596.4804] <2> process_requests: BPCD_GET_UNAME_RQST

00:21:00.522 [5596.4804] <2> getUnameInfo: UNAME_SYSNAME = Windows2003

00:21:00.522 [5596.4804] <2> getUnameInfo: UNAME_NODENAME = SPAA170

00:21:00.522 [5596.4804] <2> getUnameInfo: UNAME_RELEASE = 5

00:21:00.522 [5596.4804] <2> getUnameInfo: UNAME_VERSION = 2

00:21:00.522 [5596.4804] <2> getUnameInfo: UNAME_MACHINE = Intel x86 - Unknown - Revision x209

00:21:00.522 [5596.4804] <2> getUnameInfo: END

00:21:00.522 [5596.4804] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:00.522 [5596.4804] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2278: file_id = 3

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\bin\version.txt>

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:21:00.522 [5596.4804] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2278: file_id = 4

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\share\ciphers.txt>

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:21:00.522 [5596.4804] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:21:00.522 [5596.4804] <2> process_requests: BPCD_OPEN_FOR_READ_RQST

00:21:00.522 [5596.4804] <2> process_requests: open for read file name = D:\Program Files\Veritas\NetBackup\bin\version.txt

00:21:00.522 [5596.4804] <2> process_requests: buffer length = 16383

00:21:00.522 [5596.4804] <2> process_requests: our open flags = 0x0

00:21:00.522 [5596.4804] <2> process_requests: client open flags = 0x8000

00:21:00.522 [5596.4804] <2> process_requests: file size = 109

00:21:00.522 [5596.4804] <2> process_requests: completed the write of the open file number 4 to the output socket

00:21:00.522 [5596.4804] <2> process_requests: BPCD_READ_RQST

00:21:00.522 [5596.4804] <2> process_requests: read request on file number 4

00:21:00.522 [5596.4804] <2> process_requests: read request of 16383 bytes

00:21:00.522 [5596.4804] <2> process_requests: read 109 bytes

00:21:00.522 [5596.4804] <2> process_requests: Before write of read_count = 109

00:21:00.522 [5596.4804] <2> process_requests: After write of read_count

00:21:00.522 [5596.4804] <2> process_requests: completed write of file info

00:21:00.522 [5596.4804] <2> process_requests: BPCD_CLOSE_FILE_RQST

00:21:00.522 [5596.4804] <2> process_requests: BPCD_DISCONNECT_RQST

00:21:00.522 [5596.4804] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:21:01.054 [528.1148] <2> setup_debug_log: switched debug log file for bpcd

00:21:01.054 [528.1148] <2> bpcd main: VERBOSE = 0

00:21:01.054 [528.1148] <2> logparams: bpcd

00:21:01.054 [528.1148] <2> bpcd main: Got socket for input 588

00:21:01.054 [528.1148] <2> process_requests: offset to GMT 18000

00:21:01.054 [528.1148] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.36774 TO 333.33.70.70.13724

00:21:01.054 [528.1148] <2> process_requests: setup_sockopts complete

00:21:01.054 [528.1148] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 36774

00:21:01.054 [528.1148] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:21:01.054 [528.1148] <4> bpcd valid_server: hostname comparison succeeded

00:21:01.069 [528.1148] <2> process_requests: output socket port number = 1

00:21:01.225 [528.1148] <2> process_requests: Duplicated vnetd socket on stderr

00:21:01.225 [528.1148] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:21:01.225 [528.1148] <2> process_requests: VERBOSE = 0

00:21:01.225 [528.1148] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:21:01.257 [528.1148] <2> process_requests: BPCD_FORK_CMD_RQST

00:21:01.257 [528.1148] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpfis bpfis create -nbu -owner NBU -id spaa170.my.company.com_1379305251 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 13 -clnt spaa170.my.company.com -rg root -class spaa170.my.company.com -sched incremental -fso -S nbupub1 -jobid 547216 -WOFB -fim VSS

00:21:01.257 [528.1148] <2> process_requests: filter type = -1

00:21:01.257 [528.1148] <2> process_requests: Convert args to CreateProcess format

00:21:01.257 [528.1148] <2> process_requests: Done converting args to CreateProcess format

00:21:01.257 [528.1148] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpfis.exe create -nbu -owner NBU -id spaa170.my.company.com_1379305251 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 13 -clnt spaa170.my.company.com -rg root -class spaa170.my.company.com -sched incremental -fso -S nbupub1 -jobid 547216 -WOFB -fim VSS

00:21:01.257 [528.1148] <2> process_requests: Before CreateProcess

00:21:01.257 [528.1148] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:21:01.257 [528.1148] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpfis.exe" create -nbu -owner NBU -id spaa170.my.company.com_1379305251 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 13 -clnt spaa170.my.company.com -rg root -class spaa170.my.company.com -sched incremental -fso -S nbupub1 -jobid 547216 -WOFB -fim VSS

00:21:01.257 [528.1148] <2> process_requests: After CreateProcess, pid = 4004

00:21:01.257 [528.1148] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:21:55.960 [1108.2016] <2> setup_debug_log: switched debug log file for bpcd

00:21:55.960 [1108.2016] <2> bpcd main: VERBOSE = 0

00:21:55.960 [1108.2016] <2> logparams: bpcd

00:21:55.960 [1108.2016] <2> bpcd main: Got socket for input 604

00:21:55.960 [1108.2016] <2> process_requests: offset to GMT 18000

00:21:55.960 [1108.2016] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.49667 TO 333.33.70.70.13724

00:21:55.975 [1108.2016] <2> process_requests: setup_sockopts complete

00:21:55.975 [1108.2016] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 49667

00:21:55.975 [1108.2016] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:21:55.975 [1108.2016] <4> bpcd valid_server: hostname comparison succeeded

00:21:55.975 [1108.2016] <2> process_requests: output socket port number = 1

00:21:56.116 [1108.2016] <2> process_requests: Duplicated vnetd socket on stderr

00:21:56.132 [1108.2016] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:21:56.132 [1108.2016] <2> process_requests: VERBOSE = 0

00:21:56.132 [1108.2016] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:21:56.163 [1108.2016] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:56.163 [1108.2016] <2> process_requests: BPCD_DISCONNECT_RQST

00:21:56.163 [1108.2016] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:21:57.100 [652.5356] <2> setup_debug_log: switched debug log file for bpcd

00:21:57.100 [652.5356] <2> bpcd main: VERBOSE = 0

00:21:57.100 [652.5356] <2> logparams: bpcd

00:21:57.100 [652.5356] <2> bpcd main: Got socket for input 592

00:21:57.100 [652.5356] <2> process_requests: offset to GMT 18000

00:21:57.100 [652.5356] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.55866 TO 333.33.70.70.13724

00:21:57.100 [652.5356] <2> process_requests: setup_sockopts complete

00:21:57.116 [652.5356] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 55866

00:21:57.116 [652.5356] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:21:57.116 [652.5356] <4> bpcd valid_server: hostname comparison succeeded

00:21:57.116 [652.5356] <2> process_requests: output socket port number = 1

00:21:57.335 [652.5356] <2> process_requests: Duplicated vnetd socket on stderr

00:21:57.335 [652.5356] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:21:57.335 [652.5356] <2> process_requests: VERBOSE = 0

00:21:57.335 [652.5356] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:21:57.366 [652.5356] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:57.366 [652.5356] <2> process_requests: BPCD_DISCONNECT_RQST

00:21:57.366 [652.5356] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:21:57.929 [5560.4960] <2> setup_debug_log: switched debug log file for bpcd

00:21:57.929 [5560.4960] <2> bpcd main: VERBOSE = 0

00:21:57.929 [5560.4960] <2> logparams: bpcd

00:21:57.929 [5560.4960] <2> bpcd main: Got socket for input 588

00:21:57.929 [5560.4960] <2> process_requests: offset to GMT 18000

00:21:57.929 [5560.4960] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.40617 TO 333.33.70.70.13724

00:21:57.929 [5560.4960] <2> process_requests: setup_sockopts complete

00:21:57.929 [5560.4960] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 40617

00:21:57.929 [5560.4960] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:21:57.929 [5560.4960] <4> bpcd valid_server: hostname comparison succeeded

00:21:57.944 [5560.4960] <2> process_requests: output socket port number = 1

00:21:57.991 [5560.4960] <2> process_requests: Duplicated vnetd socket on stderr

00:21:57.991 [5560.4960] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:21:57.991 [5560.4960] <2> process_requests: VERBOSE = 0

00:21:57.991 [5560.4960] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:21:58.022 [5560.4960] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:58.022 [5560.4960] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:21:58.069 [5560.4960] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:58.069 [5560.4960] <2> process_requests: BPCD_GET_NB_VERSION_RQST

00:21:58.069 [5560.4960] <4> process_requests: Version string is NetBackup          7.0         700000               "D:\Program Files\Veritas\NetBackup\bin"

00:21:58.069 [5560.4960] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:21:58.069 [5560.4960] <2> process_requests: BPCD_GET_UNAME_RQST

00:21:58.069 [5560.4960] <2> getUnameInfo: UNAME_SYSNAME = Windows2003

00:21:58.069 [5560.4960] <2> getUnameInfo: UNAME_NODENAME = SPAA170

00:21:58.069 [5560.4960] <2> getUnameInfo: UNAME_RELEASE = 5

00:21:58.069 [5560.4960] <2> getUnameInfo: UNAME_VERSION = 2

00:21:58.069 [5560.4960] <2> getUnameInfo: UNAME_MACHINE = Intel x86 - Unknown - Revision x209

00:21:58.069 [5560.4960] <2> getUnameInfo: END

00:21:58.069 [5560.4960] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:58.069 [5560.4960] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2278: file_id = 3

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\bin\version.txt>

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:21:58.069 [5560.4960] <2> process_requests: BPCD_READ_TEXT_FILE_RQST

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2278: file_id = 4

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2326: file_name = <D:\Program Files\Veritas\NetBackup\share\ciphers.txt>

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2350: v status = 0

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2353: n status = 0

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2401: v status = 0

00:21:58.069 [5560.4960] <2> read_text_file: .\bpcd_util.c.2404: n status = 0

00:21:58.069 [5560.4960] <2> process_requests: BPCD_OPEN_FOR_READ_RQST

00:21:58.069 [5560.4960] <2> process_requests: open for read file name = D:\Program Files\Veritas\NetBackup\bin\version.txt

00:21:58.069 [5560.4960] <2> process_requests: buffer length = 16383

00:21:58.069 [5560.4960] <2> process_requests: our open flags = 0x0

00:21:58.069 [5560.4960] <2> process_requests: client open flags = 0x8000

00:21:58.069 [5560.4960] <2> process_requests: file size = 109

00:21:58.069 [5560.4960] <2> process_requests: completed the write of the open file number 4 to the output socket

00:21:58.069 [5560.4960] <2> process_requests: BPCD_READ_RQST

00:21:58.069 [5560.4960] <2> process_requests: read request on file number 4

00:21:58.069 [5560.4960] <2> process_requests: read request of 16383 bytes

00:21:58.069 [5560.4960] <2> process_requests: read 109 bytes

00:21:58.069 [5560.4960] <2> process_requests: Before write of read_count = 109

00:21:58.069 [5560.4960] <2> process_requests: After write of read_count

00:21:58.069 [5560.4960] <2> process_requests: completed write of file info

00:21:58.069 [5560.4960] <2> process_requests: BPCD_CLOSE_FILE_RQST

00:21:58.069 [5560.4960] <2> process_requests: BPCD_DISCONNECT_RQST

00:21:58.069 [5560.4960] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:21:58.710 [1808.1024] <2> setup_debug_log: switched debug log file for bpcd

00:21:58.710 [1808.1024] <2> bpcd main: VERBOSE = 0

00:21:58.710 [1808.1024] <2> logparams: bpcd

00:21:58.710 [1808.1024] <2> bpcd main: Got socket for input 604

00:21:58.710 [1808.1024] <2> process_requests: offset to GMT 18000

00:21:58.710 [1808.1024] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.41768 TO 333.33.70.70.13724

00:21:58.710 [1808.1024] <2> process_requests: setup_sockopts complete

00:21:58.710 [1808.1024] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 41768

00:21:58.710 [1808.1024] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:21:58.710 [1808.1024] <4> bpcd valid_server: hostname comparison succeeded

00:21:58.710 [1808.1024] <2> process_requests: output socket port number = 1

00:21:58.866 [1808.1024] <2> process_requests: Duplicated vnetd socket on stderr

00:21:58.866 [1808.1024] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:21:58.866 [1808.1024] <2> process_requests: VERBOSE = 0

00:21:58.866 [1808.1024] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:21:58.897 [1808.1024] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:58.897 [1808.1024] <2> process_requests: BPCD_DISCONNECT_RQST

00:21:58.897 [1808.1024] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:21:59.460 [5888.5460] <2> setup_debug_log: switched debug log file for bpcd

00:21:59.460 [5888.5460] <2> bpcd main: VERBOSE = 0

00:21:59.460 [5888.5460] <2> logparams: bpcd

00:21:59.460 [5888.5460] <2> bpcd main: Got socket for input 592

00:21:59.460 [5888.5460] <2> process_requests: offset to GMT 18000

00:21:59.460 [5888.5460] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.52613 TO 333.33.70.70.13724

00:21:59.460 [5888.5460] <2> process_requests: setup_sockopts complete

00:21:59.475 [5888.5460] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 52613

00:21:59.475 [5888.5460] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:21:59.475 [5888.5460] <4> bpcd valid_server: hostname comparison succeeded

00:21:59.475 [5888.5460] <2> process_requests: output socket port number = 1

00:21:59.632 [5888.5460] <2> process_requests: Duplicated vnetd socket on stderr

00:21:59.632 [5888.5460] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:21:59.632 [5888.5460] <2> process_requests: VERBOSE = 0

00:21:59.632 [5888.5460] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:21:59.663 [5888.5460] <2> process_requests: BPCD_GET_VERSION_RQST

00:21:59.663 [5888.5460] <2> process_requests: BPCD_GET_CHARSET_RQST

00:21:59.663 [5888.5460] <16> process_requests: put_long of locale code succeeded.  locale code is: 84

00:21:59.663 [5888.5460] <2> process_requests: BPCD_DISCONNECT_RQST

00:21:59.663 [5888.5460] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:22:00.335 [4180.3960] <2> setup_debug_log: switched debug log file for bpcd

00:22:00.335 [4180.3960] <2> bpcd main: VERBOSE = 0

00:22:00.335 [4180.3960] <2> logparams: bpcd

00:22:00.335 [4180.3960] <2> bpcd main: Got socket for input 588

00:22:00.335 [4180.3960] <2> process_requests: offset to GMT 18000

00:22:00.335 [4180.3960] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.45635 TO 333.33.70.70.13724

00:22:00.335 [4180.3960] <2> process_requests: setup_sockopts complete

00:22:00.335 [4180.3960] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 45635

00:22:00.350 [4180.3960] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:22:00.350 [4180.3960] <4> bpcd valid_server: hostname comparison succeeded

00:22:00.350 [4180.3960] <2> process_requests: output socket port number = 1

00:22:00.507 [4180.3960] <2> process_requests: Duplicated vnetd socket on stderr

00:22:00.507 [4180.3960] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:22:00.507 [4180.3960] <2> process_requests: VERBOSE = 0

00:22:00.507 [4180.3960] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:22:00.538 [4180.3960] <2> process_requests: BPCD_GET_VERSION_RQST

00:22:00.538 [4180.3960] <2> process_requests: BPCD_GET_PLATFORM_RQST

00:22:00.538 [4180.3960] <2> process_requests: BPCD_FORK_CMD_RQST

00:22:00.538 [4180.3960] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpbkar bpbkar -r 4838400 -ru root -dt 431523 -to 0 -bpstart_time 1379305616 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 2 -jobgrpid 547216 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379305315 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:22:00.538 [4180.3960] <2> process_requests: filter type = -1

00:22:00.538 [4180.3960] <2> process_requests: Convert args to CreateProcess format

00:22:00.538 [4180.3960] <2> process_requests: Done converting args to CreateProcess format

00:22:00.538 [4180.3960] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe -r 4838400 -ru root -dt 431523 -to 0 -bpstart_time 1379305616 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 2 -jobgrpid 547216 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379305315 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:22:00.538 [4180.3960] <2> process_requests: Before CreateProcess

00:22:00.538 [4180.3960] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:22:00.538 [4180.3960] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe" -r 4838400 -ru root -dt 431523 -to 0 -bpstart_time 1379305616 -clnt spaa170.my.company.com -class spaa170.my.company.com -sched incremental -st INCR -bpstart_to 300 -bpend_to 300 -read_to 300 -stream_count 3 -stream_number 2 -jobgrpid 547216 -blks_per_buffer 128 -tir -tir_plus -use_otm -fso -b spaa170.my.company.com_1379305315 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb

00:22:00.538 [4180.3960] <2> process_requests: After CreateProcess, pid = 3152

00:22:00.538 [4180.3960] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:27:32.944 [1732.356] <2> setup_debug_log: switched debug log file for bpcd

00:27:32.944 [1732.356] <2> bpcd main: VERBOSE = 0

00:27:32.944 [1732.356] <2> logparams: bpcd

00:27:32.944 [1732.356] <2> bpcd main: Got socket for input 604

00:27:32.944 [1732.356] <2> process_requests: offset to GMT 18000

00:27:32.944 [1732.356] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.43348 TO 333.33.70.70.13724

00:27:32.944 [1732.356] <2> process_requests: setup_sockopts complete

00:27:32.960 [1732.356] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 43348

00:27:32.960 [1732.356] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:27:32.960 [1732.356] <4> bpcd valid_server: hostname comparison succeeded

00:27:32.960 [1732.356] <2> process_requests: output socket port number = 1

00:27:33.132 [1732.356] <2> process_requests: Duplicated vnetd socket on stderr

00:27:33.132 [1732.356] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:27:33.132 [1732.356] <2> process_requests: VERBOSE = 0

00:27:33.132 [1732.356] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:27:33.163 [1732.356] <2> process_requests: BPCD_GET_VERSION_RQST

00:27:33.163 [1732.356] <2> process_requests: BPCD_GET_VERSION_RQST

00:27:33.163 [1732.356] <2> process_requests: BPCD_READ_USERS_CONFIG_RQST

00:27:33.194 [1732.356] <2> process_requests: BPCD_GET_VERSION_RQST

00:27:33.194 [1732.356] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:27:33.225 [1732.356] <2> process_requests: BPCD_DISCONNECT_RQST

00:27:33.225 [1732.356] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:27:34.147 [936.5400] <2> setup_debug_log: switched debug log file for bpcd

00:27:34.147 [936.5400] <2> bpcd main: VERBOSE = 0

00:27:34.147 [936.5400] <2> logparams: bpcd

00:27:34.147 [936.5400] <2> bpcd main: Got socket for input 592

00:27:34.147 [936.5400] <2> process_requests: offset to GMT 18000

00:27:34.147 [936.5400] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.43759 TO 333.33.70.70.13724

00:27:34.147 [936.5400] <2> process_requests: setup_sockopts complete

00:27:34.147 [936.5400] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 43759

00:27:34.147 [936.5400] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:27:34.147 [936.5400] <4> bpcd valid_server: hostname comparison succeeded

00:27:34.147 [936.5400] <2> process_requests: output socket port number = 1

00:27:34.335 [936.5400] <2> process_requests: Duplicated vnetd socket on stderr

00:27:34.335 [936.5400] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:27:34.335 [936.5400] <2> process_requests: VERBOSE = 0

00:27:34.335 [936.5400] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:27:34.366 [936.5400] <2> process_requests: BPCD_GET_VERSION_RQST

00:27:34.366 [936.5400] <2> process_requests: BPCD_DISCONNECT_RQST

00:27:34.366 [936.5400] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:27:34.913 [1380.4016] <2> setup_debug_log: switched debug log file for bpcd

00:27:34.913 [1380.4016] <2> bpcd main: VERBOSE = 0

00:27:34.913 [1380.4016] <2> logparams: bpcd

00:27:34.913 [1380.4016] <2> bpcd main: Got socket for input 588

00:27:34.913 [1380.4016] <2> process_requests: offset to GMT 18000

00:27:34.913 [1380.4016] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.47943 TO 333.33.70.70.13724

00:27:34.913 [1380.4016] <2> process_requests: setup_sockopts complete

00:27:34.929 [1380.4016] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 47943

00:27:34.929 [1380.4016] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:27:34.929 [1380.4016] <4> bpcd valid_server: hostname comparison succeeded

00:27:34.929 [1380.4016] <2> process_requests: output socket port number = 1

00:27:35.085 [1380.4016] <2> process_requests: Duplicated vnetd socket on stderr

00:27:35.085 [1380.4016] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:27:35.085 [1380.4016] <2> process_requests: VERBOSE = 0

00:27:35.085 [1380.4016] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:27:35.116 [1380.4016] <2> process_requests: BPCD_FORK_CMD_RQST

00:27:35.116 [1380.4016] <2> process_requests: fork cmd = /usr/openv/netbackup/bin/bpfis bpfis delete -nbu -id spaa170.my.company.com_1379305251 -bpstart_to 300 -bpend_to 300 -clnt spaa170.my.company.com -S nbupub1 -jobid 547216 -copy 1

00:27:35.116 [1380.4016] <2> process_requests: filter type = -1

00:27:35.116 [1380.4016] <2> process_requests: Convert args to CreateProcess format

00:27:35.116 [1380.4016] <2> process_requests: Done converting args to CreateProcess format

00:27:35.116 [1380.4016] <2> process_requests: new fork cmd = D:\Program Files\Veritas\NetBackup\bin\bpfis.exe delete -nbu -id spaa170.my.company.com_1379305251 -bpstart_to 300 -bpend_to 300 -clnt spaa170.my.company.com -S nbupub1 -jobid 547216 -copy 1

00:27:35.116 [1380.4016] <2> process_requests: Before CreateProcess

00:27:35.116 [1380.4016] <2> process_requests: StdOutput assigned the value STDOUTSOCK

00:27:35.116 [1380.4016] <2> process_requests: final fork cmd = "D:\Program Files\Veritas\NetBackup\bin\bpfis.exe" delete -nbu -id spaa170.my.company.com_1379305251 -bpstart_to 300 -bpend_to 300 -clnt spaa170.my.company.com -S nbupub1 -jobid 547216 -copy 1

00:27:35.116 [1380.4016] <2> process_requests: After CreateProcess, pid = 5236

00:27:35.116 [1380.4016] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

00:27:55.022 [1872.4076] <2> setup_debug_log: switched debug log file for bpcd

00:27:55.022 [1872.4076] <2> bpcd main: VERBOSE = 0

00:27:55.022 [1872.4076] <2> logparams: bpcd

00:27:55.022 [1872.4076] <2> bpcd main: Got socket for input 604

00:27:55.022 [1872.4076] <2> process_requests: offset to GMT 18000

00:27:55.022 [1872.4076] <2> logconnections: BPCD ACCEPT FROM 333.33.33.33.52281 TO 333.33.70.70.13724

00:27:55.022 [1872.4076] <2> process_requests: setup_sockopts complete

00:27:55.038 [1872.4076] <2> bpcd peer_hostname: Connection from host nbupop5.mycompany.com(333.33.33.33) port 52281

00:27:55.038 [1872.4076] <2> bpcd valid_server: comparing nbupop5.mycompany.comand nbupop5.mycompany.com

00:27:55.038 [1872.4076] <4> bpcd valid_server: hostname comparison succeeded

00:27:55.038 [1872.4076] <2> process_requests: output socket port number = 1

00:27:55.210 [1872.4076] <2> process_requests: Duplicated vnetd socket on stderr

00:27:55.210 [1872.4076] <2> process_requests: <---- NetBackup 7.0 0 ------------initiated

00:27:55.210 [1872.4076] <2> process_requests: VERBOSE = 0

00:27:55.210 [1872.4076] <2> process_requests: Not using VxSS authentication with nbupop5.mycompany.com

00:27:55.241 [1872.4076] <2> process_requests: BPCD_GET_VERSION_RQST

00:27:55.241 [1872.4076] <2> process_requests: BPCD_GET_VERSION_RQST

00:27:55.241 [1872.4076] <2> process_requests: BPCD_READ_USERS_CONFIG_RQST

00:27:55.272 [1872.4076] <2> process_requests: BPCD_GET_VERSION_RQST

00:27:55.272 [1872.4076] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

00:27:55.304 [1872.4076] <2> process_requests: BPCD_DISCONNECT_RQST

00:27:55.304 [1872.4076] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

C:\> VSSADMIN LIST WRITERS

vssadmin 1.1 - Volume Shadow Copy Service administrative command-line tool

Writer name: 'System Writer'

   Writer Id: {e8132975-6f93-4464-a53e-1050253ae220}

   Writer Instance Id: {d56e95a7-de2e-421d-9f35-da23dfab2bb8}

   State: [1] Stable

   Last error: No error

Writer name: 'MSDEWriter'

   Writer Id: {f8544ac1-0611-4fa5-b04b-f7ee00b03277}

   Writer Instance Id: {a94ecf29-c742-4bfa-bbd3-2398701a776b}

   State: [1] Stable

   Last error: No error

Writer name: 'IIS Metabase Writer'

   Writer Id: {59b1f0cf-90ef-465f-9609-6ca8b2938366}

   Writer Instance Id: {b1a84af7-f8b6-4391-aa95-f8510c106674}

   State: [1] Stable

   Last error: No error

Writer name: 'Event Log Writer'

   Writer Id: {eee8c692-67ed-4250-8d86-390603070d00}

   Writer Instance Id: {8d8eac11-fe39-4fd8-8c39-8f45fa79dafe}

   State: [1] Stable

   Last error: No error

Writer name: 'Registry Writer'

   Writer Id: {afbab4a2-367d-4d15-a586-71dbb18f8485}

   Writer Instance Id: {c578628d-8353-4228-bc03-a80ddf778546}

   State: [1] Stable

   Last error: No error

Writer name: 'COM+ REGDB Writer'

   Writer Id: {542da469-d3e1-473c-9f4f-7847f01fc64f}

   Writer Instance Id: {dd3a0505-ad02-4263-8552-9ad745b2f316}

   State: [1] Stable

   Last error: No error

Writer name: 'WMI Writer'

   Writer Id: {a6ad56c2-b509-4e6c-bb19-49d8f43532f0}

   Writer Instance Id: {25429c4e-7d45-4368-b336-47bed9c83ca2}

   State: [5] Waiting for completion

   Last error: No error

Here is more info

Windows 2003 sp2 

Symantec netbackup 7.0 client

Thanks for any help in advance! Also, sorry for the long bpcd log not sure how to put it into a file yet.

[Marianne]

bpcd log file is only for connection attempts.

Snapshot info is logged in bpfis and bpbkar log.

Please copy these log files to .txt files (e.g. bpfis.txt) and upload as File Attachments (see link at bottom of page).

Please also share info about policy - what is in Backup Selection? With or without multiple data streams?

Have you checked Microsoft Support site for latest VSS patches?

[rookie11]

please tell is client server win 2003 or win 2008 R2 ?

make sure settings are enabled on master server client attributes WOFB selected  VSS enabled individual drive snapshot enabled snapshot error then continue.

how much is shadow copy storage enabled for each disk drive on client server.

[Mark_Solutions]

The WMI writer is waiting for completion - so the server needs a reboot to get it working properly again

But 7.0 is not great - what version are your Master and Media Servers?

Please get up to date - 7.1.0.4 or 7.5.0.6

As a minimum get to 7.0.1 with any EEBs needed but try and get as high as you can

Hope this helps

[nbustarter380]

Thanks to all for your responses!

Marianne

The backups full, Synthetics and Incrementals are setup for all  “Local Drives”

The admin is checking with Microsoft on the  VSS patches

Fyi- this is a remote server and I am having a issue sending the bpfis.txt file to my laptop.

Rookie11,

Windows 2003 sp2

Yes WOFB is enabled on the master client attributes

VSS enabled individual drive snapshot is enabled .

“how much is shadow copy storage enabled for each disk drive on client server”  I have to find out how to check this also

Mark Thanks,

We will have the server rebooted also

Master server is 7.5  Yes we may have to upgrade to the 7.5 client as well.

[GV89]

Not sure if WOFB is enabled on the master client attributes where is that setting? :

You can check this setting in the host properties > Client Attributes > Window open file backup

or u can use command Bpclient -help (/usr/openv/netbackup/bin/admincmd/bpclient)

[nbustarter380]

GV89  Thanks, Yes WOFB is enabled