PDA

View Full Version : Unable to backup server



tsetliff
July 27th, 2010, 10:42 AM
So I'm backing up an OS X server with a 1.8T main disk and a 2.7T volume and a 3.7T volume. And for whatever reason it won't give me back an estimate. I have tried all the options for estimating the size, and I set the backup estimate timeout per DLE to 180000 under "how". I'm also under the impression that I can back this one system up onto multiple tapes now and I set

I'm really frustrated at this software, for a few hundred dollars it really should just work or at least have clear error messages.

Here is the report followed by some of the logs from the machine I'm trying to back up. Thank you for your time:

HOSTNAME DISK L ORIG-MB OUT-MB COMP% MMM:SS KB/s MMM:SS KB/s
---------------- -------------------------------- -----------
gfxserver / FAILED


STATISTICS:
Total Full Incr.
-------- -------- --------
Estimate Time (hrs:min) 0:03
Run Time (hrs:min) 0:29
Dump Time (hrs:min) 0:00 0:00 0:00
Output Size (meg) 0.0 0.0 0.0
Original Size (meg) 0.0 0.0 0.0
Avg Encryption'>Compressed Size (%) -- -- --
Filesystems Dumped 0 0 0
Avg Dump Rate (k/s) -- -- --

Tape Time (hrs:min) 0:00 0:00 0:00
Tape Size (meg) 0.0 0.0 0.0
Tape Used (%) 0.0 0.0 0.0
Filesystems Taped 0 0 0
Parts Taped 0 0 0
Avg Tp Write Rate (k/s) -- -- --

USAGE BY TAPE:

FAILURE SUMMARY:
gfxserver / lev -1 FAILED [no estimate]

FAILURE DETAILS:
STRANGE SUMMARY:
STRANGE DETAILS:
NOTES:
planner: Forcing full dump of gfxserver:/ as directed.
planner: gfxserver / 20100727001502 0 "no estimate"
driver: WARNING: got empty schedule from planner



>>>>>
Tue Jul 27 12:16:34 2010: amandad: sending REP pkt:
<<<<<
OPTIONS features=ffffffff9efefbffffffffff01;
OK amgtar
OK /private/var/lib/amanda/gnutar-lists/. read/writable
OK /
OK //. accessible
OK /usr/bin/gzip executable
OK /dev/null read/writable
OK /private/tmp/amanda has more than 64KB available.
OK /private/var/log/amanda has more than 64KB available.
OK /etc has more than 64KB available.
>>>>>
Tue Jul 27 12:16:34 2010: amandad: received ACK pkt:
<<<<<
>>>>>
Tue Jul 27 12:16:34 2010: amandad: security_close(handle=0x605110, driver=0x254f40 (BSDTCP))
Tue Jul 27 12:16:34 2010: amandad: security_stream_close(0x54d000)
Tue Jul 27 12:16:39 2010: amandad: Process 17464 failed to exit
Tue Jul 27 12:16:39 2010: amandad: pid 17461 finish time Tue Jul 27 12:16:39 2010
Tue Jul 27 12:25:54 2010: amandad: pid 17722 ruid 5000 euid 5000 version 3.1.1: start at Tue Jul 27 12:25:54 2010
Tue Jul 27 12:25:54 2010: amandad: security_getdriver(name=bsdtcp) returns 0x254f40
Tue Jul 27 12:25:54 2010: amandad: version 3.1.1
Tue Jul 27 12:25:54 2010: amandad: build: VERSION="Amanda-3.1.1"
Tue Jul 27 12:25:54 2010: amandad: BUILT_DATE="Mon Jun 28 10:17:03 PDT 2010" BUILT_MACH=""
Tue Jul 27 12:25:54 2010: amandad: BUILT_REV="3211" BUILT_BRANCH="3_1_1" CC="gcc"
Tue Jul 27 12:25:54 2010: amandad: paths: bindir="/usr/bin" sbindir="/usr/sbin"
Tue Jul 27 12:25:54 2010: amandad: libexecdir="/usr/lib" amlibexecdir="/usr/lib/amanda"
Tue Jul 27 12:25:54 2010: amandad: mandir="/usr/share/man"
Tue Jul 27 12:25:54 2010: amandad: AMANDA_TMPDIR="/private/tmp/amanda"
Tue Jul 27 12:25:54 2010: amandad: AMANDA_DBGDIR="/private/var/log/amanda"
Tue Jul 27 12:25:54 2010: amandad: CONFIG_DIR="/private/etc/amanda" DEV_PREFIX="/dev/"
Tue Jul 27 12:25:54 2010: amandad: RDEV_PREFIX="/dev/r" DUMP="/sbin/dump"
Tue Jul 27 12:25:54 2010: amandad: RESTORE="/sbin/restore" VDUMP=UNDEF VRESTORE=UNDEF
Tue Jul 27 12:25:54 2010: amandad: XFSDUMP=UNDEF XFSRESTORE=UNDEF VXDUMP=UNDEF VXRESTORE=UNDEF
Tue Jul 27 12:25:54 2010: amandad: SAMBA_CLIENT="/usr/bin/smbclient" GNUTAR="/usr/bin/tar"
Tue Jul 27 12:25:54 2010: amandad: COMPRESS_PATH="/usr/bin/gzip"
Tue Jul 27 12:25:54 2010: amandad: UNCOMPRESS_PATH="/usr/bin/gzip" LPRCMD=UNDEF MAILER=UNDEF
Tue Jul 27 12:25:54 2010: amandad: listed_incr_dir="/private/var/lib/amanda/gnutar-lists"
Tue Jul 27 12:25:54 2010: amandad: defs: DEFAULT_SERVER="localhost" DEFAULT_CONFIG="DailySet1"
Tue Jul 27 12:25:54 2010: amandad: DEFAULT_TAPE_SERVER="localhost" DEFAULT_TAPE_DEVICE=""
Tue Jul 27 12:25:54 2010: amandad: HAVE_MMAP NEED_STRSTR HAVE_SYSVSHM AMFLOCK_POSIX AMFLOCK_FLOCK
Tue Jul 27 12:25:54 2010: amandad: AMFLOCK_LOCKF AMFLOCK_LNLOCK ASSERTIONS AMANDA_DEBUG_DAYS=4
Tue Jul 27 12:25:54 2010: amandad: BSD_SECURITY USE_AMANDAHOSTS CLIENT_LOGIN="amandabackup"
Tue Jul 27 12:25:54 2010: amandad: CHECK_USERID HAVE_GZIP COMPRESS_SUFFIX=".gz"
Tue Jul 27 12:25:54 2010: amandad: COMPRESS_FAST_OPT="--fast" COMPRESS_BEST_OPT="--best"
Tue Jul 27 12:25:54 2010: amandad: UNCOMPRESS_OPT="-dc"
Tue Jul 27 12:25:54 2010: amandad: security_handleinit(handle=0x604e50, driver=0x254f40 (BSDTCP))
Tue Jul 27 12:25:54 2010: amandad: security_streaminit(stream=0x54d000, driver=0x254f40 (BSDTCP))
Tue Jul 27 12:25:54 2010: amandad: accept recv REQ pkt:
<<<<<
SERVICE noop
OPTIONS features=ffffffff9efefbffffffffff01;
>>>>>
Tue Jul 27 12:25:54 2010: amandad: creating new service: noop
OPTIONS features=ffffffff9efefbffffffffff01;

Tue Jul 27 12:25:54 2010: amandad: sending ACK pkt:
<<<<<
>>>>>
Tue Jul 27 12:25:54 2010: amandad: tcpm_send_token: data is still flowing
Tue Jul 27 12:25:55 2010: amandad: sending REP pkt:
<<<<<
OPTIONS features=ffffffff9efefbffffffffff01;
>>>>>
Tue Jul 27 12:25:55 2010: amandad: received ACK pkt:
<<<<<
>>>>>
Tue Jul 27 12:25:55 2010: amandad: security_close(handle=0x604e50, driver=0x254f40 (BSDTCP))
Tue Jul 27 12:25:55 2010: amandad: security_stream_close(0x54d000)
Tue Jul 27 12:26:00 2010: amandad: Process 17723 failed to exit
Tue Jul 27 12:26:00 2010: amandad: security_handleinit(handle=0x605110, driver=0x254f40 (BSDTCP))
Tue Jul 27 12:26:00 2010: amandad: security_streaminit(stream=0x54d000, driver=0x254f40 (BSDTCP))
Tue Jul 27 12:26:00 2010: amandad: accept recv REQ pkt:
<<<<<
SERVICE selfcheck
OPTIONS features=ffffffff9efefbffffffffff01;maxdumps=1;hos tname=gfxserver;config=BackupToTapesWeekly;
<dle>
<program>APPLICATION</program>
<backup-program>
<plugin>amgtar</plugin>
<property>
<name>sparse</name>
<value>yes</value>
</property>
<property>
<name>check-device</name>
<value>yes</value>
</property>
<property>
<name>atime-preserve</name>
<value>no</value>
</property>
<property>
<name>one-file-system</name>
<value>yes</value>
</property>
</backup-program>
<estimate>CALCSIZE SERVER </estimate>
<disk>/</disk>
<diskdevice>/</diskdevice>
<auth>bsdtcp</auth>
<compress>BEST</compress>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
>>>>>
Tue Jul 27 12:26:00 2010: amandad: creating new service: selfcheck
OPTIONS features=ffffffff9efefbffffffffff01;maxdumps=1;hos tname=gfxserver;config=BackupToTapesWeekly;
<dle>
<program>APPLICATION</program>
<backup-program>
<plugin>amgtar</plugin>
<property>
<name>sparse</name>
<value>yes</value>
</property>
<property>
<name>check-device</name>
<value>yes</value>
</property>
<property>
<name>atime-preserve</name>
<value>no</value>
</property>
<property>
<name>one-file-system</name>
<value>yes</value>
</property>
</backup-program>
<estimate>CALCSIZE SERVER </estimate>
<disk>/</disk>
<diskdevice>/</diskdevice>
<auth>bsdtcp</auth>
<compress>BEST</compress>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>

Tue Jul 27 12:26:00 2010: amandad: sending ACK pkt:
<<<<<
>>>>>
Tue Jul 27 12:26:00 2010: amandad: sending REP pkt:
<<<<<
OPTIONS features=ffffffff9efefbffffffffff01;
OK amgtar
OK /private/var/lib/amanda/gnutar-lists/. read/writable
OK /
OK //. accessible
OK /usr/lib/amanda/calcsize executable
OK /usr/lib/amanda/calcsize executable
OK /etc/amandates read/writable
OK /usr/bin/gzip executable
OK /dev/null read/writable
OK /private/tmp/amanda has more than 64KB available.
OK /private/var/log/amanda has more than 64KB available.
OK /etc has more than 64KB available.
>>>>>
Tue Jul 27 12:26:00 2010: amandad: received ACK pkt:
<<<<<
>>>>>
Tue Jul 27 12:26:00 2010: amandad: security_close(handle=0x605110, driver=0x254f40 (BSDTCP))
Tue Jul 27 12:26:00 2010: amandad: security_stream_close(0x54d000)
Tue Jul 27 12:26:05 2010: amandad: Process 17727 failed to exit
Tue Jul 27 12:26:05 2010: amandad: pid 17722 finish time Tue Jul 27 12:26:05 2010
big_mac:/var/log/amanda/amandad root#

tsetliff
July 27th, 2010, 12:19 PM
I found this directory:
/etc/amanda/BackupToTapesWeekly/logs

and in it a file with this contents. It seems to imply that an error happened because there were no free disks. On the other hand I've never successfully made a backup with zmanda and they are all in the drive, I heard the arm take each one from the stack and see what was on it. I guess I just figured it was doing some sort of inventory. How do I force it to reuse tapes with nothing but junk on them?

INFO amdump amdump pid 8111
INFO planner planner pid 8132
START planner date 20100727192046
DISK planner gfxserver /
INFO planner Forcing full dump of gfxserver:/ as directed.
INFO driver driver pid 8133
START driver date 20100727192046
STATS driver hostname tapeserver.remindermedia.net
STATS driver startup time 0.008
INFO dumper dumper pid 8135
INFO taper taper pid 8134
FINISH planner date 20100727192046 time 209.710
INFO planner pid-done 8132
ERROR taper no-tape [No acceptable volumes found]
FAIL driver gfxserver / 20100727192046 0 [Skipping: force-full disk can't be dumped in degraded mode]
INFO dumper pid-done 8135
INFO taper pid-done 8134
FINISH driver date 20100727192046 time 2239.068
INFO driver pid-done 8133

tsetliff
July 27th, 2010, 12:29 PM
So then I'm guessing that I want to make it look like the tape is unused... so I tried amrmtape and that didn't seem to help as the tape isn't in the list of usable tapes to start with. Below is my mtx output.

[root@tapeserver BackupToTapesWeekly]# mtx -f /dev/changer status
Storage Changer /dev/changer:1 Drives, 24 Slots ( 1 Import/Export )
Data Transfer Element 0:Full (Storage Element 3 Loaded):VolumeTag = A00003
Storage Element 1:Full :VolumeTag=A00001
Storage Element 2:Full :VolumeTag=A00002
Storage Element 3:Empty:VolumeTag=
Storage Element 4:Full :VolumeTag=A00004
Storage Element 5:Full :VolumeTag=A00005
Storage Element 6:Full :VolumeTag=A00006
Storage Element 7:Full :VolumeTag=A00007
Storage Element 8:Full :VolumeTag=A00008
Storage Element 9:Full :VolumeTag=A00009
Storage Element 10:Full :VolumeTag=A00010
Storage Element 11:Full :VolumeTag=A00011
Storage Element 12:Full :VolumeTag=A00012
Storage Element 13:Empty:VolumeTag=
Storage Element 14:Empty:VolumeTag=
Storage Element 15:Empty:VolumeTag=
Storage Element 16:Empty:VolumeTag=
Storage Element 17:Empty:VolumeTag=
Storage Element 18:Empty:VolumeTag=
Storage Element 19:Empty:VolumeTag=
Storage Element 20:Empty:VolumeTag=
Storage Element 21:Empty:VolumeTag=
Storage Element 22:Empty:VolumeTag=
Storage Element 23:Full :VolumeTag=
Storage Element 24 IMPORT/EXPORT:Empty:VolumeTag=

martineau
July 28th, 2010, 02:41 AM
What is the output of: amcheck BackupToTapesWeekly

If the tapes have data (not from amanda) on them then they need to be labelled with amlabel. Some new tapes also need to be labelled.