bpinetd not listening on 13782

Mackd · ‎11-24-2010

On a w2k server with netbackup client 5.1MP7 every morning the backup fails with error 58. After recycling the netbackup client service I see that port 13782 is not listening. If I walk away and come back after a few hours, it will be listening. If I restart the service every few minutes and check for the listening port, it might start listening after 5 minutes, or 5 hours.. ie: there doesn't seem to be any rhyme or reason to it, it just magically decides to listen at some random point on it's own. No other servers have this issue, and no other apps on this particular server have any problems.

BPINETD NetBackup INETD 5.1GA [Mar 28 2008]

3:56:53.896 AM: [28816.6696] <2> WinMain: DAT - _pgmptr = 'D:\PROGRA~1\VERITAS\NETBAC~1\bin\bpinetd.exe'

3:56:53.896 AM: [28816.6696] <2> date_debug: DAT - timezone: Eastern Standard Time, offset=18000, dst: Eastern Daylight Time

3:56:53.896 AM: [28816.6696] <2> date_debug: DAT - current time: 1290589013, 11/24/2010 3:56:53 AM

3:56:53.896 AM: [28816.6696] <2> date_debug: DAT - 01/01/94 UCT: 757382400, 12/31/1993 7:00:00 PM

3:56:53.896 AM: [28816.6696] <2> date_debug: DAT - 07/01/94 UCT: 773020800, 6/30/1994 7:00:00 PM

3:56:53.896 AM: [28816.6696] <4> V_ENABLE_PRIVILEGE: INF - restore privileges enabled

3:56:53.896 AM: [28816.6696] <4> V_ENABLE_PRIVILEGE: INF - backup privileges enabled

3:56:53.896 AM: [28816.6696] <4> V_ENABLE_PRIVILEGE: INF - security privileges enabled

3:56:53.896 AM: [28816.6696] <4> V_ENABLE_PRIVILEGE: INF - create token privileges enabled

3:56:53.896 AM: [28816.6696] <4> V_ENABLE_PRIVILEGE: INF - take ownership privileges enabled

3:56:53.896 AM: [28816.6696] <4> V_ENABLE_PRIVILEGE: INF - tcb privileges enabled

3:56:53.896 AM: [28816.6696] <16> WinMain: ERR - unable to create the main window

3:56:53.896 AM: [28816.6696] <4> WinMain: INF - Exiting D:\PROGRA~1\VERITAS\NETBAC~1\bin\bpinetd.exe

3:56:55.896 AM: [28816.6696] <4> ov_log::OVClose: INF - Closing log file: D:\Program Files\VERITAS\NetBackup\logs\BPINETD\112410.LOG

I've been unable to find any more information on this error, "unable to create the main window". Any tips on what this means, or why bpinetd takes so long to start listening on 13782?

RiaanBadenhorst · ‎11-24-2010

What does the bpcd log from the same time say?

Have you tried un-installing and re-installing the client. Bpinetd only really controls the bpcd port to ensure its listening.

Mackd · ‎11-25-2010

There is no bpcd log generated. I restart the service, and even though there is a \logs\bpcd\ folder, nothing is created inside. I've created it a few times, manually, and by running the mklogdir.bat file, and no logs are generated in there when I recycle the service.

I don't think I've ever actually seen bpcd.exe running btw. Even when a backup is running, the only netbackup related processes I see are bpinetd.exe, bpjava-msvc.exe, and bpbkar32.exe. I'll double check though and get back in a few days (I'm off shift after tonight).

We've tried re-installing the client, but it's always the same issue on this server.

RiaanBadenhorst · ‎11-25-2010

Is something else not using that port? Has it ever worked, if so, what changed?

Zahid_Haseeb · ‎11-25-2010

Hope the below may help you

See If another process has the port, use other system commands to determine the process. Based on the result, either change the port number in your services file or map, or terminate the process that has acquired the port.

Mackd · ‎12-03-2010

Nothing else is using port 13782. It's been like this since day one.

Some colleagues noticed something recently though. It appears to be conditional on whether the Tivoli Maestro service has logged in or not. Each morning at around 3:00AM there is a logon event (event id 528) by tivoli maestro in the security event logs. If the backup, which is scheduled at that time, hasn't started by the time this event happens, it fails, and we get the issue. If that happens it isn't until sometime later when Tivoli Maestro generates a logout event (538) that we can then recycle the service and have netbackup come up properly and run the backup.

So, our next step is to poke some people and see if they'll let us schedule the backup for an hour earlier or something.

Mackd · ‎12-04-2010

Discovered something interesting tonight. If I change the netbackup client service to log on with my own account, rather than "LocalSystem", it works. All the netbackup processes come up and all the necessary ports are listening, and I can run the backup.

Once Maestro service logs out (also set to log on as LocalSystem) I can then have the netbackup client service log on as LocalSystem again and all the processes/ports come up fine.. So it feels like there is a limit to the number of service logons allowed by LocalSystem.. but I'm pretty sure that's not right, and there is some other underlying cause that just makes it look that way.

Zahid_Haseeb · ‎12-04-2010

""Tivoli Maestro service""

is that any client which is installed on this machine ? is it possible that you exclude this software from that machine and run the activity again.

RiaanBadenhorst · ‎12-05-2010

Hi,

I've not seen any limits on local system account either. I would suggest creating a service (domain) account for netbackup, and continue investigating what the Tivoli service is doing to the system to lock(out) the account.

J_Rakiej · ‎12-14-2010

I just had a very similar problem with bpinetd not listening on 13782 and the same error message in the log file.

I solved it by enabling "Allow service to interact with desktop" for the Netbackup service.

Give it a go. Still, I am wondering why it stopped working in a first place.

VOX

bpinetd not listening on 13782