Backup failes with error 25 for Netbackup Client i...

Arjun_Sukumar · ‎01-12-2011

I am facing a issue to backup a client hosted in a DMZ zone recently , it used to work fine earlier bu since the last few days it has started to fail withh error 25. The firewall configured is MS ISA, ports 13724 and 1556 opened in both directions ,the bpcd log form client is as below (192.168.1.xx is the client and 192.168.1.xxx is the isa server)

18:15:24.812 [5312.1660] <2> setup_debug_log: switched debug log file for BPCD

18:15:24.812 [5312.1660] <2> bpcd main: VERBOSE = 5

18:15:24.812 [5312.1660] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\BPCD.EXE

18:15:24.812 [5312.1660] <2> bpcd main: Got socket for input 580

18:15:24.812 [5312.1660] <2> ReadKeyfile: keyfile C:\Program Files\Veritas\NetBackup\bin\keyfile.dat does not exist

18:15:24.812 [5312.1660] <2> process_requests: offset to GMT -14400

18:15:24.812 [5312.1660] <2> logconnections: BPCD ACCEPT FROM 192.168.1.202.1460 TO 192.168.1.99.13782

18:15:24.812 [5312.1660] <2> process_requests: setup_sockopts complete

18:15:24.812 [5312.1660] <2> bpcd peer_hostname: Connection from host S-EISA2-MAIN (192.168.1.202) port 1460

18:15:24.828 [5312.1660] <2> bpcd valid_server: comparing s-ebackup-main and S-EISA2-MAIN

18:15:24.828 [5312.1660] <4> bpcd valid_server: S-EISA2-MAIN is not a master server

18:15:24.828 [5312.1660] <16> bpcd valid_server: S-EISA2-MAIN is not a media server either

18:15:24.828 [5312.1660] <2> process_requests: output socket port number = 13782

18:15:24.828 [5312.1660] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1927: ip_len: 4 0x00000004

18:15:24.828 [5312.1660] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 192 0x000000c0

18:15:24.828 [5312.1660] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 168 0x000000a8

18:15:24.828 [5312.1660] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 2 0x00000002

18:15:24.828 [5312.1660] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 20 0x00000014

18:15:24.828 [5312.1660] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1950: port: 13724 0x0000359c

18:15:24.828 [5312.1660] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.878: ipc_string: 1586

18:15:24.828 [5312.1660] <2> vnet_connect_to_vnetd_extra: ../../libvlibs/vnet_vnetd.c.188: msg: VNETD CONNECT FROM 192.168.1.99.2925 TO 192.168.1.202.13724 fd = 1684

18:15:24.890 [5312.1660] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.371: VN_REQUEST_CONNECT_BACK_SOCKET: 3 0x00000003

18:15:24.890 [5312.1660] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.385: ipc_string: 1586

18:15:25.046 [5312.1660] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.406: hash_str1: cc0770882ca77ce04e01c02641228248

18:15:25.046 [5312.1660] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.419: status: 0 0x00000000

18:15:25.046 [5312.1660] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.436: pushed hash_str1: cc0770882ca77ce04e01c02641228248

18:16:01.796 [5312.1660] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.450: pstatus: 10 0x0000000a

18:16:01.796 [5312.1660] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.453: status: 10 0x0000000a

18:16:01.796 [5312.1660] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.945: status: 10 0x0000000a

18:16:01.796 [5312.1660] <2> vnet_vnetd_disconnect: ../../libvlibs/vnet_vnetd.c.289: VN_REQUEST_DISCONNECT: 1 0x00000001

18:16:01.796 [5312.1660] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.829: Function failed: 10 0x0000000a

18:16:01.796 [5312.1660] <16> get_vnetd_socket: vnet_end_connect_back failed: 10

18:16:01.796 [5312.1660] <16> process_requests: get_vnetd_socket failed: 25

18:28:49.062 [5540.5212] <2> setup_debug_log: switched debug log file for BPCD

18:28:49.062 [5540.5212] <2> bpcd main: VERBOSE = 5

18:28:49.062 [5540.5212] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\BPCD.EXE

18:28:49.062 [5540.5212] <2> bpcd main: Got socket for input 572

18:28:49.062 [5540.5212] <2> ReadKeyfile: keyfile C:\Program Files\Veritas\NetBackup\bin\keyfile.dat does not exist

18:28:49.062 [5540.5212] <2> process_requests: offset to GMT -14400

18:28:49.062 [5540.5212] <2> logconnections: BPCD ACCEPT FROM 192.168.1.xxx.1442 TO 192.168.1.xx.13782

18:28:49.062 [5540.5212] <2> process_requests: setup_sockopts complete

18:28:49.062 [5540.5212] <2> bpcd peer_hostname: Connection from host S-EISA2-MAIN (192.168.1.202) port 1442

18:28:49.062 [5540.5212] <2> bpcd valid_server: comparing s-ebackup-main and S-EISA2-MAIN

18:28:49.062 [5540.5212] <4> bpcd valid_server: S-EISA2-MAIN is not a master server

18:28:49.062 [5540.5212] <16> bpcd valid_server: S-EISA2-MAIN is not a media server either

18:28:49.062 [5540.5212] <2> process_requests: output socket port number = 13782

18:28:49.062 [5540.5212] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1927: ip_len: 4 0x00000004

18:28:49.062 [5540.5212] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 192 0x000000c0

18:28:49.062 [5540.5212] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 168 0x000000a8

18:28:49.062 [5540.5212] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 2 0x00000002

18:28:49.062 [5540.5212] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 20 0x00000014

18:28:49.062 [5540.5212] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1950: port: 13724 0x0000359c

18:28:49.062 [5540.5212] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.878: ipc_string: 2192

18:28:49.062 [5540.5212] <2> vnet_connect_to_vnetd_extra: ../../libvlibs/vnet_vnetd.c.188: msg: VNETD CONNECT FROM 192.168.1.xx.3033 TO 192.168.1.xxx.13724 fd = 1684

18:28:49.125 [5540.5212] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.371: VN_REQUEST_CONNECT_BACK_SOCKET: 3 0x00000003

18:28:49.125 [5540.5212] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.385: ipc_string: 2192

18:28:49.312 [5540.5212] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.406: hash_str1: 8fea05d72b18cc9b70baf7b39844a158

18:28:49.312 [5540.5212] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.419: status: 0 0x00000000

18:28:49.312 [5540.5212] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.436: pushed hash_str1: 8fea05d72b18cc9b70baf7b39844a158

18:29:26.390 [5540.5212] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.450: pstatus: 10 0x0000000a

18:29:26.390 [5540.5212] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.453: status: 10 0x0000000a

18:29:26.390 [5540.5212] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.945: status: 10 0x0000000a

18:29:26.390 [5540.5212] <2> vnet_vnetd_disconnect: ../../libvlibs/vnet_vnetd.c.289: VN_REQUEST_DISCONNECT: 1 0x00000001

18:29:26.390 [5540.5212] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.829: Function failed: 10 0x0000000a

18:29:26.390 [5540.5212] <16> get_vnetd_socket: vnet_end_connect_back failed: 10

18:29:26.390 [5540.5212] <16> process_requests: get_vnetd_socket failed: 25

18:42:10.234 [3044.5940] <2> setup_debug_log: switched debug log file for BPCD

18:42:10.234 [3044.5940] <2> bpcd main: VERBOSE = 5

18:42:10.234 [3044.5940] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\BPCD.EXE

18:42:10.234 [3044.5940] <2> bpcd main: Got socket for input 588

18:42:10.234 [3044.5940] <2> ReadKeyfile: keyfile C:\Program Files\Veritas\NetBackup\bin\keyfile.dat does not exist

18:42:10.234 [3044.5940] <2> process_requests: offset to GMT -14400

18:42:10.234 [3044.5940] <2> logconnections: BPCD ACCEPT FROM 192.168.1.xxx.1527 TO 192.168.1.xx.13782

18:42:10.234 [3044.5940] <2> process_requests: setup_sockopts complete

18:42:10.250 [3044.5940] <2> bpcd peer_hostname: Connection from host S-EISA2-MAIN (192.168.1.xxx) port 1527

18:42:10.250 [3044.5940] <2> bpcd valid_server: comparing s-ebackup-main and S-EISA2-MAIN

18:42:10.250 [3044.5940] <4> bpcd valid_server: S-EISA2-MAIN is not a master server

18:42:10.250 [3044.5940] <16> bpcd valid_server: S-EISA2-MAIN is not a media server either

18:42:10.437 [3044.5940] <2> process_requests: output socket port number = 13782

18:42:10.437 [3044.5940] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1927: ip_len: 4 0x00000004

18:42:10.437 [3044.5940] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 192 0x000000c0

18:42:10.437 [3044.5940] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 168 0x000000a8

18:42:10.437 [3044.5940] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 2 0x00000002

18:42:10.437 [3044.5940] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1943: bptr[i]: 20 0x00000014

18:42:10.437 [3044.5940] <2> vnet_vnetd_pop_ipaddr: ../../libvlibs/vnet_vnetd.c.1950: port: 13724 0x0000359c

18:42:10.437 [3044.5940] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.878: ipc_string: 2834

18:42:10.437 [3044.5940] <2> vnet_connect_to_vnetd_extra: ../../libvlibs/vnet_vnetd.c.188: msg: VNETD CONNECT FROM 192.168.1.xx.3134 TO 192.168.1.xxx.13724 fd = 1684

18:42:10.484 [3044.5940] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.371: VN_REQUEST_CONNECT_BACK_SOCKET: 3 0x00000003

18:42:10.484 [3044.5940] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.385: ipc_string: 2834

18:42:10.812 [3044.5940] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.406: hash_str1: f84a174d73b62ee1e45e14951bead66a

18:42:10.812 [3044.5940] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.419: status: 0 0x00000000

18:42:10.812 [3044.5940] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.436: pushed hash_str1: f84a174d73b62ee1e45e14951bead66a

18:42:48.328 [3044.5940] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.450: pstatus: 10 0x0000000a

18:42:48.328 [3044.5940] <2> connect_back_socket: ../../libvlibs/vnet_vnetd.c.453: status: 10 0x0000000a

18:42:48.328 [3044.5940] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.945: status: 10 0x0000000a

18:42:48.328 [3044.5940] <2> vnet_vnetd_disconnect: ../../libvlibs/vnet_vnetd.c.289: VN_REQUEST_DISCONNECT: 1 0x00000001

18:42:48.328 [3044.5940] <2> vnet_end_connect_back_ira: ../../libvlibs/vnet_vnetd.c.829: Function failed: 10 0x0000000a

18:42:48.328 [3044.5940] <16> get_vnetd_socket: vnet_end_connect_back failed: 10

18:42:48.328 [3044.5940] <16> process_requests: get_vnetd_socket failed: 25

emret · ‎01-13-2011

port 13720, 13724, 13782 and 1783 must be opened both directions.

Mouse · ‎01-13-2011

Try bptestbpcd -client <client_name> from master & media servers to test connectivity.

bpclntcmd could be also helpful.

You must have the VNETD port open

VOX

Backup failes with error 25 for Netbackup Client in DMZ