Subject: bin/35966: dump reports negative time estimates and writes too much data
To: None <gnats-admin@netbsd.org, netbsd-bugs@netbsd.org>
From: None <agrier@poofygoof.com>
List: netbsd-bugs
Date: 03/10/2007 05:35:00
>Number:         35966
>Category:       bin
>Synopsis:       dump reports negative time estimates and writes too much data
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    bin-bug-people
>State:          open
>Class:          sw-bug
>Submitter-Id:   net
>Arrival-Date:   Sat Mar 10 05:35:00 +0000 2007
>Originator:     agrier@poofygoof.com
>Release:        NetBSD 3.0_STABLE
>Organization:
  Aaron J. Grier | "Not your ordinary poofy goof." | agrier@poofygoof.com
              "silly brewer, saaz are for pils!"  --  virt
>Environment:
	
System: NetBSD aragorn 3.0_STABLE NetBSD 3.0_STABLE (GENERIC) #0: Thu Jul 27 22:58:47 PDT 2006 agrier@aragorn:/var/obj/GENERIC i386
Architecture: i386
Machine: i386

/sbin/dump:
     $NetBSD: crt0.c,v 1.13 2003/07/26 19:24:27 salo Exp $
     $NetBSD: itime.c,v 1.15 2003/08/07 10:04:14 agc Exp $
     $NetBSD: main.c,v 1.57.2.3 2006/11/11 21:30:27 bouyer Exp $
     $NetBSD: optr.c,v 1.33 2004/04/21 01:05:32 christos Exp $
     $NetBSD: dumprmt.c,v 1.30 2003/08/07 10:04:14 agc Exp $
     $NetBSD: rcache.c,v 1.21 2003/09/13 10:59:50 simonb Exp $
     $NetBSD: tape.c,v 1.44.2.1 2006/11/11 21:30:27 bouyer Exp $
     $NetBSD: traverse.c,v 1.44 2004/05/25 14:54:56 hannken Exp $
     $NetBSD: unctime.c,v 1.15 2003/08/07 10:04:15 agc Exp $
     $NetBSD: ffs_inode.c,v 1.16 2004/03/27 12:59:18 dsl Exp $
     $NetBSD: ffs_bswap.c,v 1.29.2.1 2005/06/02 20:43:11 tron Exp $
>Description:
DUMP: Found /dev/rwd0f on /usr in /etc/fstab
DUMP: Date of this level 0 dump: Fri Mar  9 00:32:30 2007
DUMP: Date of last level 0 dump: the epoch
DUMP: Dumping /dev/rwd0f (/usr) to standard output
DUMP: Label: none
DUMP: mapping (Pass I) [regular files]
DUMP: mapping (Pass II) [directories]
DUMP: estimated 10243859 tape blocks.
DUMP: Volume 1 started at: Fri Mar  9 00:33:23 2007
DUMP: dumping (Pass III) [directories]
DUMP: dumping (Pass IV) [regular files]
DUMP: 4.86% done, finished in 1:37
DUMP: 8.25% done, finished in 1:51
DUMP: 11.72% done, finished in 1:53
DUMP: 15.23% done, finished in 1:51
DUMP: 18.68% done, finished in 1:48
DUMP: 22.27% done, finished in 1:44
DUMP: 25.78% done, finished in 1:40
DUMP: 29.23% done, finished in 1:36
DUMP: 33.57% done, finished in 1:29
DUMP: 37.27% done, finished in 1:24
DUMP: 40.70% done, finished in 1:20
DUMP: 44.20% done, finished in 1:15
DUMP: 48.04% done, finished in 1:10
DUMP: 52.18% done, finished in 1:04
DUMP: 55.68% done, finished in 0:59
DUMP: 59.94% done, finished in 0:53
DUMP: 63.71% done, finished in 0:48
DUMP: 67.41% done, finished in 0:43
DUMP: 70.93% done, finished in 0:38
DUMP: 74.34% done, finished in 0:34
DUMP: 77.85% done, finished in 0:29
DUMP: 81.16% done, finished in 0:25
DUMP: 84.53% done, finished in 0:21
DUMP: 87.94% done, finished in 0:16
DUMP: 91.45% done, finished in 0:11
DUMP: 94.86% done, finished in 0:07
DUMP: 100.76% done, finished in 0:-1
DUMP: 104.78% done, finished in 0:-6
DUMP: 108.36% done, finished in 0:-11
DUMP: 112.37% done, finished in 0:-16
DUMP: 116.60% done, finished in 0:-22
DUMP: 124.17% done, finished in 0:-31
DUMP: 135.15% done, finished in 0:-42
DUMP: 144.13% done, finished in 0:-52
DUMP: 153.81% done, finished in -1:-1
DUMP: 163.09% done, finished in -1:-9
DUMP: 174.66% done, finished in -1:-19
DUMP: 180.76% done, finished in -1:-24
DUMP: 183.88% done, finished in -1:-28
DUMP: 186.98% done, finished in -1:-33
DUMP: 190.13% done, finished in -1:-37
DUMP: 194.31% done, finished in -1:-41
DUMP: 198.56% done, finished in -1:-46
DUMP: 208.51% done, finished in -1:-54
DUMP: 220.25% done, finished in -2:-2
DUMP: 231.96% done, finished in -2:-10
DUMP: 243.76% done, finished in -2:-18
DUMP: 255.31% done, finished in -2:-25
DUMP: 267.36% done, finished in -2:-33
DUMP: 279.05% done, finished in -2:-40
DUMP: 290.71% done, finished in -2:-47
DUMP: 302.57% done, finished in -2:-54
DUMP: 314.48% done, finished in -3:00
DUMP: 326.44% done, finished in -3:-7
DUMP: 338.56% done, finished in -3:-13
DUMP: 350.13% done, finished in -3:-20
DUMP: 361.78% done, finished in -3:-26
DUMP: 373.78% done, finished in -3:-32
DUMP: 380.81% done, finished in -3:-37
DUMP: 383.96% done, finished in -3:-41
DUMP: 387.08% done, finished in -3:-46
DUMP: 391.53% done, finished in -3:-50
DUMP: 395.52% done, finished in -3:-55
DUMP: 407.26% done, finished in -4:-1
DUMP: 418.85% done, finished in -4:-7
DUMP: 430.58% done, finished in -4:-13
DUMP: 442.28% done, finished in -4:-19
DUMP: 453.91% done, finished in -4:-25
DUMP: 465.96% done, finished in -4:-30
DUMP: 477.56% done, finished in -4:-36
DUMP: 489.26% done, finished in -4:-42
DUMP: 501.07% done, finished in -4:-48
DUMP: 513.00% done, finished in -4:-53
DUMP: 525.02% done, finished in -4:-59
DUMP: 536.98% done, finished in -5:-5
DUMP: 548.52% done, finished in -5:-10
DUMP: 560.29% done, finished in -5:-16
DUMP: 572.12% done, finished in -5:-21
DUMP: 584.05% done, finished in -5:-27
DUMP: 595.99% done, finished in -5:-32
DUMP: 607.66% done, finished in -5:-38
DUMP: 619.70% done, finished in -5:-43
DUMP: 631.84% done, finished in -5:-49
DUMP: 643.86% done, finished in -5:-54
DUMP: 655.81% done, finished in -6:00
DUMP: 667.62% done, finished in -6:-5
DUMP: 679.44% done, finished in -6:-10
DUMP: 691.31% done, finished in -6:-16
DUMP: 703.38% done, finished in -6:-21
DUMP: 715.54% done, finished in -6:-27
DUMP: 727.13% done, finished in -6:-32
DUMP: 738.88% done, finished in -6:-37
DUMP: 750.63% done, finished in -6:-43
DUMP: 762.26% done, finished in -6:-48
DUMP: 774.11% done, finished in -6:-53
DUMP: 777.39% done, finished in -6:-58
DUMP: 780.63% done, finished in -7:-2
DUMP: 783.79% done, finished in -7:-7
DUMP: 787.23% done, finished in -7:-12
DUMP: 790.75% done, finished in -7:-16
DUMP: 797.72% done, finished in -7:-21
DUMP: 803.22% done, finished in -7:-26
DUMP: 806.38% done, finished in -7:-31
DUMP: 809.54% done, finished in -7:-35
DUMP: 812.69% done, finished in -7:-40
DUMP: 815.91% done, finished in -7:-45
DUMP: 820.20% done, finished in -7:-49
DUMP: 824.02% done, finished in -7:-54
DUMP: 827.65% done, finished in -7:-59
DUMP: 831.19% done, finished in -8:-3
DUMP: 834.55% done, finished in -8:-8
DUMP: 838.05% done, finished in -8:-13
DUMP: 841.36% done, finished in -8:-17
DUMP: 844.65% done, finished in -8:-22
DUMP: 847.98% done, finished in -8:-27
DUMP: 851.30% done, finished in -8:-31
DUMP: 855.19% done, finished in -8:-36
DUMP: 859.18% done, finished in -8:-41
DUMP: 862.85% done, finished in -8:-46
DUMP: 866.23% done, finished in -8:-50
DUMP: 872.14% done, finished in -8:-55
DUMP: 876.18% done, finished in -9:00
DUMP: 879.76% done, finished in -9:-5
DUMP: 883.76% done, finished in -9:-9
DUMP: 888.00% done, finished in -9:-14
DUMP: 895.33% done, finished in -9:-19
DUMP: 907.57% done, finished in -9:-25
DUMP: 919.27% done, finished in -9:-30
DUMP: 931.04% done, finished in -9:-35
DUMP: 942.58% done, finished in -9:-41
DUMP: 954.62% done, finished in -9:-46
DUMP: 966.41% done, finished in -9:-51
DUMP: 978.02% done, finished in -9:-57
DUMP: 989.84% done, finished in -10:-2
DUMP: 1001.78% done, finished in -10:-7
DUMP: 1013.71% done, finished in -10:-12
DUMP: 1025.76% done, finished in -10:-18
DUMP: 1037.57% done, finished in -10:-23
DUMP: 1049.00% done, finished in -10:-28
DUMP: 1061.11% done, finished in -10:-34
DUMP: 1073.00% done, finished in -10:-39
DUMP: 1084.85% done, finished in -10:-44
DUMP: 1096.63% done, finished in -10:-49
DUMP: 1108.51% done, finished in -10:-55
DUMP: 1120.75% done, finished in -11:00
DUMP: 1132.82% done, finished in -11:-5
DUMP: 1144.70% done, finished in -11:-10
DUMP: 1156.71% done, finished in -11:-16
DUMP: 1168.55% done, finished in -11:-21
DUMP: 1180.50% done, finished in -11:-26
DUMP: 1192.47% done, finished in -11:-31
DUMP: 1204.60% done, finished in -11:-36
DUMP: 1216.46% done, finished in -11:-42
DUMP: 1228.20% done, finished in -11:-47
DUMP: 1239.83% done, finished in -11:-52
DUMP: 1251.57% done, finished in -11:-57
DUMP: 1263.48% done, finished in -12:-2
DUMP: 1275.21% done, finished in -12:-8
DUMP: 1286.78% done, finished in -12:-13
DUMP: 1298.90% done, finished in -12:-18
DUMP: 1310.96% done, finished in -12:-23
DUMP: 1323.07% done, finished in -12:-28
DUMP: 1334.91% done, finished in -12:-33
DUMP: 1346.53% done, finished in -12:-39
DUMP: 1358.54% done, finished in -12:-44
DUMP: 1370.29% done, finished in -12:-49
DUMP: 1382.16% done, finished in -12:-54
DUMP: 1393.87% done, finished in -12:-59
DUMP: 1405.61% done, finished in -13:-4
DUMP: 1417.37% done, finished in -13:-10
DUMP: 1429.33% done, finished in -13:-15
DUMP: 1441.23% done, finished in -13:-20
DUMP: 1453.56% done, finished in -13:-25
DUMP: 1465.74% done, finished in -13:-30
DUMP: 1477.45% done, finished in -13:-35
DUMP: 1489.38% done, finished in -13:-40
DUMP: 1501.41% done, finished in -13:-46
DUMP: 1513.44% done, finished in -13:-51
DUMP: 1525.41% done, finished in -13:-56
DUMP: 1537.19% done, finished in -14:-1
DUMP: 1549.32% done, finished in -14:-6
DUMP: 1561.06% done, finished in -14:-11
DUMP: 1573.20% done, finished in -14:-16
DUMP: 1585.15% done, finished in -14:-21
DUMP: 1597.15% done, finished in -14:-27
DUMP: 1609.20% done, finished in -14:-32
DUMP: 1621.17% done, finished in -14:-37
DUMP: 1630.70% done, finished in -14:-42
DUMP: 1635.05% done, finished in -14:-47
DUMP: 1639.23% done, finished in -14:-52
DUMP: 1642.69% done, finished in -14:-56
DUMP: 1646.89% done, finished in -15:-1
DUMP: 169098219 tape blocks
DUMP: Volume 1 completed at: Fri Mar  9 16:36:42 2007
DUMP: Volume 1 took 16:03:19
DUMP: Volume 1 transfer rate: 2925 KB/s
DUMP: Date of this level 0 dump: Fri Mar  9 00:32:30 2007
DUMP: Date this dump completed:  Fri Mar  9 16:36:42 2007
DUMP: Average transfer rate: 2925 KB/s
DUMP: level 0 dump on Fri Mar  9 00:32:30 2007
DUMP: DUMP IS DONE

let me get this straight; the dump estimated 10243859 blocks, yet wrote
169098219 blocks?  how is that possible?

169098219 / 10243859 ~= 16.5

that's over sixteen TIMES the amount of data I actually have written on
disk.

something is wrong.

>How-To-Repeat:
attempt to dump my /usr partition.
>Fix:
	

>Unformatted: