Forum Discussion

Nick21's avatar
12 years ago

SC=58, Cannot Connect to client

Client: Windows 2008 R2, Netbackup 7.1..This is a new client..never backed up before 

Master/Media: Solaris 10, Netbackup 7.1

 

From Master Server,

1) bptestbpcd -client sestwss52 -verbose -debug

11:25:49.894 [17819] <2> bptestbpcd: VERBOSE = 0

11:25:49.900 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

11:25:49.900 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/176/def58376+0,1,50,0,2,0+sestwss52.txt

11:25:49.922 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

11:25:49.922 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/176/def58376+veritas_pbx,1,4,2,2,0+sestwss52.txt

11:25:49.933 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

11:25:49.933 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/09f/db80789f+0,1,50,0,2,0+10.104.155.81.txt

11:25:49.954 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

11:25:49.954 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/176/def58376+vnetd,1,4,2,2,0+sestwss52.txt

11:25:49.966 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

11:25:49.967 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/176/def58376+bpcd,1,4,2,2,0+sestwss52.txt

11:25:50.892 [17819] <2> vnet_pbxConnect: pbxConnectEx Succeeded

11:25:50.894 [17819] <2> logconnections: BPCD CONNECT FROM 10.105.9.40.39030 TO 10.104.155.81.1556 fd = 4

11:25:50.896 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

11:25:50.897 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/09f/db80789f+veritas_pbx,1,4,2,2,0+10.104.155.81.txt

11:25:50.909 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

11:25:50.909 [17819] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/09f/db80789f+vnetd,1,4,2,2,0+10.104.155.81.txt

11:25:50.971 [17819] <2> vnet_pbxConnect: pbxConnectEx Succeeded

11:25:52.284 [17819] <2> do_pbx_service: ../../libvlibs/vnet_connect.c.1776: 0: via PBX: VNETD CONNECT FROM 10.105.9.40.39079 TO 10.104.155.81.1556 fd = 5

11:25:52.296 [17819] <2> vnet_vnetd_connect_forward_socket_begin: ../../libvlibs/vnet_vnetd.c.445: 0: VN_REQUEST_CONNECT_FORWARD_SOCKET: 10 0x0000000a

11:25:52.612 [17819] <2> vnet_vnetd_connect_forward_socket_begin: ../../libvlibs/vnet_vnetd.c.462: 0: ipc_string: 49725

1 1 1

10.105.9.40:39030 -> 10.104.155.81:1556

10.105.9.40:39079 -> 10.104.155.81:1556

11:25:53.328 [17819] <2> bpcr_get_peername_rqst: Server peername length = 9

11:25:53.567 [17819] <2> bpcr_get_hostname_rqst: Server hostname length = 9

11:25:53.687 [17819] <2> bpcr_get_clientname_rqst: Server client name length = 9

11:25:53.808 [17819] <2> bpcr_get_version_rqst: bpcd version: 07100000

11:25:53.927 [17819] <2> bpcr_get_platform_rqst: Server client platform length = 7

11:25:54.047 [17819] <2> bpcr_get_version_rqst: bpcd version: 07100000

11:25:54.118 [17819] <2> bpcr_patch_version_rqst: theRest == > <

11:25:54.168 [17819] <2> bpcr_get_version_rqst: bpcd version: 07100000

11:25:54.188 [17819] <2> bpcr_patch_version_rqst: theRest == > <

11:25:54.287 [17819] <2> bpcr_get_version_rqst: bpcd version: 07100000

PEER_NAME = trfnbu001

HOST_NAME = SESTWSS52

CLIENT_NAME = SESTWSS52

VERSION = 0x07100000

PLATFORM = win_x64

PATCH_VERSION = 7.1.0.0

SERVER_PATCH_VERSION = 7.1.0.0

MASTER_SERVER = trfnbu001

EMM_SERVER = trfnbu001

11:25:54.416 [17819] <2> vnet_pbxConnect: pbxConnectEx Succeeded

11:25:54.483 [17819] <2> do_pbx_service: ../../libvlibs/vnet_connect.c.1776: 0: via PBX: VNETD CONNECT FROM 10.105.9.40.39260 TO 10.104.155.81.1556 fd = 6

11:25:54.483 [17819] <2> vnet_vnetd_connect_forward_socket_begin: ../../libvlibs/vnet_vnetd.c.445: 0: VN_REQUEST_CONNECT_FORWARD_SOCKET: 10 0x0000000a

11:25:54.733 [17819] <2> vnet_vnetd_connect_forward_socket_begin: ../../libvlibs/vnet_vnetd.c.462: 0: ipc_string: 49728

10.105.9.40:39260 -> 10.104.155.81:1556

<2>bptestbpcd: EXIT status = 0

11:25:54.871 [17819] <2> bptestbpcd: EXIT status = 0

 

2) bpclntcmd -hn sestwss52

host sestwss52: sestwss52.prd1.prdroot.net at 10.104.155.81

aliases:     sestwss52.prd1.prdroot.net     sestwss52     10.104.155.81

 

bpclntcmd -ip 10.104.155.81

host 10.104.155.81: sestwss52.prd1.prdroot.net at 10.104.155.81

aliases:     sestwss52.prd1.prdroot.net     10.104.155.81

 

3) nslookup sestwss52

Server:         10.105.14.3

Address:        10.105.14.3#53

 

Name:   sestwss52.prd1.prdroot.net

Address: 10.104.155.81

 

nslookup 10.104.155.81

Server:         10.105.14.3

Address:        10.105.14.3#53

 

81.155.104.10.in-addr.arpa      name = sestwss52.prd1.prdroot.net.

 

4) Able to telnet from master to client on both vnetd and bpcd

From Client:

 

C:\Program Files\VERITAS\NetBackup\bin>bpclntcmd -pn

expecting response from server trfnbu001

sestwss52.prd1.prdroot.net SESTWSS52 10.104.155.81 54600

 

C:\Program Files\VERITAS\NetBackup\bin>bpclntcmd -self

gethostname() returned: SESTWSS52

host SESTWSS52: SESTWSS52.atlantica.se at 10.104.155.81

host SESTWSS52: SESTWSS52.atlantica.se at ::1

aliases:     SESTWSS52.atlantica.se     SESTWSS52     ::1     10.104.155.81

 

C:\Program Files\VERITAS\NetBackup\bin>bpclntcmd -hn trfnbu001

host trfnbu001: trfnbu001 at 10.105.9.40

aliases:     trfnbu001     10.105.9.40

 

C:\Program Files\VERITAS\NetBackup\bin>bpclntcmd -ip 10.105.9.40

host 10.105.9.40: trfnbu001 at 10.105.9.40

aliases:     trfnbu001     10.105.9.40

 

C:\Program Files\VERITAS\NetBackup\bin>bpclntcmd -hn tvgnburtv002

host tvgnburtv002: tvgnburtv002 at 10.104.155.252

 

C:\Program Files\VERITAS\NetBackup\bin>netstat -an|find "13724"

  TCP    0.0.0.0:13724          0.0.0.0:0              LISTENING

 

C:\Program Files\VERITAS\NetBackup\bin>netstat -an|find "13782"

  TCP    0.0.0.0:13782          0.0.0.0:0              LISTENING

aliases:     tvgnburtv002     10.104.155.252

 

C:\Program Files\VERITAS\NetBackup\bin>bpclntcmd -ip 10.104.155.252

host 10.104.155.252: tvgnburtv002 at 10.104.155.252

aliases:     tvgnburtv002     10.104.155.252

Below are thr bpcd logs:

10:20:42.778 [2784.2788] <2> vnet_pbxAcceptSocket: Accepted sock[528] from 10.105.9.40:62991

10:20:42.779 [2784.2788] <2> bpcd main: accept sock = 528

10:20:43.150 [479772.469296] <2> setup_debug_log: switched debug log file for bpcd

10:20:43.151 [479772.469296] <2> bpcd main: VERBOSE = 0

10:20:43.151 [479772.469296] <2> logparams: C:\Program Files\VERITAS\NetBackup\bin\bpcd.exe -standalone

10:20:43.152 [479772.469296] <2> process_requests: offset to GMT -3600

10:20:43.158 [479772.469296] <2> logconnections: BPCD ACCEPT FROM 10.105.9.40.62991 TO 10.104.155.81.1556 fd = 528

10:20:43.158 [479772.469296] <2> process_requests: setup_sockopts complete

10:20:43.165 [479772.469296] <2> bpcd peer_hostname: Connection from host trfnbu001 (10.105.9.40) port 62991

10:20:43.165 [479772.469296] <2> bpcd valid_server: comparing trfnbu001 and trfnbu001

10:20:43.165 [479772.469296] <4> bpcd valid_server: hostname comparison succeeded

10:20:43.168 [479772.469296] <2> process_requests: output socket port number = 1

10:20:43.305 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.305 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+bprd,1,1,0,1,0+.txt

10:20:43.308 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.308 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+bpdbm,1,1,0,1,0+.txt

10:20:43.311 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.311 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+vmd,1,1,0,1,0+.txt

10:20:43.314 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.314 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+tldcd,1,1,0,1,0+.txt

10:20:43.318 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.318 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+tl8cd,1,1,0,1,0+.txt

10:20:43.320 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.320 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+tlhcd,1,1,0,1,0+.txt

10:20:43.323 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.323 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+tl4d,1,1,0,1,0+.txt

10:20:43.326 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.326 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+tlmd,1,1,0,1,0+.txt

10:20:43.328 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.328 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+tshd,1,1,0,1,0+.txt

10:20:43.331 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.331 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+acsd,1,1,0,1,0+.txt

10:20:43.334 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.334 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+bpjobd,1,1,0,1,0+.txt

10:20:43.336 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.336 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1ff\ffffffff+testdaemon,1,1,0,1,0+.txt

10:20:43.338 [479772.469296] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006

10:20:43.338 [479772.469296] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 10109 0x0000277d

10:20:43.338 [479772.469296] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon

10:20:43.338 [479772.469296] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006

10:20:43.338 [479772.469296] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 62550

10:20:43.338 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.338 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\14f\6cf9fd4f+62550,1,0,2,1,0+127.0.0.1.txt

10:20:43.367 [479772.469296] <2> process_requests: Duplicated vnetd socket on stderr

10:20:43.367 [479772.469296] <2> process_requests: <---- NetBackup 7.1 0 ------------initiated

10:20:43.367 [479772.469296] <2> process_requests: VERBOSE = 0

10:20:43.367 [479772.469296] <2> process_requests: Not using VxSS authentication with trfnbu001

10:20:43.408 [479772.469296] <2> process_requests: BPCD_GET_STDOUT_SOCKET_RQST

10:20:43.408 [479772.469296] <2> process_requests: socket port number = 1

10:20:43.840 [479772.469296] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 10109 0x0000277d

10:20:43.840 [479772.469296] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL

10:20:43.840 [479772.469296] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon

10:20:43.840 [479772.469296] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006

10:20:43.840 [479772.469296] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 10109 0x0000277d

10:20:43.840 [479772.469296] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon

10:20:43.840 [479772.469296] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006

10:20:43.840 [479772.469296] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 62553

10:20:43.841 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:20:43.841 [479772.469296] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\14f\6cf9fd4f+62553,1,0,2,1,0+127.0.0.1.txt

10:20:43.867 [479772.469296] <2> process_requests: Connected on output socket

10:20:43.867 [479772.469296] <2> process_requests: Skipping shutdown of send side of stdout.

10:20:43.867 [479772.469296] <2> process_requests: Duplicated socket on stdout

10:20:43.869 [479772.469296] <2> process_requests: BPCD_DISCONNECT_RQST

10:20:43.869 [479772.469296] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

10:21:13.697 [2784.2788] <2> vnet_pbxAcceptSocket: Accepted sock[528] from 10.105.9.40:63965

10:21:13.697 [2784.2788] <2> bpcd main: accept sock = 528

10:21:13.742 [397524.460896] <2> setup_debug_log: switched debug log file for bpcd

10:21:13.742 [397524.460896] <2> bpcd main: VERBOSE = 0

10:21:13.742 [397524.460896] <2> logparams: C:\Program Files\VERITAS\NetBackup\bin\bpcd.exe -standalone

10:21:13.743 [397524.460896] <2> process_requests: offset to GMT -3600

10:21:13.749 [397524.460896] <2> logconnections: BPCD ACCEPT FROM 10.105.9.40.63965 TO 10.104.155.81.1556 fd = 528

10:21:13.749 [397524.460896] <2> process_requests: setup_sockopts complete

10:21:13.756 [397524.460896] <2> bpcd peer_hostname: Connection from host trfnbu001 (10.105.9.40) port 63965

10:21:13.756 [397524.460896] <2> bpcd valid_server: comparing trfnbu001 and trfnbu001

10:21:13.756 [397524.460896] <4> bpcd valid_server: hostname comparison succeeded

10:21:13.757 [397524.460896] <2> process_requests: output socket port number = 1

10:21:14.133 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 10109 0x0000277d

10:21:14.133 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL

10:21:14.133 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon

10:21:14.133 [397524.460896] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006

10:21:14.133 [397524.460896] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 10109 0x0000277d

10:21:14.133 [397524.460896] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon

10:21:14.134 [397524.460896] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006

10:21:14.134 [397524.460896] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 62610

10:21:14.134 [397524.460896] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:21:14.134 [397524.460896] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\14f\6cf9fd4f+62610,1,0,2,1,0+127.0.0.1.txt

10:21:14.161 [397524.460896] <2> process_requests: Duplicated vnetd socket on stderr

10:21:14.161 [397524.460896] <2> process_requests: <---- NetBackup 7.1 0 ------------initiated

10:21:14.161 [397524.460896] <2> process_requests: VERBOSE = 0

10:21:14.162 [397524.460896] <2> process_requests: Not using VxSS authentication with trfnbu001

10:21:14.241 [397524.460896] <2> process_requests: BPCD_PEERNAME_RQST

10:21:14.242 [397524.460896] <2> bpcd peer_hostname: Connection from host trfnbu001 (10.105.9.40) port 63965

10:21:14.358 [397524.460896] <2> process_requests: BPCD_HOSTNAME_RQST

10:21:14.359 [397524.460896] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:21:14.359 [397524.460896] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\1f5\f8ab5bf5+0,1,2,0,1,0+w2k8desoe532c50.txt

10:21:14.373 [397524.460896] <2> retry_getaddrinfo_for_real: ../../libvlibs/vnet_addrinfo.c.1016: 0: getaddrinfo() failed: 11001 0x00002af9

10:21:14.373 [397524.460896] <2> retry_getaddrinfo_for_real: ../../libvlibs/vnet_addrinfo.c.1018: 0: getaddrinfo() failed name: W2K8DESOE532C50

10:21:14.373 [397524.460896] <2> retry_getaddrinfo_for_real: ../../libvlibs/vnet_addrinfo.c.1020: 0: getaddrinfo() failed service: 0

10:21:14.373 [397524.460896] <2> retry_getaddrinfo: ../../libvlibs/vnet_addrinfo.c.901: 0: retry_getaddrinfo_for_real failed: 11001 0x00002af9

10:21:14.373 [397524.460896] <2> retry_getaddrinfo: ../../libvlibs/vnet_addrinfo.c.902: 0: retry_getaddrinfo_for_real failed name: W2K8DESOE532C50

10:21:14.373 [397524.460896] <2> retry_getaddrinfo: ../../libvlibs/vnet_addrinfo.c.904: 0: retry_getaddrinfo_for_real failed service: 0

10:21:14.373 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1566: 0: retry_getaddrinfo() failed: 11001 0x00002af9

10:21:14.373 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1567: 0: retry_getaddrinfo() failed name: W2K8DESOE532C50

10:21:14.373 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1569: 0: retry_getaddrinfo() failed service: NULL

10:21:14.373 [397524.460896] <2> vnet_cached_getaddrinfo: ../../libvlibs/vnet_addrinfo.c.1223: 0: vnet_cached_getaddrinfo_and_update() failed: 6 0x00000006

10:21:14.373 [397524.460896] <2> vnet_is_local_host: ../../libvlibs/vnet_addrinfo.c.322: 0: vnet_cached_getaddrinfo() failed: 6 0x00000006

10:21:14.373 [397524.460896] <2> vnet_is_local_host: ../../libvlibs/vnet_addrinfo.c.323: 0: vnet_cached_getaddrinfo() failed: 11001 0x00002af9

10:21:14.373 [397524.460896] <2> vnet_is_local_host: ../../libvlibs/vnet_addrinfo.c.324: 0: vnet_cached_getaddrinfo() failed: W2K8DESOE532C50

10:21:14.478 [397524.460896] <2> process_requests: BPCD_CLIENTNAME_RQST

10:21:14.598 [397524.460896] <2> process_requests: BPCD_GET_VERSION_RQST

10:21:14.719 [397524.460896] <2> process_requests: BPCD_GET_PLATFORM_RQST

10:21:14.839 [397524.460896] <2> process_requests: BPCD_GET_VERSION_RQST

10:21:14.959 [397524.460896] <2> process_requests: BPCD_PATCH_VERSION_RQST

10:21:14.959 [397524.460896] <2> retrieveLocalPatchVersion: Reading from C:\Program Files\VERITAS\NetBackup\bin\version.txt

10:21:14.970 [397524.460896] <2> parsePatchVersionString: parsing = >7.1

10:21:14.970 [397524.460896] <2> parsePatchVersionString: theRest = ><

10:21:15.079 [397524.460896] <2> process_requests: BPCD_GET_VERSION_RQST

10:21:15.081 [397524.460896] <2> process_requests: BPCD_PATCH_VERSION_RQST

10:21:15.081 [397524.460896] <2> retrieveLocalPatchVersion: Reading from C:\Program Files\VERITAS\NetBackup\version.txt

10:21:15.081 [397524.460896] <2> parsePatchVersionString: parsing = >7.1

10:21:15.081 [397524.460896] <2> parsePatchVersionString: theRest = ><

10:21:15.199 [397524.460896] <2> process_requests: BPCD_GET_VERSION_RQST

10:21:15.200 [397524.460896] <2> process_requests: BPCD_READ_HOST_CONFIG_RQST

10:21:15.320 [397524.460896] <2> process_requests: BPCD_GET_STDOUT_SOCKET_RQST

10:21:15.320 [397524.460896] <2> process_requests: socket port number = 1

10:21:15.733 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 10109 0x0000277d

10:21:15.733 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL

10:21:15.733 [397524.460896] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon

10:21:15.733 [397524.460896] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006

10:21:15.733 [397524.460896] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 10109 0x0000277d

10:21:15.733 [397524.460896] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon

10:21:15.733 [397524.460896] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006

10:21:15.733 [397524.460896] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 62623

10:21:15.734 [397524.460896] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:21:15.734 [397524.460896] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\14f\6cf9fd4f+62623,1,0,2,1,0+127.0.0.1.txt

10:21:15.760 [397524.460896] <2> process_requests: Connected on output socket

10:21:15.760 [397524.460896] <2> process_requests: Skipping shutdown of send side of stdout.

10:21:15.760 [397524.460896] <2> process_requests: Duplicated socket on stdout

10:21:15.762 [397524.460896] <2> process_requests: BPCD_DISCONNECT_RQST

10:21:15.762 [397524.460896] <2> bpcd exit_bpcd: exit status 0  ----------->exiting

10:22:24.537 [2784.2788] <2> bpcd main: accept sock = 528

10:22:24.568 [407164.341624] <2> setup_debug_log: switched debug log file for bpcd

10:22:24.568 [407164.341624] <2> bpcd main: VERBOSE = 0

10:22:24.568 [407164.341624] <2> logparams: C:\Program Files\VERITAS\NetBackup\bin\bpcd.exe -standalone

10:22:24.570 [407164.341624] <2> process_requests: offset to GMT -3600

10:22:24.577 [407164.341624] <2> logconnections: BPCD ACCEPT FROM 10.104.155.81.62682 TO 10.104.155.81.13782 fd = 528

10:22:24.577 [407164.341624] <2> process_requests: setup_sockopts complete

10:22:24.584 [407164.341624] <2> bpcd peer_hostname: Connection from host SESTWSS52.atlantica.se (10.104.155.81) port 62682

10:22:24.584 [407164.341624] <2> bpcd valid_server: comparing trfnbu001 and SESTWSS52.atlantica.se

10:22:24.589 [407164.341624] <2> bpcd valid_server: comparing tvgnbulpa001 and SESTWSS52.atlantica.se

10:22:24.590 [407164.341624] <2> bpcd valid_server: comparing tvgnburtv001 and SESTWSS52.atlantica.se

10:22:24.592 [407164.341624] <2> bpcd valid_server: comparing tvgnburtv002 and SESTWSS52.atlantica.se

10:22:24.593 [407164.341624] <2> bpcd valid_server: comparing tvgnbulpa002 and SESTWSS52.atlantica.se

10:22:24.594 [407164.341624] <2> bpcd valid_server: comparing nbusun03-test and SESTWSS52.atlantica.se

10:22:24.595 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 11001 0x00002af9

10:22:24.595 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: nbusun03-test

10:22:24.595 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: NULL

10:22:24.595 [407164.341624] <2> vnet_cached_getaddrinfo: ../../libvlibs/vnet_addrinfo.c.1223: 0: vnet_cached_getaddrinfo_and_update() failed: 6 0x00000006

10:22:24.595 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2926: 0: vnet_cached_getaddrinfo() failed: 6 0x00000006

10:22:24.595 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2927: 0: vnet_cached_getaddrinfo() failed: 11001 0x00002af9

10:22:24.595 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2928: 0: vnet_cached_getaddrinfo() failed: nbusun03-test

10:22:24.595 [407164.341624] <2> bpcd valid_server: comparing tvgnburtv002.prd1.prdroot.net and SESTWSS52.atlantica.se

10:22:24.596 [407164.341624] <2> bpcd valid_server: comparing tvgnbulpa002.prd1.prdroot.net and SESTWSS52.atlantica.se

10:22:24.597 [407164.341624] <2> bpcd valid_server: comparing tvgnburtv002v.vesta.no and SESTWSS52.atlantica.se

10:22:24.597 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 11001 0x00002af9

10:22:24.597 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: tvgnburtv002v.vesta.no

10:22:24.597 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: NULL

10:22:24.597 [407164.341624] <2> vnet_cached_getaddrinfo: ../../libvlibs/vnet_addrinfo.c.1223: 0: vnet_cached_getaddrinfo_and_update() failed: 6 0x00000006

10:22:24.597 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2926: 0: vnet_cached_getaddrinfo() failed: 6 0x00000006

10:22:24.597 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2927: 0: vnet_cached_getaddrinfo() failed: 11001 0x00002af9

10:22:24.597 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2928: 0: vnet_cached_getaddrinfo() failed: tvgnburtv002v.vesta.no

10:22:24.597 [407164.341624] <2> bpcd valid_server: comparing tvgnbulpa002v.vesta.no and SESTWSS52.atlantica.se

10:22:24.598 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 11001 0x00002af9

10:22:24.598 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: tvgnbulpa002v.vesta.no

10:22:24.598 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: NULL

10:22:24.598 [407164.341624] <2> vnet_cached_getaddrinfo: ../../libvlibs/vnet_addrinfo.c.1223: 0: vnet_cached_getaddrinfo_and_update() failed: 6 0x00000006

10:22:24.598 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2926: 0: vnet_cached_getaddrinfo() failed: 6 0x00000006

10:22:24.598 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2927: 0: vnet_cached_getaddrinfo() failed: 11001 0x00002af9

10:22:24.598 [407164.341624] <2> vnet_same_host: ../../libvlibs/vnet_addrinfo.c.2928: 0: vnet_cached_getaddrinfo() failed: tvgnbulpa002v.vesta.no

10:22:24.598 [407164.341624] <4> bpcd valid_server: SESTWSS52.atlantica.se is not a master server

10:22:24.598 [407164.341624] <16> bpcd valid_server: SESTWSS52.atlantica.se is not a media server either

10:22:24.601 [407164.341624] <2> process_requests: output socket port number = 2126

10:22:24.608 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 10109 0x0000277d

10:22:24.608 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL

10:22:24.608 [407164.341624] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon

10:22:24.608 [407164.341624] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006

10:22:24.608 [407164.341624] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 10109 0x0000277d

10:22:24.608 [407164.341624] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon

10:22:24.608 [407164.341624] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006

10:22:24.608 [407164.341624] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 2126

10:22:24.610 [407164.341624] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002

10:22:24.610 [407164.341624] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: C:\Program Files\VERITAS\NetBackup\var\host_cache\09f\db80789f+2126,1,0,2,1,0+10.104.155.81.txt

10:22:24.613 [407164.341624] <2> process_requests: <---- NetBackup 7.1 0 ------------initiated

10:22:24.613 [407164.341624] <2> process_requests: VERBOSE = 0

10:22:24.613 [407164.341624] <2> bpcd exit_bpcd: exit status 46  ----------->exiting

10:22:24.613 [407164.341624] <4> bpcd exit_bpcd: FTL - BPCD EXIT STATUS 46

 

10:22:24.613 [407164.341624] <16> process_requests: Server access denied

 

 

Under Host Properties, it is showing connected

Please help!!

 

  •  

    10:22:24.598 [407164.341624] <4> bpcd valid_server: SESTWSS52.atlantica.se is not a master server

    10:22:24.598 [407164.341624] <16> bpcd valid_server: SESTWSS52.atlantica.se is not a media server either

     

    You need to add SERVER entry for SESTWSS52.atlantica.se on the client.

4 Replies

  • You have done bptestbpcd -client sestwss52 -verbose -debug at 11:25 but the bpcd logs doesn't have information about that time. Also the bptestbpcd connected fine and exited with status 0.

    Your bpcd log on client shows
    10:22:24.613 [407164.341624] <4> bpcd exit_bpcd: FTL - BPCD EXIT STATUS 46


    10:22:24.613 [407164.341624] <16> process_requests: Server access denied

    Chekc the windows firewall on ws 2008 client. Disable it if it is enabled

    Also have you tried the nslookup from client to masterserver ip and name.

  •  

    10:22:24.598 [407164.341624] <4> bpcd valid_server: SESTWSS52.atlantica.se is not a master server

    10:22:24.598 [407164.341624] <16> bpcd valid_server: SESTWSS52.atlantica.se is not a media server either

     

    You need to add SERVER entry for SESTWSS52.atlantica.se on the client.

  • did your master and media servers are same?

    if not what is the output of bptestbpcd from media server to client?

  • Agree  with Mariannes suggested fix. The servers IP connecting to the client is resolved as SESTWSS52.atkancia.se and is not in the SERVER list on the client.