Veritas-bu

[Veritas-bu] netbackup "Full" backups stopping

2003-12-29 23:11:42
Subject: [Veritas-bu] netbackup "Full" backups stopping
From: grover AT huntcorp.com DOT au (Neil Hunt)
Date: Tue, 30 Dec 2003 12:11:42 +0800
G'day,
Over the last few weeks, we have been having major problems with NBU
full backups.  Basically the backups fire off, but after about 30
seconds they just stop and sit there.  (I have copied the log file from
one at the bottom).
The only change that has been made is the addition of 4.5MP5, but this
was only done on the 24th (well after the problems started).

Unusually, when MPX is set, bpsched will fire up the initial number of
jobs, and then, when one is done, it will fire up another set of jobs
(the same number as the MPX level).  I can get maybe one or two jobs to
complete out of the 9 that are supposed to run.  
Also, it seems that the incremental jobs are running properly, and these
are set up the same way.

Product: NBU 4.5 MP5
OS: Solaris (all Solaris client, but one (Win2k) (no difference)
Hardware: L9 with DLT8000

There hasn't been a proper full backup in about a month, and this is
getting to the desparate stage, so some help would be mightily
appreciated.

Neil



bpbkar logfile 

11:55:36.534 [2373] **LOCALE ERROR** locale <en_AU.ISO8859-1> not found
in file </usr/openv/msg/.conf>
11:55:36.543 [2373] <4> bpbkar main: real locales
</C/en_AU.ISO8859-1/en_AU.ISO8859-1/en_AU.ISO8859-1/C/C>
11:55:36.543 [2373] <4> bpbkar main: standardized locales - lc_messages
<C> lc_ctype <C> lc_time <C> lc_collate <C> lc_numeric <C>
11:55:36.553 [2373] <2> logparams: bpbkar -r 1129032 -ru root -dt 0 -to
0 -clnt aufin2 -class AFG -sched Full -st FULL -bpstart_to 300 -bpend_to
300 -read_to 600 -fso -Z -b aufin2_1072756532 -kl 28 -shm 
11:55:36.557 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d100 on /
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (proc)
/proc on /proc
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (fd) fd
on /dev/fd
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (mntfs)
mnttab on /etc/mnttab
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d110 on /var
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (tmpfs)
swap on /var/run
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (tmpfs)
swap on /tmp
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d6 on /u06
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d20 on /u04
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d70 on /u01
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d10 on /u03
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d30 on /u05
11:55:36.558 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d40 on /u08
11:55:36.564 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d60 on /u07
11:55:36.565 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d120 on /u02
11:55:36.565 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d84 on /export
11:55:36.565 [2373] <2> mount build_mount_list: INF - Processing (NFS)
aufin3:/u01/staging on /staging
11:55:36.565 [2373] <2> mount build_mount_list: INF - Processing
(autofs) -hosts on /net
11:55:36.565 [2373] <2> mount build_mount_list: INF - Processing
(autofs) auto_home on /home
11:55:36.565 [2373] <2> mount build_mount_list: INF - Processing
(autofs) -xfn on /xfn
11:55:36.573 [2373] <2> bpbkar initialize: INF - Selecting ALL files
11:55:36.573 [2373] <4> bpbkar main: INF - setenv KEYWORD=NONE
11:55:36.573 [2373] <4> bpbkar main: INF - setenv STREAM_PID=2373
11:55:36.573 [2373] <4> bpbkar main: INF - setenv STREAM_NUMBER=0
11:55:36.573 [2373] <4> bpbkar main: INF - setenv STREAM_COUNT=0
11:55:36.573 [2373] <4> bpbkar main: INF - setenv STREAMS=0
11:55:36.573 [2373] <4> bpbkar main: INF - setenv BPSTART_TIMEOUT=300
11:55:36.574 [2373] <4> bpbkar main: INF - setenv BPEND_TIMEOUT=300
11:55:36.574 [2373] <4> bpbkar main: INF - setenv
BACKUPID=aufin2_1072756532
11:55:36.574 [2373] <4> bpbkar main: INF - setenv
UNIXBACKUPTIME=1072756532
11:55:36.574 [2373] <4> bpbkar main: INF - setenv BACKUPTIME=Tue Dec 30
11:55:32 2003

11:55:36.595 [2373] <4> bpbkar main: INF - BACKUP START
11:55:36.596 [2373] <4> bpbkar main: INF - Estimate:-1 -1
11:55:36.597 [2373] <2> bpbkar main: INF - CONTINUE BACKUP message
received
11:55:38.616 [2373] <2> bpbkar setup_shm: INF - media_shm_info = 8 32768
51112 2374 0 0 0 0 1
11:55:38.616 [2373] <2> bpbkar setup_shm: INF - SHMID = 51112, BUF_PTR =
0xff0c0000, BUF_CONTROL = 0xff100000, readyptr = 0xff1000c0
11:55:38.626 [2373] <4> bpbkar expand_wildcards: INF - Processing
/u01/finprod
11:55:38.662 [2373] <8> bpbkar validate_argument: WRN - Cannot process
path /u01/finprod: No such file or directory. Skipping.
11:55:38.662 [2373] <4> bpbkar expand_wildcards: INF - Processing /
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d100 on /
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (proc)
/proc on /proc
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (fd) fd
on /dev/fd
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (mntfs)
mnttab on /etc/mnttab
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d110 on /var
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (tmpfs)
swap on /var/run
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (tmpfs)
swap on /tmp
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d6 on /u06
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d20 on /u04
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d70 on /u01
11:55:38.684 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d10 on /u03
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d30 on /u05
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d40 on /u08
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d60 on /u07
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d120 on /u02
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing (ufs)
/dev/md/dsk/d84 on /export
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing (NFS)
aufin3:/u01/staging on /staging
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing
(autofs) -hosts on /net
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing
(autofs) auto_home on /home
11:55:38.685 [2373] <2> mount build_mount_list: INF - Processing
(autofs) -xfn on /xfn
11:55:38.686 [2373] <2> bpbkar SelectFile: INF - Resolved_path = /
11:55:38.686 [2373] <2> bpbkar resolve_path: INF - Actual mount point of
/ is /
11:55:38.691 [2373] <4> bpbkar PrintFile: /
11:55:38.697 [2373] <4> bpbkar PrintFile: /bin
11:55:38.703 [2373] <4> bpbkar PrintFile: /lib
11:55:38.708 [2373] <4> bpbkar compress_file: INF - Compression:  44.94%
/.sh_history
11:55:38.709 [2373] <4> bpbkar PrintFile: /.sh_history
11:55:38.715 [2373] <4> bpbkar compress_file: INF - Compression:  50.85%
/.profile
11:55:38.715 [2373] <4> bpbkar PrintFile: /.profile
11:55:38.718 [2373] <4> bpbkar compress_file: INF - Compression:  53.00%
/.dtprofile
11:55:38.719 [2373] <4> bpbkar PrintFile: /.dtprofile


<Prev in Thread] Current Thread [Next in Thread>