Client connects far too often (Was: Re: [Box Backup] Windows service starts and immediately stops.)

[David Anderson]

Chris,

I have just come across a problem.

On one of my 4 Windows 2000 machines (this one Windows 2000 terminal),
the client connects to the server far more often than configured.

It's configured for every hour - in practice it goes about every 2 minutes.

Some logs:

Jan 23 01:14:28 localhost bbstored[7634]: Certificate CN: BACKUP-6
Jan 23 01:14:48 localhost bbstored[7634]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:16:37 localhost bbstored[7635]: Certificate CN: BACKUP-6
Jan 23 01:16:58 localhost bbstored[7635]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:18:41 localhost bbstored[7636]: Certificate CN: BACKUP-6
Jan 23 01:19:00 localhost bbstored[7636]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:20:12 localhost bbstored[7637]: Certificate CN: BACKUP-6
Jan 23 01:20:32 localhost bbstored[7637]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:21:56 localhost bbstored[7640]: Certificate CN: BACKUP-6
Jan 23 01:22:16 localhost bbstored[7640]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:24:02 localhost bbstored[7641]: Certificate CN: BACKUP-6
Jan 23 01:24:22 localhost bbstored[7641]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:26:25 localhost bbstored[7642]: Certificate CN: BACKUP-6
Jan 23 01:26:45 localhost bbstored[7642]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:28:21 localhost bbstored[7643]: Certificate CN: BACKUP-6
Jan 23 01:28:41 localhost bbstored[7643]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:30:18 localhost bbstored[7644]: Certificate CN: BACKUP-6
Jan 23 01:30:37 localhost bbstored[7644]: Connection statistics for BACKUP-6: IN=6993 OUT=116180 TOTAL=123173
Jan 23 01:32:20 localhost bbstored[7645]: Certificate CN: BACKUP-6
Jan 23 01:32:40 localhost bbstored[7645]: Connection statistics for BACKUP-6: IN=7084 OUT=116196 TOTAL=123280
Jan 23 01:34:11 localhost bbstored[7646]: Certificate CN: BACKUP-6
Jan 23 01:34:32 localhost bbstored[7646]: Connection statistics for BACKUP-6: IN=7014 OUT=116341 TOTAL=123355

Each of those connections seems to work without problems:

[root@spurgeon ~]# tail -2000 /var/log/boxbackup |grep 7646
Jan 23 01:34:11 localhost bbstored[3026]: Incoming connection from 10.14.0.2 port 36443 (handling in child 7646)
Jan 23 01:34:11 localhost bbstored[7646]: Certificate CN: BACKUP-6
Jan 23 01:34:11 localhost bbstored[7646]: Login: Client ID 00000006, Read/Write
Jan 23 01:34:32 localhost bbstored[7646]: Session finished
Jan 23 01:34:32 localhost bbstored[7646]: Connection statistics for BACKUP-6: IN=7014 OUT=116341 TOTAL=123355

Here is the config file, minus comments/whitespace:

*** BEGIN ***

StoreHostname = (snip)
AccountNumber = 0x6
KeysFile = D:\Program Files\Box Backup\6-FileEncKeys.raw
CertificateFile = D:\Program Files\Box Backup\6-cert.pem
PrivateKeyFile = D:\Program Files\Box Backup\6-key.pem
TrustedCAsFile = D:\Program Files\Box Backup\serverCA.pem
DataDirectory = D:\Program Files\Box Backup\bbackupd
UpdateStoreInterval = 3600
MinimumFileAge = 21600
MaxUploadWait = 86400
FileTrackingSizeThreshold = 65535
DiffingUploadSizeThreshold = 8192
MaximumDiffingTime = 20
CommandSocket = pipe
Server
{
	PidFile = D:\Program Files\Box Backup\bbackupd\bbackupd.pid
}
BackupLocations
{
	DocsAndSettings
	{
		Path = C:\Documents And Settings
	}
      E
	{
                Path = E:\
			ExcludeDir = E:\MSSQL\Data
			ExcludeDir = E:\MSSQL\snip-new
	}
}

*** END ***

David

On Saturday 30 December 2006 17:36, David Anderson wrote:
> Working fine so far, though we've not yet needed to restore anything
> (but the logs show plenty of activity).
>
> Thanks,
> David
>
> On Friday 29 December 2006 22:16, Chris Wilson wrote:
> > Hi David,
> >
> > On Fri, 20 Oct 2006, David Anderson wrote:
> > > Thanks. That now told me which file was the problem.
> > >
> > > It was the pid file. I created the bbackupd directory using mkdir
> > > from Cygwin, but apparently it didn't have sufficient permissions
> > > for the service. (For whatever reason it had sufficient
> > > permissions for running directly from cmd.exe).
> >
> > I was just wondering if you are still using the build that I sent
> > you, 1096, and whether it's working well for you? I'm considering
> > announcing it as a new general release soon, so feedback would be
> > very welcome.
> >
> > Cheers, Chris.

-- 
Skype: davidcanderson / MSN: david@readingroom.com