From nobody@nwww.freebsd.org Thu May 2 11:42:48 2002 Return-Path: Received: from nwww.freebsd.org (nwww.FreeBSD.org [216.136.204.117]) by hub.freebsd.org (Postfix) with ESMTP id 6C6A437B426 for ; Thu, 2 May 2002 11:42:16 -0700 (PDT) Received: from nwww.freebsd.org (localhost [127.0.0.1]) by nwww.freebsd.org (8.12.2/8.12.2) with ESMTP id g42IhLhG066048 for ; Thu, 2 May 2002 11:43:21 -0700 (PDT) (envelope-from nobody@nwww.freebsd.org) Received: (from nobody@localhost) by nwww.freebsd.org (8.12.2/8.12.2/Submit) id g42IhLZZ066047; Thu, 2 May 2002 11:43:21 -0700 (PDT) Message-Id: <200205021843.g42IhLZZ066047@nwww.freebsd.org> Date: Thu, 2 May 2002 11:43:21 -0700 (PDT) From: Alson van der Meulen To: freebsd-gnats-submit@FreeBSD.org Subject: Page fault when newfs'ing a vinum volume while one of the two plexes is being initialized X-Send-Pr-Version: www-1.0 >Number: 37675 >Category: kern >Synopsis: [vinum] Page fault when newfs'ing a vinum volume while one of the two plexes is being initialized >Confidential: no >Severity: serious >Priority: medium >Responsible: le >State: closed >Quarter: >Keywords: >Date-Required: >Class: sw-bug >Submitter-Id: current-users >Arrival-Date: Thu May 02 11:50:02 PDT 2002 >Closed-Date: Sat Nov 26 15:05:57 GMT 2005 >Last-Modified: Sat Nov 26 15:05:57 GMT 2005 >Originator: Alson van der Meulen >Release: 4.5-RELEASE-p2 >Organization: Montessorischool Waalsdorp >Environment: FreeBSD damaged.local.waalsdorp.nl 4.5-RELEASE-p2 FreeBSD 4.5-RELEASE-p2 #2: Sat Mar 23 18:32:08 CET 2002 root@damaged.local.waalsdorp.nl:/usr/src/sys/compile/DAMAGED i386 >Description: I converted a vinum volume from striping to mirroring. After the data had been backuped, one of the two plexes was up, and the other was down. Sorry if this PR is too verbose, but I'm not sure what information is important, so I include it all. I figured I had to initialize the other plex, so I did 'init raid.p1'. When this was around 60%, I started a newfs on the volume 'raid'. The kernel paniced a short time after newfs was started. I'm afraid I can't try to reproduce this problem, since I can't really afford to take this box offline. Vinum config (sorry, don't have the vinum config from the time it crashed, but it was basically the same as the current one, except that raid.p1 was initializing): vinum -> list 2 drives: D d1 State: up Device /dev/ad0s1e Avail: 0/78528 MB (0%) D d2 State: up Device /dev/ad2s1e Avail: 0/78528 MB (0%) 1 volumes: V raid State: up Plexes: 2 Size: 76 GB 2 plexes: P raid.p0 C State: up Subdisks: 1 Size: 76 GB P raid.p1 C State: up Subdisks: 1 Size: 76 GB 2 subdisks: S raid.p0.s0 State: up PO: 0 B Size: 76 GB S raid.p1.s0 State: up PO: 0 B Size: 76 GB There was probably some configuration error, and I've messed around a bit with vinum to try to get it to work, so I'm not sure what the relevant part is here: Apr 14 15:00:45 damaged /kernel: vinum: unloaded Apr 14 15:00:47 damaged /kernel: vinum: loaded Apr 14 15:00:55 damaged /kernel: vinum: raid.p0.s0 is crashed Apr 14 15:00:55 damaged /kernel: vinum: raid.p0 is faulty Apr 14 15:00:55 damaged /kernel: vinum: raid.p1.s0 is crashed Apr 14 15:00:55 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:01:13 damaged /kernel: vinum: unloaded Apr 14 15:01:20 damaged /kernel: vinum: loaded Apr 14 15:01:47 damaged /kernel: vinum: unloaded Apr 14 15:01:48 damaged /kernel: vinum: loaded Apr 14 15:01:51 damaged /kernel: vinum: reading configuration from /dev/ad0s1e Apr 14 15:01:51 damaged /kernel: vinum: updating configuration from /dev/ad2s1e Apr 14 15:02:51 damaged /kernel: vinum: unloaded Apr 14 15:03:00 damaged /kernel: vinum: loaded Apr 14 15:03:05 damaged /kernel: vinum: CONFIGURATION OBLITERATED Apr 14 15:03:07 damaged /kernel: vinum: reading configuration from /dev/ad0s1e Apr 14 15:03:07 damaged /kernel: vinum: updating configuration from /dev/ad2s1e Apr 14 15:03:15 damaged /kernel: vinum: unloaded Apr 14 15:03:22 damaged /kernel: vinum: loaded Apr 14 15:03:28 damaged /kernel: vinum: reading configuration from /dev/ad2s1e Apr 14 15:03:28 damaged /kernel: vinum: updating configuration from /dev/ad0s1e Apr 14 15:03:35 damaged /kernel: vinum: raid.p0.s1 is crashed by force Apr 14 15:03:35 damaged /kernel: vinum: raid is down Apr 14 15:03:35 damaged /kernel: vinum: raid.p0 is faulty Apr 14 15:03:35 damaged /kernel: vinum: removing raid.p0.s0 Apr 14 15:03:35 damaged /kernel: vinum: plex raid.p0 does not have at least 2 subdisks Apr 14 15:03:35 damaged /kernel: Correcting length of raid.p0: was 321645128, is 160822564 Apr 14 15:03:37 damaged /kernel: vinum: removing raid.p0.s1 Apr 14 15:03:37 damaged /kernel: vinum: plex raid.p0 does not have at least 2 subdisks Apr 14 15:03:37 damaged /kernel: vinum: raid.p0 is up Apr 14 15:03:37 damaged /kernel: vinum: raid is up Apr 14 15:03:50 damaged /kernel: vinum: removing raid.p0 Apr 14 15:03:50 damaged /kernel: vinum: raid is down Apr 14 15:03:52 damaged /kernel: vinum: removing raid Apr 14 15:04:05 damaged /kernel: vinum: unloaded Apr 14 15:04:12 damaged /kernel: vinum: loaded Apr 14 15:04:12 damaged /kernel: vinum: raid.p0.s0 is crashed Apr 14 15:04:12 damaged /kernel: vinum: raid.p0 is faulty Apr 14 15:04:12 damaged /kernel: vinum: raid.p1.s0 is crashed Apr 14 15:04:12 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:04:46 damaged vinum: couldn't initialize plex raid.p0, 1 processes died Apr 14 15:04:52 damaged /kernel: vinum: unloaded Apr 14 15:04:53 damaged /kernel: vinum: loaded Apr 14 15:05:11 damaged /kernel: vinum: no drives found Apr 14 15:05:41 damaged /kernel: vinum: raid.p0.s0 is crashed Apr 14 15:05:41 damaged /kernel: vinum: raid.p0 is faulty Apr 14 15:05:41 damaged /kernel: vinum: raid.p1.s0 is crashed Apr 14 15:05:41 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:07:17 damaged /kernel: vinum: drive d1 is up Apr 14 15:07:17 damaged /kernel: vinum: raid.p0.s0 is reborn Apr 14 15:07:17 damaged /kernel: vinum: raid.p0 is flaky Apr 14 15:07:17 damaged /kernel: vinum: raid is up Apr 14 15:07:17 damaged /kernel: vinum: raid.p0 is faulty Apr 14 15:07:17 damaged /kernel: vinum: raid is down Apr 14 15:07:17 damaged /kernel: vinum: raid.p2 is up Apr 14 15:07:17 damaged /kernel: vinum: raid is up Apr 14 15:07:27 damaged /kernel: vinum: raid.p4.s0 is crashed Apr 14 15:07:27 damaged /kernel: vinum: raid.p4 is faulty Apr 14 15:07:27 damaged /kernel: vinum: raid.p3 is faulty Apr 14 15:07:33 damaged /kernel: vinum: CONFIGURATION OBLITERATED Apr 14 15:07:36 damaged /kernel: vinum: unloaded Apr 14 15:07:38 damaged /kernel: vinum: loaded Apr 14 15:07:38 damaged /kernel: vinum: no drives found Apr 14 15:07:40 damaged /kernel: vinum: no drives found Apr 14 15:07:46 damaged /kernel: vinum: drive d1 is up Apr 14 15:07:46 damaged /kernel: vinum: drive d2 is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p0.s0 is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p0 is up Apr 14 15:07:46 damaged /kernel: vinum: raid is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:08:00 damaged /kernel: vinum: raid.p1.s0 is initializing by force Apr 14 15:08:00 damaged /kernel: vinum: raid.p1 is initializing Apr 14 15:05:41 damaged /kernel: vinum: raid.p1.s0 is crashed Apr 14 15:05:41 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:07:17 damaged /kernel: vinum: drive d1 is up Apr 14 15:07:17 damaged /kernel: vinum: raid.p0.s0 is reborn Apr 14 15:07:17 damaged /kernel: vinum: raid.p0 is flaky Apr 14 15:07:17 damaged /kernel: vinum: raid is up Apr 14 15:07:17 damaged /kernel: vinum: raid.p0 is faulty Apr 14 15:07:17 damaged /kernel: vinum: raid is down Apr 14 15:07:17 damaged /kernel: vinum: raid.p2 is up Apr 14 15:07:17 damaged /kernel: vinum: raid is up Apr 14 15:07:27 damaged /kernel: vinum: raid.p4.s0 is crashed Apr 14 15:07:27 damaged /kernel: vinum: raid.p4 is faulty Apr 14 15:07:27 damaged /kernel: vinum: raid.p3 is faulty Apr 14 15:07:33 damaged /kernel: vinum: CONFIGURATION OBLITERATED Apr 14 15:07:36 damaged /kernel: vinum: unloaded Apr 14 15:07:38 damaged /kernel: vinum: loaded Apr 14 15:07:38 damaged /kernel: vinum: no drives found Apr 14 15:07:40 damaged /kernel: vinum: no drives found Apr 14 15:07:46 damaged /kernel: vinum: drive d1 is up Apr 14 15:07:46 damaged /kernel: vinum: drive d2 is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p0.s0 is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p0 is up Apr 14 15:07:46 damaged /kernel: vinum: raid is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:08:00 damaged /kernel: vinum: raid.p1.s0 is initializing by force Apr 14 15:08:00 damaged /kernel: vinum: raid.p1 is initializing Apr 14 15:05:41 damaged /kernel: vinum: raid.p1.s0 is crashed Apr 14 15:05:41 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:07:17 damaged /kernel: vinum: drive d1 is up Apr 14 15:07:17 damaged /kernel: vinum: raid.p0.s0 is reborn Apr 14 15:07:17 damaged /kernel: vinum: raid.p0 is flaky Apr 14 15:07:17 damaged /kernel: vinum: raid is up Apr 14 15:07:17 damaged /kernel: vinum: raid.p0 is faulty Apr 14 15:07:17 damaged /kernel: vinum: raid is down Apr 14 15:07:17 damaged /kernel: vinum: raid.p2 is up Apr 14 15:07:17 damaged /kernel: vinum: raid is up Apr 14 15:07:27 damaged /kernel: vinum: raid.p4.s0 is crashed Apr 14 15:07:27 damaged /kernel: vinum: raid.p4 is faulty Apr 14 15:07:27 damaged /kernel: vinum: raid.p3 is faulty Apr 14 15:07:33 damaged /kernel: vinum: CONFIGURATION OBLITERATED Apr 14 15:07:36 damaged /kernel: vinum: unloaded Apr 14 15:07:38 damaged /kernel: vinum: loaded Apr 14 15:07:38 damaged /kernel: vinum: no drives found Apr 14 15:07:40 damaged /kernel: vinum: no drives found Apr 14 15:07:46 damaged /kernel: vinum: drive d1 is up Apr 14 15:07:46 damaged /kernel: vinum: drive d2 is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p0.s0 is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p0 is up Apr 14 15:07:46 damaged /kernel: vinum: raid is up Apr 14 15:07:46 damaged /kernel: vinum: raid.p1 is faulty Apr 14 15:08:00 damaged /kernel: vinum: raid.p1.s0 is initializing by force Apr 14 15:08:00 damaged /kernel: vinum: raid.p1 is initializing Backtrace: Script started on Thu May 2 20:20:26 2002 damaged# gdb -k GNU gdb 4.18 Copyright 1998 Free Software Foundation, Inc. GDB is free software, covered by the GNU General Public License, and you are welcome to change it and/or distribute copies of it under certain conditions. Type "show copying" to see the conditions. There is absolutely no warranty for GDB. Type "show warranty" for details. This GDB was configured as "i386-unknown-freebsd". (kgdb) symbol-file kernel.debug.23032002 Reading symbols from kernel.debug.23032002...done. (kgdb) exec-file kernel.0 (kgdb) core-file vmcore.0 IdlePTD at phsyical address 0x00342000 initial pcb at physical address 0x002b4120 panicstr: page fault panic messages: --- Fatal trap 12: page fault while in kernel mode fault virtual address = 0x0 fault code = supervisor read, page not present instruction pointer = 0x8:0xc1f1b72d stack pointer = 0x10:0xd79e9d78 frame pointer = 0x10:0xd79e9d8c code segment = base 0x0, limit 0xfffff, type 0x1b = DPL 0, pres 1, def32 1, gran 1 processor eflags = interrupt enabled, resume, IOPL = 0 current process = 500 (newfs) interrupt mask = none trap number = 12 panic: page fault syncing disks... 6 done Uptime: 22m10s dumping to dev #ad/0x20021, offset 1048736 dump ata2: resetting devices .. done 511 510 509 508 507 506 505 504 503 502 501 500 499 498 497 496 495 494 493 492 491 490 489 488 487 486 485 484 483 482 481 480 479 478 477 476 475 474 473 472 471 470 469 468 467 466 465 464 463 462 461 460 459 458 457 456 455 454 453 452 451 450 449 448 447 446 445 444 443 442 441 440 439 438 437 436 435 434 433 432 431 430 429 428 427 426 425 424 423 422 421 420 419 418 417 416 415 414 413 412 411 410 409 408 407 406 405 404 403 402 401 400 399 398 397 396 395 394 393 392 391 390 389 388 387 386 385 384 383 382 381 380 379 378 377 376 375 374 373 372 371 370 369 368 367 366 365 364 363 362 361 360 359 358 357 356 355 354 353 352 351 350 349 348 347 346 345 344 343 342 341 [CTRL-C to abort] 340 339 338 337 336 335 334 333 332 331 330 329 328 327 326 325 324 323 322 321 320 319 318 317 316 315 314 313 312 311 310 309 308 307 306 305 304 303 302 301 300 299 298 297 296 295 294 293 292 291 290 289 288 287 286 285 284 283 282 281 280 279 278 277 276 275 274 273 272 271 270 269! 268 267 266 265 264 263 262 261 260 259 258 257 256 255 254 253 252 251 250 249 248 247 246 245 244 243 242 241 240 239 238 237 236 235 234 233 232 231 230 229 228 227 226 225 224 223 222 221 220 219 218 217 216 215 214 213 212 211 210 209 208 207 206 205 204 203 202 201 200 199 198 197 196 195 194 193 192 191 190 189 188 187 186 185 184 183 182 181 180 179 178 177 176 175 174 173 172 171 170 169 168 167 166 165 164 163 162 161 160 159 158 157 156 155 154 153 152 151 150 149 148 147 146 145 144 143 142 141 140 139 138 137 136 135 134 133 132 131 130 129 128 127 126 125 124 123 122 121 120 119 118 117 116 115 114 113 112 111 110 109 108 107 106 105 104 103 102 101 100 99 98 97 96 95 94 93 92 91 90 89 88 87 86 85 84 83 82 81 80 79 78 77 76 75 74 73 72 71 70 69 68 67 66 65 64 63 62 61 60 59 58 57 56 55 54 53 52 51 50 49 48 47 46 45 44 43 42 41 40 39 38 37 36 35 34 33 32 31 30 29 28 27 26 25 24 23 22 21 20 19 18 17 16 15 14 13 12 11 10 9 8 7 6 5 4 3 2 1 0 --- #0 dumpsys () at ../../kern/kern_shutdown.c:474 474 if (dumping++) { (kgdb) where #0 dumpsys () at ../../kern/kern_shutdown.c:474 #1 0xc014351f in boot (howto=256) at ../../kern/kern_shutdown.c:313 #2 0xc0143919 in panic (fmt=0xc0289aec "%s") at ../../kern/kern_shutdown.c:582 #3 0xc025200f in trap_fatal (frame=0xd79e9d38, eva=0) at ../../i386/i386/trap.c:956 #4 0xc0251cbd in trap_pfault (frame=0xd79e9d38, usermode=0, eva=0) at ../../i386/i386/trap.c:849 #5 0xc0251863 in trap (frame={tf_fs = 16, tf_es = 16, tf_ds = 16, tf_edi = -1038679040, tf_esi = 1, tf_ebp = -677470836, tf_isp = -677470876, tf_ebx = -1038678496, tf_edx = -1039884288, tf_ecx = 14, tf_eax = 0, tf_trapno = 12, tf_err = 0, tf_eip = -1041123539, tf_cs = 8, tf_eflags = 66182, tf_esp = -1039884288, tf_ss = -1040259072}) at ../../i386/i386/trap.c:448 #6 0xc1f1b72d in ?? () #7 0xc1f1b552 in ?? () #8 0xc1f1b3ba in ?? () #9 0xc013fe63 in physio (dev=0xc1ee1500, uio=0xd79e9ed4, ioflag=524289) at ../../kern/kern_physio.c:111 #10 0xc017bc5d in spec_write (ap=0xd79e9e64) at ../../miscfs/specfs/spec_vnops.c:283 #11 0xc020c364 in ufsspec_write (ap=0xd79e9e64) at ../../ufs/ufs/ufs_vnops.c:1874 #12 0xc020c981 in ufs_vnoperatespec (ap=0xd79e9e64) at ../../ufs/ufs/ufs_vnops.c:2441 #13 0xc0177ee6 in vn_write (fp=0xc2108440, uio=0xd79e9ed4, cred=0xc2097480, flags=0, p=0xd796ec20) at vnode_if.h:363 #14 0xc015225d in dofilewrite (p=0xd796ec20, fp=0xc2108440, fd=3, buf=0x806cb40, nbyte=131072, offset=-1, flags=0) at ../../sys/file.h:162 #15 0xc0152116 in write (p=0xd796ec20, uap=0xd79e9f80) at ../../kern/sys_generic.c:329 #16 0xc02522c5 in syscall2 (frame={tf_fs = 47, tf_es = 47, tf_ds = 47, tf_edi = 8192, tf_esi = 122880, tf_ebp = -1077940500, tf_isp = -677470252, tf_ebx = 3, tf_edx = 3, tf_ecx = 0, tf_eax = 4, tf_trapno = 7, tf_err = 2, tf_eip = 134621012, tf_cs = 31, tf_eflags = 659, tf_esp = -1077940528, tf_ss = 47}) at ../../i386/i386/trap.c:1157 #17 0xc0245f35 in Xint0x80_syscall () #18 0x804c9d5 in ?? () #19 0x804b86d in ?? () #20 0x804b29d in ?? () #21 0x8049213 in ?? () #22 0x8048135 in ?? () (kgdb) up 9 #9 0xc013fe63 in physio (dev=0xc1ee1500, uio=0xd79e9ed4, ioflag=524289) at ../../kern/kern_physio.c:111 111 BUF_STRATEGY(bp, 0); (kgdb) print bp $1 = (struct buf *) 0x1 (kgdb) up #10 0xc017bc5d in spec_write (ap=0xd79e9e64) at ../../miscfs/specfs/spec_vnops.c:283 283 error = (*devsw(dev)->d_write) (dev, uio, ap->a_ioflag); (kgdb) print dev $2 = 0xc1ee1500 (kgdb) print *dev $3 = {si_flags = 0, si_udev = 23296, si_hash = {le_next = 0xc1edfc00, le_prev = 0xc1ff3688}, si_hlist = { slh_first = 0xd79a64c0}, si_name = '\000' , si_drv1 = 0x0, si_drv2 = 0x0, si_devsw = 0x0, si_iosize_max = 65536, __si_u = {__si_tty = {__sit_tty = 0x0}, __si_disk = {__sid_disk = 0x0, __sid_mountpoint = 0x0, __sid_bsize_phys = 512, __sid_bsize_best = 0}}} (kgdb) print uio $4 = (struct uio *) 0xd79e9ed4 (kgdb) print *uio $5 = {uio_iov = 0xd79e9eac, uio_iovcnt = 1, uio_offset = 15825272832, uio_resid = 131072, uio_segflg = UIO_USERSPACE, uio_rw = UIO_WRITE, uio_procp = 0xd796ec20} (kgdb) print ap->a_ioflag $6 = 524289 (kgdb) up #11 0xc020c364 in ufsspec_write (ap=0xd79e9e64) at ../../ufs/ufs/ufs_vnops.c:1874 1874 error = VOCALL(spec_vnodeop_p, VOFFSET(vop_write), ap); (kgdb) print spec_vnodeop_p $7 = (vop_t **) 0xc1de3000 (kgdb) print *spec_vnodeop_p $8 = (vop_t *) 0xc016e130 (kgdb) print ap $10 = (struct vop_write_args *) 0xd79e9e64 (kgdb) print *ap $11 = {a_desc = 0xc0292000, a_vp = 0xd79a6640, a_uio = 0xd79e9ed4, a_ioflag = 524289, a_cred = 0xc2097480} (kgdb) up #12 0xc020c981 in ufs_vnoperatespec (ap=0xd79e9e64) at ../../ufs/ufs/ufs_vnops.c:2441 2441 return (VOCALL(ufs_specop_p, ap->a_desc->vdesc_offset, ap)); (kgdb) print ufs_specop_p $12 = (vop_t **) 0xc1de3a00 (kgdb) print *ufs_specop_p $13 = (vop_t *) 0xc016e130 (kgdb) print ap $14 = (struct vop_generic_args *) 0x0 (kgdb) up #13 0xc0177ee6 in vn_write (fp=0xc2108440, uio=0xd79e9ed4, cred=0xc2097480, flags=0, p=0xd796ec20) at vnode_if.h:363 363 rc = VCALL(vp, VOFFSET(vop_write), &a); (kgdb) print vp $15 = (struct vnode *) 0xd79a6640 (kgdb) print *vp $16 = {v_flag = 0, v_usecount = 2, v_writecount = 1, v_holdcnt = 0, v_id = 2724, v_mount = 0xc1edba00, v_op = 0xc1e24e00, v_freelist = {tqe_next = 0xd79a64c0, tqe_prev = 0xd79a695c}, v_nmntvnodes = {tqe_next = 0xd79a64c0, tqe_prev = 0xd79a67e4}, v_cleanblkhd = {tqh_first = 0x0, tqh_last = 0xd79a666c}, v_dirtyblkhd = {tqh_first = 0x0, tqh_last = 0xd79a6674}, v_synclist = {le_next = 0x0, le_prev = 0x0}, v_numoutput = 0, v_type = VCHR, v_un = {vu_mountedhere = 0xc1ee1500, vu_socket = 0xc1ee1500, vu_spec = {vu_specinfo = 0xc1ee1500, vu_specnext = {sle_next = 0x0}}, vu_fifoinfo = 0xc1ee1500}, v_lease = 0x0, v_lastw = 0, v_cstart = 0, v_lasta = 0, v_clen = 0, v_object = 0x0, v_interlock = {lock_data = 0}, v_vnlock = 0xc2052e00, v_tag = VT_UFS, v_data = 0xc2052e00, v_cache_src = {lh_first = 0x0}, v_cache_dst = { tqh_first = 0xc2160fc0, tqh_last = 0xc2160fd0}, v_dd = 0xd79a6640, v_ddid = 0, v_pollinfo = {vpi_lock = {lock_data = 0}, vpi_selinfo = {si_pid = 0, si_note = {slh_first = 0x0}, si_flags = 0}, vpi_events = 0, vpi_revents = 0}, v_vxproc = 0x0} (kgdb) print a $17 = {a_desc = 0xc0292000, a_vp = 0xd79a6640, a_uio = 0xd79e9ed4, a_ioflag = 524289, a_cred = 0xc2097480} (kgdb) up #14 0xc015225d in dofilewrite (p=0xd796ec20, fp=0xc2108440, fd=3, buf=0x806cb40, nbyte=131072, offset=-1, flags=0) at ../../sys/file.h:162 162 error = (*fp->f_ops->fo_write)(fp, uio, cred, flags, p); (kgdb) print fp $18 = (struct file *) 0xc2108440 (kgdb) print *fp $19 = {f_list = {le_next = 0xc2160a80, le_prev = 0xc20922c0}, f_FILLER3 = 0, f_type = 1, f_flag = 2, f_cred = 0xc2097480, f_ops = 0xc029ce40, f_seqcount = 8, f_nextoff = 15825272832, f_offset = 15825272832, f_data = 0xd79a6640 "", f_count = 3, f_msgcount = 0} (kgdb) print cred $20 = (struct ucred *) 0x0 (kgdb) print flags $21 = 0 (kgdb) print p $22 = (struct proc *) 0xd796ec20 (kgdb) print *p $23 = {p_procq = {tqe_next = 0x0, tqe_prev = 0xc02cafa0}, p_list = {le_next = 0xd796f2a0, le_prev = 0xc02caef8}, p_cred = 0xc2146b00, p_fd = 0xc2051600, p_stats = 0xd79e7cd0, p_limit = 0xc1fde900, p_upages_obj = 0xd79d6cc0, p_procsig = 0xc1ff1d40, p_flag = 16390, p_stat = 2 '\002', p_pad1 = "\000\000", p_pid = 500, p_hash = {le_next = 0x0, le_prev = 0xc1dbafd0}, p_pglist = {le_next = 0x0, le_prev = 0xc1ff8ee8}, p_pptr = 0xd796f2a0, p_sibling = {le_next = 0x0, le_prev = 0xd796f2f0}, p_children = {lh_first = 0x0}, p_ithandle = {callout = 0x0}, p_oppid = 0, p_dupfd = 0, p_vmspace = 0xd798fdc0, p_estcpu = 54, p_cpticks = 17, p_pctcpu = 275, p_wchan = 0x0, p_wmesg = 0xc026858f "physstr", p_swtime = 33, p_slptime = 0, p_realtimer = {it_interval = {tv_sec = 0, tv_usec = 0}, it_value = {tv_sec = 0, tv_usec = 0}}, p_runtime = 4325751, p_uu = 0, p_su = 0, p_iu = 0, p_uticks = 353, p_sticks = 285, p_iticks = 19, p_traceflag = 0, p_tracep = 0x0, p_siglist = {__bits = {0, 0, 0, 0}}, p_textvp = 0xd64c1d80, p_lock = 1 '\001', p_oncpu = 0 '\000', p_lastcpu = 0 '\000', p_rqindex = 12 '\f', p_locks = -15795, p_simple_locks = 0, p_stops = 0, p_stype = 0, p_step = 0 '\000', p_pfsflags = 0 '\000', p_pad3 = "\000", p_retval = {0, 3}, p_sigiolst = {slh_first = 0x0}, p_sigparent = 20, p_oldsigmask = {__bits = {0, 0, 0, 0}}, p_sig = 0, p_code = 0, p_klist = {slh_first = 0x0}, p_sigmask = { __bits = {0, 0, 0, 0}}, p_sigstk = {ss_sp = 0x0, ss_size = 0, ss_flags = 4}, p_priority = 56 '8', p_usrpri = 56 '8', p_nice = 0 '\000', p_comm = "newfs", '\000' , p_pgrp = 0xc1ff8ee0, p_sysent = 0xc0294be0, p_rtprio = { type = 1, prio = 0}, p_prison = 0x0, p_args = 0xc214f0c0, p_addr = 0xd79e7000, p_md = {md_regs = 0xd79e9fa8}, p_xstat = 0, p_acflag = 0, p_ru = 0x0, p_nthreads = 0, p_aioinfo = 0x0, p_wakeup = 0, p_peers = 0x0, p_leader = 0xd796ec20, p_asleep = { as_priority = 0, as_timo = 0}, p_emuldata = 0x0} (kgdb) up #15 0xc0152116 in write (p=0xd796ec20, uap=0xd79e9f80) at ../../kern/sys_generic.c:329 329 error = dofilewrite(p, fp, uap->fd, uap->buf, uap->nbyte, (off_t)-1, 0); (kgdb) print p $24 = (struct proc *) 0xd796ec20 (kgdb) print *p $25 = {p_procq = {tqe_next = 0x0, tqe_prev = 0xc02cafa0}, p_list = {le_next = 0xd796f2a0, le_prev = 0xc02caef8}, p_cred = 0xc2146b00, p_fd = 0xc2051600, p_stats = 0xd79e7cd0, p_limit = 0xc1fde900, p_upages_obj = 0xd79d6cc0, p_procsig = 0xc1ff1d40, p_flag = 16390, p_stat = 2 '\002', p_pad1 = "\000\000", p_pid = 500, p_hash = {le_next = 0x0, le_prev = 0xc1dbafd0}, p_pglist = {le_next = 0x0, le_prev = 0xc1ff8ee8}, p_pptr = 0xd796f2a0, p_sibling = {le_next = 0x0, le_prev = 0xd796f2f0}, p_children = {lh_first = 0x0}, p_ithandle = {callout = 0x0}, p_oppid = 0, p_dupfd = 0, p_vmspace = 0xd798fdc0, p_estcpu = 54, p_cpticks = 17, p_pctcpu = 275, p_wchan = 0x0, p_wmesg = 0xc026858f "physstr", p_swtime = 33, p_slptime = 0, p_realtimer = {it_interval = {tv_sec = 0, tv_usec = 0}, it_value = {tv_sec = 0, tv_usec = 0}}, p_runtime = 4325751, p_uu = 0, p_su = 0, p_iu = 0, p_uticks = 353, p_sticks = 285, p_iticks = 19, p_traceflag = 0, p_tracep = 0x0, p_siglist = {__bits = {0, 0, 0, 0}}, p_textvp = 0xd64c1d80, p_lock = 1 '\001', p_oncpu = 0 '\000', p_lastcpu = 0 '\000', p_rqindex = 12 '\f', p_locks = -15795, p_simple_locks = 0, p_stops = 0, p_stype = 0, p_step = 0 '\000', p_pfsflags = 0 '\000', p_pad3 = "\000", p_retval = {0, 3}, p_sigiolst = {slh_first = 0x0}, p_sigparent = 20, p_oldsigmask = {__bits = {0, 0, 0, 0}}, p_sig = 0, p_code = 0, p_klist = {slh_first = 0x0}, p_sigmask = { __bits = {0, 0, 0, 0}}, p_sigstk = {ss_sp = 0x0, ss_size = 0, ss_flags = 4}, p_priority = 56 '8', p_usrpri = 56 '8', p_nice = 0 '\000', p_comm = "newfs", '\000' , p_pgrp = 0xc1ff8ee0, p_sysent = 0xc0294be0, p_rtprio = { type = 1, prio = 0}, p_prison = 0x0, p_args = 0xc214f0c0, p_addr = 0xd79e7000, p_md = {md_regs = 0xd79e9fa8}, p_xstat = 0, p_acflag = 0, p_ru = 0x0, p_nthreads = 0, p_aioinfo = 0x0, p_wakeup = 0, p_peers = 0x0, p_leader = 0xd796ec20, p_asleep = { as_priority = 0, as_timo = 0}, p_emuldata = 0x0} (kgdb) print fp $26 = (struct file *) 0xc2108440 (kgdb) print *fp $27 = {f_list = {le_next = 0xc2160a80, le_prev = 0xc20922c0}, f_FILLER3 = 0, f_type = 1, f_flag = 2, f_cred = 0xc2097480, f_ops = 0xc029ce40, f_seqcount = 8, f_nextoff = 15825272832, f_offset = 15825272832, f_data = 0xd79a6640 "", f_count = 3, f_msgcount = 0} (kgdb) print uap->fd $28 = 3 (kgdb) print *uap $29 = {fd = 3, fd_ = 0xd79e9f84 "@Ë\006\b", buf = 0x806cb40, buf_ = 0xd79e9f88 "", nbyte = 131072, nbyte_ = 0xd79e9f8c "\003"} (kgdb) up #16 0xc02522c5 in syscall2 (frame={tf_fs = 47, tf_es = 47, tf_ds = 47, tf_edi = 8192, tf_esi = 122880, tf_ebp = -1077940500, tf_isp = -677470252, tf_ebx = 3, tf_edx = 3, tf_ecx = 0, tf_eax = 4, tf_trapno = 7, tf_err = 2, tf_eip = 134621012, tf_cs = 31, tf_eflags = 659, tf_esp = -1077940528, tf_ss = 47}) at ../../i386/i386/trap.c:1157 1157 error = (*callp->sy_call)(p, args); (kgdb) print p $30 = (struct proc *) 0xd796ec20 (kgdb) print *p $31 = {p_procq = {tqe_next = 0x0, tqe_prev = 0xc02cafa0}, p_list = {le_next = 0xd796f2a0, le_prev = 0xc02caef8}, p_cred = 0xc2146b00, p_fd = 0xc2051600, p_stats = 0xd79e7cd0, p_limit = 0xc1fde900, p_upages_obj = 0xd79d6cc0, p_procsig = 0xc1ff1d40, p_flag = 16390, p_stat = 2 '\002', p_pad1 = "\000\000", p_pid = 500, p_hash = {le_next = 0x0, le_prev = 0xc1dbafd0}, p_pglist = {le_next = 0x0, le_prev = 0xc1ff8ee8}, p_pptr = 0xd796f2a0, p_sibling = {le_next = 0x0, le_prev = 0xd796f2f0}, p_children = {lh_first = 0x0}, p_ithandle = {callout = 0x0}, p_oppid = 0, p_dupfd = 0, p_vmspace = 0xd798fdc0, p_estcpu = 54, p_cpticks = 17, p_pctcpu = 275, p_wchan = 0x0, p_wmesg = 0xc026858f "physstr", p_swtime = 33, p_slptime = 0, p_realtimer = {it_interval = {tv_sec = 0, tv_usec = 0}, it_value = {tv_sec = 0, tv_usec = 0}}, p_runtime = 4325751, p_uu = 0, p_su = 0, p_iu = 0, p_uticks = 353, p_sticks = 285, p_iticks = 19, p_traceflag = 0, p_tracep = 0x0, p_siglist = {__bits = {0, 0, 0, 0}}, p_textvp = 0xd64c1d80, p_lock = 1 '\001', p_oncpu = 0 '\000', p_lastcpu = 0 '\000', p_rqindex = 12 '\f', p_locks = -15795, p_simple_locks = 0, p_stops = 0, p_stype = 0, p_step = 0 '\000', p_pfsflags = 0 '\000', p_pad3 = "\000", p_retval = {0, 3}, p_sigiolst = {slh_first = 0x0}, p_sigparent = 20, p_oldsigmask = {__bits = {0, 0, 0, 0}}, p_sig = 0, p_code = 0, p_klist = {slh_first = 0x0}, p_sigmask = { __bits = {0, 0, 0, 0}}, p_sigstk = {ss_sp = 0x0, ss_size = 0, ss_flags = 4}, p_priority = 56 '8', p_usrpri = 56 '8', p_nice = 0 '\000', p_comm = "newfs", '\000' , p_pgrp = 0xc1ff8ee0, p_sysent = 0xc0294be0, p_rtprio = { type = 1, prio = 0}, p_prison = 0x0, p_args = 0xc214f0c0, p_addr = 0xd79e7000, p_md = {md_regs = 0xd79e9fa8}, p_xstat = 0, p_acflag = 0, p_ru = 0x0, p_nthreads = 0, p_aioinfo = 0x0, p_wakeup = 0, p_peers = 0x0, p_leader = 0xd796ec20, p_asleep = { as_priority = 0, as_timo = 0}, p_emuldata = 0x0} >How-To-Repeat: >Fix: >Release-Note: >Audit-Trail: Responsible-Changed-From-To: freebsd-bugs->grog Responsible-Changed-By: grog Responsible-Changed-When: Thu May 2 16:50:19 PDT 2002 Responsible-Changed-Why: grog will process this PR. http://www.freebsd.org/cgi/query-pr.cgi?pr=37675 From: Greg 'groggy' Lehey To: Alson van der Meulen Cc: freebsd-gnats-submit@FreeBSD.org Subject: Re: kern/37675: Page fault when newfs'ing a vinum volume while one of the two plexes is being initialized Date: Fri, 3 May 2002 09:23:16 +0930 [Format recovered--see http://www.lemis.com/email/email-format.html] All paragraphs were on a single line. On Thursday, 2 May 2002 at 11:43:21 -0700, Alson van der Meulen wrote: > >> Number: 37675 >> Category: kern >> Synopsis: Page fault when newfs'ing a vinum volume while one of the two plexes is being initialized >> Confidential: no >> Severity: non-critical >> Priority: low >> Responsible: freebsd-bugs >> State: open >> Quarter: >> Keywords: >> Date-Required: >> Class: sw-bug >> Submitter-Id: current-users >> Arrival-Date: Thu May 02 11:50:02 PDT 2002 >> Closed-Date: >> Last-Modified: >> Originator: Alson van der Meulen >> Release: 4.5-RELEASE-p2 >> Organization: > Montessorischool Waalsdorp >> Environment: > FreeBSD damaged.local.waalsdorp.nl 4.5-RELEASE-p2 FreeBSD 4.5-RELEASE-p2 #2: Sat Mar 23 18:32:08 CET 2002 root@damaged.local.waalsdorp.nl:/usr/src/sys/compile/DAMAGED i386 > >> Description: > I converted a vinum volume from striping to mirroring. After the > data had been backuped, one of the two plexes was up, and the other > was down. > > Sorry if this PR is too verbose, but I'm not sure what information > is important, so I include it all. Well, there's a description of what's needed in vinum(4) or at http://www.vinumvm.org/vinum/how-to-debug.html. You haven't included all the information that's asked for there, though granted you've included stuff we don't need. > I figured I had to initialize the other plex, so I did 'init > raid.p1'. When this was around 60%, I started a newfs on the volume > 'raid'. The kernel paniced a short time after newfs was started. Hmm. This is probably a "don't do that then". There should be an interlock to stop this from happening. > I'm afraid I can't try to reproduce this problem, since I can't > Vinum config (sorry, don't have the vinum config from the time it > crashed, but it was basically the same as the current one, except > that raid.p1 was initializing): > > vinum -> list > 2 drives: > D d1 State: up Device /dev/ad0s1e Avail: 0/78528 MB (0%) > D d2 State: up Device /dev/ad2s1e Avail: 0/78528 MB (0%) > > 1 volumes: > V raid State: up Plexes: 2 Size: 76 GB > > 2 plexes: > P raid.p0 C State: up Subdisks: 1 Size: 76 GB > P raid.p1 C State: up Subdisks: 1 Size: 76 GB > > 2 subdisks: > S raid.p0.s0 State: up PO: 0 B Size: 76 GB > S raid.p1.s0 State: up PO: 0 B Size: 76 GB > > There was probably some configuration error, and I've messed around > a bit with vinum to try to get it to work, so I'm not sure what the > relevant part is here: > Probably none of this in this case. > #0 dumpsys () at ../../kern/kern_shutdown.c:474 > 474 if (dumping++) { > (kgdb) where > #0 dumpsys () at ../../kern/kern_shutdown.c:474 > #1 0xc014351f in boot (howto=256) at ../../kern/kern_shutdown.c:313 > #2 0xc0143919 in panic (fmt=0xc0289aec "%s") at ../../kern/kern_shutdown.c:582 > #3 0xc025200f in trap_fatal (frame=0xd79e9d38, eva=0) at ../../i386/i386/trap.c:956 > #4 0xc0251cbd in trap_pfault (frame=0xd79e9d38, usermode=0, eva=0) at ../../i386/i386/trap.c:849 > #5 0xc0251863 in trap (frame={tf_fs = 16, tf_es = 16, tf_ds = 16, tf_edi = -1038679040, tf_esi = 1, tf_ebp = -677470836, > tf_isp = -677470876, tf_ebx = -1038678496, tf_edx = -1039884288, tf_ecx = 14, tf_eax = 0, tf_trapno = 12, tf_err = 0, > tf_eip = -1041123539, tf_cs = 8, tf_eflags = 66182, tf_esp = -1039884288, tf_ss = -1040259072}) > at ../../i386/i386/trap.c:448 > #6 0xc1f1b72d in ?? () > #7 0xc1f1b552 in ?? () > #8 0xc1f1b3ba in ?? () > #9 0xc013fe63 in physio (dev=0xc1ee1500, uio=0xd79e9ed4, ioflag=524289) at ../../kern/kern_physio.c:111 > #10 0xc017bc5d in spec_write (ap=0xd79e9e64) at ../../miscfs/specfs/spec_vnops.c:283 > (etc) The problem here is that you haven't loaded the symbols for the Vinum module, so we don't even know if this was in Vinum, though the rest of the trace makes it look likely (specifically, while initializing, I would think). The references I gave above explain how to do this. If you still have the dump, it would be interesting to see a full backtrace. > #11 0xc020c364 in ufsspec_write (ap=0xd79e9e64) at ../../ufs/ufs/ufs_vnops.c:1874 > #12 0xc020c981 in ufs_vnoperatespec (ap=0xd79e9e64) at ../../ufs/ufs/ufs_vnops.c:2441 > #13 0xc0177ee6 in vn_write (fp=0xc2108440, uio=0xd79e9ed4, cred=0xc2097480, flags=0, p=0xd796ec20) at vnode_if.h:363 > #14 0xc015225d in dofilewrite (p=0xd796ec20, fp=0xc2108440, fd=3, buf=0x806cb40, nbyte=131072, offset=-1, flags=0) > at ../../sys/file.h:162 > #15 0xc0152116 in write (p=0xd796ec20, uap=0xd79e9f80) at ../../kern/sys_generic.c:329 > #16 0xc02522c5 in syscall2 (frame={tf_fs = 47, tf_es = 47, tf_ds = 47, tf_edi = 8192, tf_esi = 122880, tf_ebp = -1077940500, > tf_isp = -677470252, tf_ebx = 3, tf_edx = 3, tf_ecx = 0, tf_eax = 4, tf_trapno = 7, tf_err = 2, tf_eip = 134621012, > tf_cs = 31, tf_eflags = 659, tf_esp = -1077940528, tf_ss = 47}) at ../../i386/i386/trap.c:1157 > (kgdb) up 9 This is too low down the stack. You really want to be looking at frames 6 to 8, whatever they may be. > #9 0xc013fe63 in physio (dev=0xc1ee1500, uio=0xd79e9ed4, ioflag=524289) at ../../kern/kern_physio.c:111 > 111 BUF_STRATEGY(bp, 0); > (kgdb) print bp > $1 = (struct buf *) 0x1 This looks strange, however. Greg -- When replying to this message, please take care not to mutilate the original text. For more information, see http://www.lemis.com/email.html Finger grog@FreeBSD.org for PGP public key See complete headers for address and phone numbers From: Alson van der Meulen To: Greg 'groggy' Lehey Cc: freebsd-gnats-submit@FreeBSD.org Subject: Re: kern/37675: Page fault when newfs'ing a vinum volume while one of the two plexes is being initialized Date: Fri, 3 May 2002 02:37:59 +0200 Greg 'groggy' Lehey(grog@FreeBSD.org)@2002.05.03 09:23:16 +0000: > On Thursday, 2 May 2002 at 11:43:21 -0700, Alson van der Meulen wrote: > > > >> Number: 37675 > >> Category: kern > >> Synopsis: Page fault when newfs'ing a vinum volume while one of = the two plexes is being initialized > >> Confidential: no > >> Severity: non-critical > >> Priority: low > >> Responsible: freebsd-bugs > >> State: open > >> Quarter: > >> Keywords: > >> Date-Required: > >> Class: sw-bug > >> Submitter-Id: current-users > >> Arrival-Date: Thu May 02 11:50:02 PDT 2002 > >> Closed-Date: > >> Last-Modified: > >> Originator: Alson van der Meulen > >> Release: 4.5-RELEASE-p2 > >> Organization: > > Montessorischool Waalsdorp > >> Environment: > > FreeBSD damaged.local.waalsdorp.nl 4.5-RELEASE-p2 FreeBSD 4.5-RELEASE-p= 2 #2: Sat Mar 23 18:32:08 CET 2002 root@damaged.local.waalsdorp.nl:/usr= /src/sys/compile/DAMAGED i386 > > > >> Description: > > I converted a vinum volume from striping to mirroring. After the > > data had been backuped, one of the two plexes was up, and the other > > was down. > > > > Sorry if this PR is too verbose, but I'm not sure what information > > is important, so I include it all. >=20 > Well, there's a description of what's needed in vinum(4) or at > http://www.vinumvm.org/vinum/how-to-debug.html. You haven't included > all the information that's asked for there, though granted you've > included stuff we don't need. The only what's missing is the vinum history as far as I can see, anything else? The vinum history is quite large in that timeframe, since I messed around a bit. It really doesn't contain much more than resetconfig, a few rm's, a create and an init. If you'd really like to see it I won't mind posting it, but I can't exactly explain what I was doing there (more like trying stuff 'till it works). > > > > >=20 > The problem here is that you haven't loaded the symbols for the Vinum > module, so we don't even know if this was in Vinum, though the rest of > the trace makes it look likely (specifically, while initializing, I > would think). The references I gave above explain how to do this. If > you still have the dump, it would be interesting to see a full > backtrace. Backtrace with vinum symbols: Script started on Fri May 3 02:12:37 2002 damaged# gdb -k kernel.debug.23032002 vmcore.0=20 GNU gdb 4.18 Copyright 1998 Free Software Foundation, Inc. GDB is free software, covered by the GNU General Public License, and you are welcome to change it and/or distribute copies of it under certain condition= s. Type "show copying" to see the conditions. There is absolutely no warranty for GDB. Type "show warranty" for details. This GDB was configured as "i386-unknown-freebsd"... IdlePTD at phsyical address 0x00342000 initial pcb at physical address 0x002b4120 panicstr: page fault panic messages: --- Fatal trap 12: page fault while in kernel mode fault virtual address =3D 0x0 fault code =3D supervisor read, page not present instruction pointer =3D 0x8:0xc1f1b72d stack pointer =3D 0x10:0xd79e9d78 frame pointer =3D 0x10:0xd79e9d8c code segment =3D base 0x0, limit 0xfffff, type 0x1b =3D DPL 0, pres 1, def32 1, gran 1 processor eflags =3D interrupt enabled, resume, IOPL =3D 0 current process =3D 500 (newfs) interrupt mask =3D none trap number =3D 12 panic: page fault syncing disks... 6=20 done Uptime: 22m10s dumping to dev #ad/0x20021, offset 1048736 dump ata2: resetting devices .. done 511 510 509 508 507 506 505 504 503 502 501 500 499 498 497 496 495 494 493= 492 491 490 489 488 487 486 485 484 483 482 481 480 479 478 477 476 475 47= 4 473 472 471 470 469 468 467 466 465 464 463 462 461 460 459 458 457 456 4= 55 454 453 452 451 450 449 448 447 446 445 444 443 442 441 440 439 438 437 = 436 435 434 433 432 431 430 429 428 427 426 425 424 423 422 421 420 419 418= 417 416 415 414 413 412 411 410 409 408 407 406 405 404 403 402 401 400 39= 9 398 397 396 395 394 393 392 391 390 389 388 387 386 385 384 383 382 381 3= 80 379 378 377 376 375 374 373 372 371 370 369 368 367 366 365 364 363 362 = 361 360 359 358 357 356 355 354 353 352 351 350 349 348 347 346 345 344 343= 342 341 [CTRL-C to abort] 340 339 338 337 336 335 334 333 332 331 330 329 = 328 327 326 325 324 323 322 321 320 319 318 317 316 315 314 313 312 311 310= 309 308 307 306 305 304 303 302 301 300 299 298 297 296 295 294 293 292 29= 1 290 289 288 287 286 285 284 283 282 281 280 279 278 277 276 275 274 273 2= 72 271 270 269 268 267 266 265 264 263 262 261 260 259 258 257 256 255 254 = 253 252 251 250 249 248 247 246 245 244 243 242 241 240 239 238 237 236 235= 234 233 232 231 230 229 228 227 226 225 224 223 222 221 220 219 218 217 21= 6 215 214 213 212 211 210 209 208 207 206 205 204 203 202 201 200 199 198 1= 97 196 195 194 193 192 191 190 189 188 187 186 185 184 183 182 181 180 179 = 178 177 176 175 174 173 172 171 170 169 168 167 166 165 164 163 162 161 160= 159 158 157 156 155 154 153 152 151 150 149 148 147 146 145 144 143 142 14= 1 140 139 138 137 136 135 134 133 132 131 130 129 128 127 126 125 124 123 1= 22 121 120 119 118 117 116 115 114 113 112 111 110 109 108 107 106 105 104 = 103 102 101 100 99 98 97 96 95 94 93 92 91 90 89 88 87 86 85 84 83 82 81 80= 79 78 77 76 75 74 73 72 71 70 69 68 67 66 65 64 63 62 61 60 59 58 57 56 55= 54 53 52 51 50 49 48 47 46 45 44 43 42 41 40 39 38 37 36 35 34 33 32 31 30= 29 28 27 26 25 24 23 22 21 20 19 18 17 16 15 14 13 12 11 10 9 8 7 6 5 4 3 = 2 1 0=20 --- #0 dumpsys () at ../../kern/kern_shutdown.c:474 474 if (dumping++) { (kgdb) where #0 dumpsys () at ../../kern/kern_shutdown.c:474 #1 0xc014351f in boot (howto=3D0x100) at ../../kern/kern_shutdown.c:313 #2 0xc0143919 in panic (fmt=3D0xc0289aec "%s") at ../../kern/kern_shutdown= .c:582 #3 0xc025200f in trap_fatal (frame=3D0xd79e9d38, eva=3D0x0) at ../../i386/= i386/trap.c:956 #4 0xc0251cbd in trap_pfault (frame=3D0xd79e9d38, usermode=3D0x0, eva=3D0x= 0) at ../../i386/i386/trap.c:849 #5 0xc0251863 in trap (frame=3D{tf_fs =3D 0x10, tf_es =3D 0x10, tf_ds =3D = 0x10, tf_edi =3D 0xc2170400, tf_esi =3D 0x1,=20 tf_ebp =3D 0xd79e9d8c, tf_isp =3D 0xd79e9d64, tf_ebx =3D 0xc2170620, = tf_edx =3D 0xc204a000, tf_ecx =3D 0xe, tf_eax =3D 0x0,=20 tf_trapno =3D 0xc, tf_err =3D 0x0, tf_eip =3D 0xc1f1b72d, tf_cs =3D 0= x8, tf_eflags =3D 0x10286, tf_esp =3D 0xc204a000,=20 tf_ss =3D 0xc1fee800}) at ../../i386/i386/trap.c:448 #6 0xc1f1b72d in launch_requests (rq=3D0xc20a47c0, reviveok=3D0x0) at /usr/src/sys/modules/vinum/../../dev/vinum/vinumrequest.c:396 #7 0xc1f1b552 in vinumstart (bp=3D0xcc5168d4, reviveok=3D0x0) at /usr/src/sys/modules/vinum/../../dev/vinum/vinumrequest.c:291 #8 0xc1f1b3ba in vinumstrategy (bp=3D0xcc5168d4) at /usr/src/sys/modules/v= inum/../../dev/vinum/vinumrequest.c:164 #9 0xc013fe63 in physio (dev=3D0xc1ee1500, uio=3D0xd79e9ed4, ioflag=3D0x80= 001) at ../../kern/kern_physio.c:111 #10 0xc017bc5d in spec_write (ap=3D0xd79e9e64) at ../../miscfs/specfs/spec_= vnops.c:283 #11 0xc020c364 in ufsspec_write (ap=3D0xd79e9e64) at ../../ufs/ufs/ufs_vnop= s.c:1874 #12 0xc020c981 in ufs_vnoperatespec (ap=3D0xd79e9e64) at ../../ufs/ufs/ufs_= vnops.c:2441 #13 0xc0177ee6 in vn_write (fp=3D0xc2108440, uio=3D0xd79e9ed4, cred=3D0xc20= 97480, flags=3D0x0, p=3D0xd796ec20) at vnode_if.h:363 #14 0xc015225d in dofilewrite (p=3D0xd796ec20, fp=3D0xc2108440, fd=3D0x3, b= uf=3D0x806cb40, nbyte=3D0x20000,=20 offset=3D0xffffffffffffffff, flags=3D0x0) at ../../sys/file.h:162 #15 0xc0152116 in write (p=3D0xd796ec20, uap=3D0xd79e9f80) at ../../kern/sy= s_generic.c:329 #16 0xc02522c5 in syscall2 (frame=3D{tf_fs =3D 0x2f, tf_es =3D 0x2f, tf_ds = =3D 0x2f, tf_edi =3D 0x2000, tf_esi =3D 0x1e000,=20 tf_ebp =3D 0xbfbfeeec, tf_isp =3D 0xd79e9fd4, tf_ebx =3D 0x3, tf_edx = =3D 0x3, tf_ecx =3D 0x0, tf_eax =3D 0x4,=20 tf_trapno =3D 0x7, tf_err =3D 0x2, tf_eip =3D 0x8062754, tf_cs =3D 0x= 1f, tf_eflags =3D 0x293, tf_esp =3D 0xbfbfeed0,=20 tf_ss =3D 0x2f}) at ../../i386/i386/trap.c:1157 #17 0xc0245f35 in Xint0x80_syscall () #18 0x804c9d5 in ?? () #19 0x804b86d in ?? () #20 0x804b29d in ?? () #21 0x8049213 in ?? () #22 0x8048135 in ?? () (kgdb) f 1 #1 0xc014351f in boot (howto=3D0x100) at ../../kern/kern_shutdown.c:313 313 dumpsys(); (kgdb) up 5 #6 0xc1f1b72d in launch_requests (rq=3D0xc20a47c0, reviveok=3D0x0) at /usr/src/sys/modules/vinum/../../dev/vinum/vinumrequest.c:396 396 rqg->lock =3D lockrange(rqg->lockbase, rqg->rq->bp, &PLEX[rqg->ple= xno]); (kgdb) print rqg $1 =3D (struct rqgroup *) 0xc2170400 (kgdb) print *rqg $2 =3D { next =3D 0xc2170600,=20 rq =3D 0x0,=20 count =3D 0x0,=20 active =3D 0x0,=20 plexno =3D 0x0,=20 badsdno =3D 0x0,=20 flags =3D 0,=20 lock =3D 0x0,=20 lockbase =3D 0x0,=20 rqe =3D 0xc2170420 } (kgdb) up #7 0xc1f1b552 in vinumstart (bp=3D0xcc5168d4, reviveok=3D0x0) at /usr/src/sys/modules/vinum/../../dev/vinum/vinumrequest.c:291 291 return launch_requests(rq, reviveok); /* now start the requests i= f we can */ (kgdb) print rq $3 =3D (struct request *) 0xc20a47c0 (kgdb) print *rq $4 =3D { bp =3D 0xc21608c0,=20 flags =3D 0,=20 volplex =3D { volno =3D 0x0,=20 plexno =3D 0x0 },=20 error =3D 0x0,=20 sdno =3D 0x0,=20 isplex =3D 0x0,=20 active =3D 0x0,=20 rqg =3D 0x0,=20 lrqg =3D 0x0,=20 next =3D 0x0 } (kgdb) up #8 0xc1f1b3ba in vinumstrategy (bp=3D0xcc5168d4) at /usr/src/sys/modules/v= inum/../../dev/vinum/vinumrequest.c:164 164 vinumstart(bp, 0); (kgdb) print bp $5 =3D (struct buf *) 0xcc5168d4 (kgdb) print *bp $6 =3D { b_hash =3D { le_next =3D 0x0,=20 le_prev =3D 0x0 },=20 b_vnbufs =3D { tqe_next =3D 0x0,=20 tqe_prev =3D 0x0 },=20 b_freelist =3D { tqe_next =3D 0xcc516788,=20 tqe_prev =3D 0xc02cb444 },=20 b_act =3D { tqe_next =3D 0x0,=20 tqe_prev =3D 0xc1edcca8 },=20 b_flags =3D 0x40200,=20 b_qindex =3D 0x0,=20 b_xflags =3D 0x0,=20 b_lock =3D { lk_interlock =3D { lock_data =3D 0x0 },=20 lk_flags =3D 0x400,=20 lk_sharecount =3D 0x0,=20 lk_waitcount =3D 0x0,=20 lk_exclusivecount =3D 0x1,=20 lk_prio =3D 0x14,=20 lk_wmesg =3D 0xc026bb30 "bufwait",=20 lk_timo =3D 0x0,=20 lk_lockholder =3D 0x1f4 },=20 b_error =3D 0x0,=20 b_bufsize =3D 0x10000,=20 b_runningbufspace =3D 0x0,=20 b_bcount =3D 0x10000,=20 b_resid =3D 0x0,=20 b_dev =3D 0xc1ee1500,=20 b_data =3D 0xd2382b40 "",=20 b_kvabase =3D 0xd2382000 "{",=20 b_kvasize =3D 0x20000,=20 b_lblkno =3D 0x48f4c0,=20 b_blkno =3D 0x1d7a140,=20 b_offset =3D 0x3af428000,=20 b_iodone =3D 0xc013fcb8 ,=20 b_iodone_chain =3D 0x0,=20 b_vp =3D 0x0,=20 b_dirtyoff =3D 0x0,=20 b_dirtyend =3D 0x0,=20 b_rcred =3D 0x0,=20 b_wcred =3D 0x0,=20 b_pblkno =3D 0x1d7a140,=20 b_saveaddr =3D 0x806cb40,=20 b_driver1 =3D 0x0,=20 b_driver2 =3D 0x0,=20 b_caller1 =3D 0x0,=20 b_caller2 =3D 0x0,=20 b_pager =3D { pg_spc =3D 0x0,=20 pg_reqpage =3D 0x0 },=20 b_cluster =3D { cluster_head =3D { tqh_first =3D 0xcc54de98,=20 tqh_last =3D 0xcc54e098 },=20 cluster_entry =3D { tqe_next =3D 0xcc54de98,=20 ---Type to continue, or q to quit--- tqe_prev =3D 0xcc54e098 } },=20 b_pages =3D {0xc06fa764, 0xc0702720, 0xc07001dc, 0xc0702f18, 0xc070a754, = 0xc0705510, 0xc07002cc, 0xc06fa908,=20 0xc06ecfc4, 0xc06dc980, 0xc06fcf3c, 0xc06ef5f8, 0xc06f0534, 0xc06deff0,= 0xc06e8dac, 0xc06f8ce8, 0xc06e5224,=20 0x0 },=20 b_npages =3D 0x11,=20 b_dep =3D { lh_first =3D 0x0 },=20 b_chain =3D { parent =3D 0x0,=20 count =3D 0x0 } } (kgdb) quit damaged# exit Script done on Fri May 3 02:19:25 2002 If you need more information from that dump let me know, but it's just hard for a non-developer to tell what's really important here. Alson Responsible-Changed-From-To: grog->le Responsible-Changed-By: linimon Responsible-Changed-When: Thu Sep 9 19:10:20 GMT 2004 Responsible-Changed-Why: With permission of both, reassign from grog to le. http://www.freebsd.org/cgi/query-pr.cgi?pr=37675 State-Changed-From-To: open->closed State-Changed-By: le State-Changed-When: Sat Nov 26 15:04:20 GMT 2005 State-Changed-Why: "Classic" vinum in FreeBSD 4.x isn't supported anymore, so I'm closing this PR. If this also happens in FreeBSD 5.x/6.x with geom_vinum (which hasn't been the case yet), a new PR can be opened. http://www.freebsd.org/cgi/query-pr.cgi?pr=37675 >Unformatted: