I'm only getting level 0 dumps for all my disks as estimates for level
1 are failing. I'm using gnu tar to do the dumps. I've included some
excerpts pertaining to an example disk (/boot) from two days consecutive amdump
log
files. Does anyone have a suggestion why estimates may be failing or
where I should look next?
regards :-)
BruceS
============================================================
amdump: start at Sun May 20 00:05:01 ADT 2007
amdump: datestamp 20070520
============================================================
planner: pid 14881 executable /usr/lib/amanda/planner version 2.5.0p2
SETTING UP FOR ESTIMATES...
planner: time 0.001: setting up estimates for gw.n.xatl.drdc-rddc.gc.ca:/boot
driver: started dumper1 pid 14886
driver: started dumper2 pid 14887
driver: started dumper3 pid 14888
driver: started dumper4 pid 14889
driver: started dumper5 pid 14890
driver: start time 0.033 inparallel 6 bandwidth 50 diskspace 75846828 dir
OBSOLETE datestamp 20070520 driver: drain-ends tapeq FIRST big-dumpers ttt
dumper: pid 14885 executable dumper0 version 2.5.0p2
dumper: pid 14886 executable dumper1 version 2.5.0p2
dumper: pid 14887 executable dumper2 version 2.5.0p2
dumper: pid 14888 executable dumper3 version 2.5.0p2
dumper: pid 14889 executable dumper4 version 2.5.0p2
dumper: pid 14890 executable dumper5 version 2.5.0p2
setup_estimate: gw.n.xatl.drdc-rddc.gc.ca:/boot: command 0, options: none
last_level 0 next_level0 28 level_days 0 getting estimates 0 (-2) 1 (-2) -1
(-2)
planner: time 0.150: setting up estimates took 0.148 secs
GETTING ESTIMATES...
planner: time 0.158: bind_portrange2: trying port=842
planner: time 0.158: dgram_bind: socket bound to 0.0.0.0.842
planner: time 0.806: got partial result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> -2K, 1 -> -2K, -1 -> -2K
planner: time 0.935: got partial result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> 31910K, 1 -> -2K, -1 -> -2K
planner: time 0.953: got partial result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 933.988: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1000.273: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1004.592: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1007.623: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1090.864: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1092.452: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1092.838: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1092.887: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1094.993: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1095.045: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1101.443: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1101.626: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1101.638: got result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1101.639: getting estimates took 1101.488 secs
ANALYZING ESTIMATES...
pondering gw.n.xatl.drdc-rddc.gc.ca:/boot... next_level0 28 last_level 0 (not
due for a full dump, picking an incr level)
picklev: last night 0, so tonight level 1
curr level 0 size 28897 total size 44214235 total_lev0 0 balanced-lev0size
1579056
INITIAL SCHEDULE (size 44214235):
gw.n.xatl.drdc-rddc.gc.ca /boot pri 1 lev 0 size 28897
GENERATING SCHEDULE:
--------
DUMP gw.n.xatl.drdc-rddc.gc.ca fffffeff9ffeffff07 /boot 20070520 1 0
1970:1:1:0:0:0 28897 4 0 1970:1:1:0:0:0 28897 28
--------
driver: flush size 0
driver: send-cmd time 1101.729 to chunker0: PORT-WRITE 00-00001
/var/spool/amanda/20070520000501/gw.n.xatl.drdc-rddc.gc.ca._boot.0
gw.n.xatl.drdc-rddc.gc.ca fffffeff9ffeffff07 /boot 0 1970:1:1:0:0:0 1048576
GNUTAR 28992 |;auth=BSD;srvcomp-fast;index;
driver: finished-cmd time 1105.720 dumper0 dumped
gw.n.xatl.drdc-rddc.gc.ca:/boot
driver: finished-cmd time 1105.721 chunker0 chunked
gw.n.xatl.drdc-rddc.gc.ca:/boot
driver: startaflush: FIRST gw.n.xatl.drdc-rddc.gc.ca /boot 28924 35840000
driver: finished-cmd time 1114.230 taper wrote gw.n.xatl.drdc-rddc.gc.ca:/boot
amdump: start at Mon May 21 00:05:01 ADT 2007
amdump: datestamp 20070521
============================================================
amdump: start at Mon May 21 00:05:01 ADT 2007
amdump: datestamp 20070521
============================================================
planner: pid 16387 executable /usr/lib/amanda/planner version 2.5.0p2
SETTING UP FOR ESTIMATES...
planner: time 0.044: setting up estimates for gw.n.xatl.drdc-rddc.gc.ca:/boot
dumper: pid 16393 executable dumper3 version 2.5.0p2
dumper: pid 16391 executable dumper1 version 2.5.0p2
dumper: pid 16390 executable dumper0 version 2.5.0p2
dumper: pid 16392 executable dumper2 version 2.5.0p2
dumper: pid 16395 executable dumper5 version 2.5.0p2
dumper: pid 16394 executable dumper4 version 2.5.0p2
setup_estimate: gw.n.xatl.drdc-rddc.gc.ca:/boot: command 0, options: none
last_level 0 next_level0 27 level_days 0 getting estimates 0 (-2) 1 (-2) -1
(-2)
planner: time 1.066: got partial result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> -2K, 1 -> -2K, -1 -> -2K
planner: time 1.167: got partial result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> 31910K, 1 -> -2K, -1 -> -2K
planner: time 1.185: got partial result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1017.759: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1075.904: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1080.166: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1083.078: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1162.401: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1164.066: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1166.117: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1166.160: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1168.360: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1168.407: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1174.240: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1174.415: got partial result for host gw.n.xatl.drdc-rddc.gc.ca
disk /boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
planner: time 1174.421: got result for host gw.n.xatl.drdc-rddc.gc.ca disk
/boot: 0 -> 31910K, 1 -> -1K, -1 -> -2K
ANALYZING ESTIMATES...
pondering gw.n.xatl.drdc-rddc.gc.ca:/boot... next_level0 27 last_level 0 (not
due for a full dump, picking an incr level)
picklev: last night 0, so tonight level 1
curr level 0 size 28893 total size 44297288 total_lev0 0 balanced-lev0size
1582022
INITIAL SCHEDULE (size 44297288):
gw.n.xatl.drdc-rddc.gc.ca /boot pri 1 lev 0 size 28893
GENERATING SCHEDULE:
--------
DUMP gw.n.xatl.drdc-rddc.gc.ca fffffeff9ffeffff07 /boot 20070521 1 0
1970:1:1:0:0:0 28893 4 0 1970:1:1:0:0:0 28893 28
--------
driver: flush size 0
driver: send-cmd time 1174.452 to chunker0: PORT-WRITE 00-00001
/var/spool/amanda/20070521000501/gw.n.xatl.drdc-rddc.gc.ca._boot.0
gw.n.xatl.drdc-rddc.gc.ca fffffeff9ffeffff07 /boot 0 1970:1:1:0:0:0 1048576
GNUTAR 28960 |;auth=BSD;srvcomp-fast;index;
driver: send-cmd time 1174.533 to dumper0: PORT-DUMP 00-00001 50012
gw.n.xatl.drdc-rddc.gc.ca fffffeff9ffeffff07 /boot /boot 0 1970:1:1:0:0:0
GNUTAR |;auth=BSD;srvcomp-fast;index;
driver: finished-cmd time 1178.298 dumper0 dumped
gw.n.xatl.drdc-rddc.gc.ca:/boot
driver: finished-cmd time 1178.301 chunker0 chunked
gw.n.xatl.drdc-rddc.gc.ca:/boot
driver: send-cmd time 1178.307 to taper: FILE-WRITE 00-00002
/var/spool/amanda/20070521000501/gw.n.xatl.drdc-rddc.gc.ca._boot.0
gw.n.xatl.drdc-rddc.gc.ca fffffeff9ffeffff07 /boot 0 20070521 0
driver: startaflush: FIRST gw.n.xatl.drdc-rddc.gc.ca /boot 28924 35840000
driver: finished-cmd time 1184.912 taper wrote gw.n.xatl.drdc-rddc.gc.ca:/boot
--
Bruce Skinner
Norstead Farm
1427 Prospect Rd
Waterville NS B0P 1V0
CANADA
Tel: 902-538-1765
Cell: 902-670-6456
<mailto:Bruce.Skinner AT norsteadfarm DOT ca>
|