Subject: hang in lfs
To: None <current-users@NetBSD.org>
From: Rui Paulo <rpaulo@fnop.net>
List: current-users
Date: 06/10/2006 03:32:40
Hi,
I have a macppc machine running -current with a /vol1 lfs partition in
a 2.0GB SCSI disk.
I was building a C++ lib from pkgsrc on /vol1 when the machine just
hung.
It replies to pings and I have ddb serial access.

I will leave the machine as is for a while, so say something fast.

Stopped in pid 5.1 (ioflush) at netbsd:cpu_Debugger+0x10:       lwz     r0, r1, 0
x14
db> bt
0x004c0ed0: at zstty_stint+0x264
0x004c0f10: at zsc_intr_hard+0x140
0x004c0f30: at zshard+0x58
0x004c0f50: at ext_intr+0x20c
0x004c0fa0: at trapstart+0x8fc
0xd5256db0: at lfs_writevnodes+0x294
0xd5256df0: at lfs_segwrite+0xe4
0xd5256e40: at lfs_sync+0x7c
0xd5256e60: at sync_fsync+0xb8
0xd5256e90: at VOP_FSYNC+0x4c
0xd5256ed0: at sched_sync+0x194
0xd5256f40: at cpu_switchto+0x44
saved LR(0xdbdbdb57) is invalid.
db> ps
 PID           PPID     PGRP        UID S   FLAGS LWPS          COMMAND    WAIT
 7331          3266      534          0 2  0x4002    1          cc1plus
 3266          2007      534          0 2  0x4002    1              g++    wait
 2007         19451      534          0 2  0x4002    1               sh    wait
 19451         1186      534          0 2  0x4002    1               sh    wait
 1186          2029      534          0 2  0x4002    1               sh    wait
 2029          3907      534          0 2  0x4002    1               sh    wait
 3907         29615      534          0 2  0x4002    1            gmake    wait
 24095          447      447         12 2  0x4108    1           pickup
 29615        12869      534          0 2  0x4002    1               sh    wait
 12869         2103      534          0 2  0x4002    1            gmake    wait
 2103         19001      534          0 2  0x4002    1               sh    wait
 19001        16767      534          0 2  0x4002    1            gmake    wait
 16767        22279      534          0 2  0x4002    1            gmake    wait
 22279        29423      534          0 2  0x4002    1               sh    wait
 29423        15396      534          0 2  0x4002    1             make    wait
 15396         7464      534          0 2  0x4002    1               sh    wait
 7464         17890      534          0 2  0x4002    1             make    wait
 17890        14728      534          0 2  0x4002    1               sh    wait
 14728         6949      534          0 2  0x4002    1             make    wait
 6949          1974      534          0 2  0x4002    1               sh    wait
 637              1      637          0 2       0    1             ntpd
 2805             1     2805          0 2       0    1          route6d
 4332             1     4332          0 2       0    1           routed
 15441            1    15441          0 2       0    1          rpcbind
 18261            1    18261          0 2   0x400    3            named       *
 4641             1     4641          0 2       0    1          syslogd
 1559             1     1559          0 2       0    1            inetd  kqread
 5723             1     5723          0 2       0    1             cron
 6090             1     6090          0 2       0    1          syslogd
 27889            1    27889      32767 2   0x100    1           identd    poll
 3299          3668     3299       1000 2  0x4002    1              zsh   ttyin
 3668          5239     5239       1000 2   0x100    1             sshd
 5239           346     5239          0 2  0x4101    1             sshd   netio
 1974          1843      534          0 2  0x4002    1             make    wait
 1843           534      534          0 2  0x4002    1               sh    wait
 534            555      534          0 2  0x4002    1             make    wait
 555            446      555          0 2  0x4002    1              zsh   pause
 446            489      446       1000 2  0x4002    1              zsh   pause
 489            460      460       1000 2   0x100    1             sshd
 460            346      460          0 2  0x4101    1             sshd   netio
 500              1      500          0 2  0x4002    1            getty
 377              1      377          0 2       0    1             cron
 496              1      496          0 2       0    1            inetd  kqread
 467            447      447         12 2  0x4108    1             qmgr
 447              1      447          0 2  0x4108    1           master
 346              1      346          0 2       0    1             sshd  select
 210              1      210          0 2       0    1     lfs_cleanerd
 205              0        0          0 2 0x20200    1       lfs_writer
 152              1      152          0 2       0    1          syslogd
 28               0        0          0 2 0x20200    1          physiod physiod
 6                0        0          0 2 0x20200    1         aiodoned aiodone
>5                0        0          0 2 0x20200    1          ioflush
 4                0        0          0 2 0x20200    1       pagedaemon pgdaemo
 3                0        0          0 2 0x20200    1         scsibus1  sccomp
 2                0        0          0 2 0x20200    1         scsibus0  sccomp
 1                0        1          0 2  0x4000    1             init    wait
 0               -1        0          0 2 0x20200    1          swapper
db> show vnode
OBJECT 0x368974: locked=-2147418092, pgops=0x38210010, npages=2080899750, refs=-
1809711200

VNODE flags ffffffff92a10034<SYSTEM,EXECMAP,WRITEMAP>
mp 0x93a10054 numoutput -1828650944 size 0x7d80002639200000
data 0x2f000074 usecount -1809711200 writecount -1824456632 holdcnt -1820262320 n
umoutput -1828650944
tag UNKNOWN(952500225) type UNKNOWN(-2012872704) mount 0x93a10054 typedata 0x93e
1005c
db> show buf
  vp 0x92e1003c lblkno 0x2c800075419e0030 blkno 0x93a1005493c10058 rawblkno 0x90
01006491810030 dev 0x93010040
  error 2080899750 flags 0x4e800020<SCANNED,WANTED,XXX,VFLUSH>
  bufsize 0x7d800026 bcount 0x39200000 resid 0x92a10034
  data 0x93410048 saveaddr 0x93210044 dep 0x3ae00001
  iodone 0x92c10038
db> show page
PAGE 0x368974:
  flags=9341<BUSY,FAKE,ZERO,PAGER1>, pqflags=50<ANON>, wire_count=37761, pa=0x93
a10054
  uobject=0x39200000, uanon=0x7d800026, offset=0x92a1003493010040 loan_count=72
  [page ownership tracking disabled]
db> show uvmexp
Current UVM status:
  pagesize=4096 (0x1000), pagemask=0xfff, pageshift=12
  38488 VM pages: 14478 active, 10322 inactive, 1172 wired, 6680 free
  min  10% (25) anon, 10% (25) file, 5% (12) exec
  max  80% (204) anon, 50% (128) file, 30% (76) exec
  pages  10691 anon, 11728 file, 3553 exec
  freemin=64, free-target=85, inactive-target=10324, wired-max=12829
  faults=11795190, traps=12084768, intrs=966798, ctxswitch=4175899
  softint=501053, syscalls=0, swapins=198, swapouts=227
  fault counts:
    noram=0, noanon=0, pgwait=0, pgrele=0
    ok relocks(total)=2240(2240), anget(retrys)=2280782(466), amapcopy=1458254
    neighbor anon/obj pg=3253000/19685054, gets(lock/unlock)=4874411/1774
    cases: anon=1477234, anoncow=791397, obj=4042902, prcopy=831509, przero=4585
272
  daemon and swap counts:
    woke=93, revs=93, scans=29388, obscans=18530, anscans=1816
    busy=0, freed=25592, reactivate=707, deactivate=50821
    pageouts=118, pending=1698, nswget=466
    nswapdev=1, swpgavail=32844
    swpages=32844, swpginuse=817, swpgonly=630, paging=0