Troy Daniels schrieb:
> > no errors, but I can't find an file named VU0EM005.restore.2.bsr on either 
> > the
> > dir or the fd.  And no VU0EM005.VerifySMTCZB0003.*.bootstrap file too!
> > 
> 
> Are you checking for these files during the verify or after it?

During and after, see below for more details.
 
> You dont specifically say, but they'll probably only exist during the 
> job. Or maybe during the setup of the job - I'm not sure.
> 
> And /opt/bacula/var/bacula/working/VU0EM005.restore.2.bsr definitely 
> doesn't exist?

I couldn't find it yet, but...

Now I used iwatch/inotify to see what happens to the working directory.
(also available at http://pastebin.ca/649831)

failed first verify with local fd

[ 9/Aug/2007 12:18:26] IN_CLOSE_WRITE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.17.26.6094920.mail
[ 9/Aug/2007 12:18:26] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.17.26.6094920.mail
 is closed
[ 9/Aug/2007 12:18:26] IN_DELETE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.17.26.6094920.mail
[ 9/Aug/2007 12:18:26] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.17.26.6094920.mail
 is deleted
[ 9/Aug/2007 12:18:26] IN_CLOSE_WRITE /opt/bacula/var/bacula/working//log
[ 9/Aug/2007 12:18:26] * /opt/bacula/var/bacula/working//log is closed
[ 9/Aug/2007 12:18:26] IN_CLOSE_WRITE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.17.26.6102616.mail
[ 9/Aug/2007 12:18:26] IN_DELETE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.17.26.6102616.mail
[ 9/Aug/2007 12:18:26] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.17.26.6102616.mail
 is deleted
[ 9/Aug/2007 12:18:26] IN_CLOSE_WRITE /opt/bacula/var/bacula/working//log
[ 9/Aug/2007 12:18:26] * /opt/bacula/var/bacula/working//log is closed

I don't see anyting about a bootstrap file anywhere!


ok with the remote fd

[ 9/Aug/2007 12:19:15] IN_CREATE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.19.13.6057496.mail
[ 9/Aug/2007 12:19:15] IN_CREATE 
/opt/bacula/var/bacula/working//VU0EM005.restore.3.bsr
[ 9/Aug/2007 12:19:15] IN_CLOSE_WRITE 
/opt/bacula/var/bacula/working//VU0EM005.restore.3.bsr
[ 9/Aug/2007 12:19:15] * /opt/bacula/var/bacula/working//VU0EM005.restore.3.bsr 
is closed
[ 9/Aug/2007 12:19:16] IN_DELETE 
/opt/bacula/var/bacula/working//VU0EM005.restore.3.bsr
[ 9/Aug/2007 12:19:16] * /opt/bacula/var/bacula/working//VU0EM005.restore.3.bsr 
is deleted
[ 9/Aug/2007 12:19:16] IN_CREATE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.19.13.3.bootstrap
[ 9/Aug/2007 12:19:16] IN_CLOSE_WRITE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.19.13.3.bootstrap
[ 9/Aug/2007 12:19:16] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.19.13.3.bootstrap
 is closed
[ 9/Aug/2007 12:19:16] IN_DELETE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.19.13.3.bootstrap
[ 9/Aug/2007 12:19:16] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.19.13.3.bootstrap
 is deleted

Here the bootstrap files were created and deleted (VU0EM005.restore.3 + 
VU0EM005.VerifySMTCZB0003.2007-08-09_12.19.13.3.bootstrap)


ok with the local fd (second try)

[ 9/Aug/2007 12:20:31] IN_CREATE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.6094920.mail
[ 9/Aug/2007 12:20:32] IN_CREATE 
/opt/bacula/var/bacula/working//VU0EM005.restore.4.bsr
[ 9/Aug/2007 12:20:32] IN_CLOSE_WRITE 
/opt/bacula/var/bacula/working//VU0EM005.restore.4.bsr
[ 9/Aug/2007 12:20:32] * /opt/bacula/var/bacula/working//VU0EM005.restore.4.bsr 
is closed
[ 9/Aug/2007 12:20:43] IN_DELETE 
/opt/bacula/var/bacula/working//VU0EM005.restore.4.bsr
[ 9/Aug/2007 12:20:43] * /opt/bacula/var/bacula/working//VU0EM005.restore.4.bsr 
is deleted
[ 9/Aug/2007 12:20:43] IN_CREATE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.3.bootstrap
[ 9/Aug/2007 12:20:43] IN_CLOSE_WRITE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.3.bootstrap
[ 9/Aug/2007 12:20:43] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.3.bootstrap
 is closed
[ 9/Aug/2007 12:20:44] IN_CREATE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.4.bootstrap
[ 9/Aug/2007 12:20:44] IN_CLOSE_WRITE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.4.bootstrap
[ 9/Aug/2007 12:20:44] IN_DELETE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.4.bootstrap
[ 9/Aug/2007 12:20:44] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.4.bootstrap
 is deleted
[ 9/Aug/2007 12:20:44] IN_DELETE 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.3.bootstrap
[ 9/Aug/2007 12:20:44] * 
/opt/bacula/var/bacula/working//VU0EM005.VerifySMTCZB0003.2007-08-09_12.20.29.3.bootstrap
 is deleted


The bootstrap files were created and deleted too! The daemons are still running
as the same user. This can't be a simple permission problem (I hope).


> > Now it's working with the local fd on the dir too. But I still can't find 
> > any of
> > the bootstrap file neither on fd nor on the dir .
> > 
> 
> Very strange, very very strange.

Indeed.

> > I can reproduce this after every restart of the daemons. I first have to 
> > run an
> > verify job with an remote fd, before I can use the local fd for verify jobs.
> > 
> 
> Some questions to clarify the above statement.
> 
> Is it just the first verify job that fails?

yes - at least until now.

> Does it fail if you verify the first job via a remote client?

no.

> If the first thing you try is a backup job of the local client does that 
> work OK?

didn't try this.

> Does running backup jobs before the verify jobs have any impact on the 
> problem?

I haven't run a backup job since yesterday.

> > What is going on there? 
> 
> No idea whatsoever :)
> 
> > I also started the daemons with debug level 200 and
> > searched for the permission error message, I didn't find it in the debug 
> > file.
> > 
> 
> Try increasing it even more.
> 
> Did you check all 3 daemons?
> 
> To narrow it down, you could try restarting each daemon in turn and 
> running a verify job to see if the problem occurs.

Ok, if this whole debugging thing just wouldn't cost so much time ;)

Ralf

-------------------------------------------------------------------------
This SF.net email is sponsored by: Splunk Inc.
Still grepping through log files to find problems?  Stop.
Now Search log events and configuration files using AJAX and a browser.
Download your FREE copy of Splunk now >>  http://get.splunk.com/
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

Reply via email to