-- After the oops the kernel hanged. The NMI watchdog detected this lockup and the system booted into the capture kernel successfully. Despite of this the result of this test is marked with an X, because an oops that causes a lockup should be a panic not an oops. nexus:~# modprobe dtt Kernel Hooks Interface installed. 8 compiled-in crash points registered Crash dump test tools' module successfully loaded nexus:~# /home/fewy/tests/kexec-tools-1.101/objdir/build/sbin/kexec -p /home/fewy/tests/linux-2.6.17-rc4-cptr/vmlinux --args-linux --append="root=/dev/sda1 init 1 irqpoll console=ttyS0,38400 console=tty0" nexus:~# ttutils set -p TIMERADD -t bug [crash point set] name:TIMERADD type:bug count:10 nexus:~# logout TRIG_BUG ------------[ cut here ]------------ kernel BUG at drivers/dtt/khdtt.c:311! invalid opcode: 0000 [#1] PREEMPT SMP Modules linked in: dtt hook ipv6 ext3 jbd rtc eth1394 ide_cd cdrom snd_intel8x0 snd_ac97_codec snd_ac97_bus ohci1394 ieee1394 psmouse snd_pcm piix ehci_hcd i2c_i801 snd_timer snd soundcore snd_page_alloc ide_core evdev hw_random uhci_hcd usbcore CPU: 0 EIP: 0060:[] Not tainted VLI EFLAGS: 00010096 (2.6.17-rc4-dtt #2) EIP is at cpoint_default_exit+0x7f/0x8d [dtt] eax: 0000000c ebx: c3806970 ecx: c03075c0 edx: 00000001 esi: c3806970 edi: f78f1588 ebp: 00000000 esp: f7a9fed8 ds: 007b es: 007b ss: 0068 Process getty (pid: 1770, threadinfo=f7a9f000 task=c3ab0a50) Stack: <0>f8aca5fe c0132435 c0309740 50891b40 00000010 00000013 00000000 f7a9ffa8 c3ab0a50 f78f1588 c01207a4 f78f1588 8c23e540 00000010 00000001 f7a9f000 c016f2be 00000000 f7af7f2c 00000000 c0170cc4 f74028c0 f7af7f2c 00000010 Call Trace: TIMERADD_hook+0x48/0x4e do_setitimer+0x5c3/0x61c locks_free_lock+0x36/0x59 fcntl_setlk+0x44/0x2a0 _spin_unlock_irq+0xe/0x22 do_sigaction+0xed/0x199 sys_rt_sigaction+0x6d/0xa0 alarm_setitimer+0x49/0x77 sysenter_past_esp+0x54/0x75 Code: c3 c7 04 24 1c a6 ac f8 e8 82 3e 65 c7 eb fe c7 05 00 00 00 00 00 00 00 00 31 c0 83 c4 04 c3 c7 04 24 fe a5 ac f8 e8 64 3e 65 c7 <0f> 0b 37 01 08 a6 ac f8 31 c0 83 c4 04 c3 55 57 56 53 83 ec 18 EIP: [] cpoint_default_exit+0x7f/0x8d [dtt] SS:ESP 0068:f7a9fed8 <6>note: getty[1770] exited with preempt_count 1 BUG: scheduling while atomic: getty/0x00000001/1770 schedule+0xd11/0xd23 free_hot_cold_page+0xde/0x126 __pagevec_free+0x22/0x31 release_pages+0x33/0x1b7 __down+0xd3/0xf5 default_wake_function+0x0/0x15 __down_failed+0x7/0xc .text.lock.kernel_lock+0x1b/0x37 tty_release+0x5/0x16 __fput+0xa9/0x1aa filp_close+0x49/0x6d put_files_struct+0x82/0xcc do_exit+0x13b/0x916 printk+0x1b/0x1f do_simd_coprocessor_error+0x0/0x1b2 do_invalid_op+0x0/0xb4 do_invalid_op+0xab/0xb4 cpoint_default_exit+0x7f/0x8d [dtt] _spin_unlock_irqrestore+0xf/0x23 release_console_sem+0x1ac/0x1eb vprintk+0x1f5/0x380 getnstimeofday+0x14/0x37 do_gettimeofday+0x19/0xc6 error_code+0x4f/0x54 cpoint_default_exit+0x7f/0x8d [dtt] TIMERADD_hook+0x48/0x4e do_setitimer+0x5c3/0x61c locks_free_lock+0x36/0x59 fcntl_setlk+0x44/0x2a0 _spin_unlock_irq+0xe/0x22 do_sigaction+0xed/0x199 sys_rt_sigaction+0x6d/0xa0 alarm_setitimer+0x49/0x77 sysenter_past_esp+0x54/0x75 BUG: scheduling while atomic: getty/0x00000001/1770 schedule+0xd11/0xd23 __down+0xd3/0xf5 default_wake_function+0x0/0x15 __down_failed+0x7/0xc .text.lock.kernel_lock+0x1b/0x37 tty_release+0x5/0x16 __fput+0xa9/0x1aa filp_close+0x49/0x6d put_files_struct+0x82/0xcc do_exit+0x13b/0x916 printk+0x1b/0x1f do_simd_coprocessor_error+0x0/0x1b2 do_invalid_op+0x0/0xb4 do_invalid_op+0xab/0xb4 cpoint_default_exit+0x7f/0x8d [dtt] _spin_unlock_irqrestore+0xf/0x23 release_console_sem+0x1ac/0x1eb vprintk+0x1f5/0x380 getnstimeofday+0x14/0x37 do_gettimeofday+0x19/0xc6 error_code+0x4f/0x54 cpoint_default_exit+0x7f/0x8d [dtt] TIMERADD_hook+0x48/0x4e do_setitimer+0x5c3/0x61c locks_free_lock+0x36/0x59 fcntl_setlk+0x44/0x2a0 _spin_unlock_irq+0xe/0x22 do_sigaction+0xed/0x199 sys_rt_sigaction+0x6d/0xa0 alarm_setitimer+0x49/0x77 sysenter_past_esp+0x54/0x75 BUG: NMI Watchdog detected LOCKUP on CPU1, eip c02c1e32, registers: Modules linked in: dtt hook ipv6 ext3 jbd rtc eth1394 ide_cd cdrom snd_intel8x0 snd_ac97_codec snd_ac97_bus ohci1394 ieee1394 psmouse snd_pcm piix ehci_hcd i2c_i801 snd_timer snd soundcore snd_page_alloc ide_core evdev hw_random uhci_hcd usbcore CPU: 1 EIP: 0060:[] Not tainted VLI EFLAGS: 00000002 (2.6.17-rc4-dtt #2) EIP is at _spin_lock+0x50/0x65 eax: 00000001 ebx: f79cdfc4 ecx: 00000001 edx: 00000001 esi: f78f1540 edi: c3ab0a50 ebp: f79cdfc4 esp: c3924f00 ds: 007b es: 007b ss: 0068 Process init (pid: 1, threadinfo=c3924000 task=c3923a50) Stack: <0>c3ab0a50 c011e3e2 c3ab0a50 00000000 c3ab0eec 00000000 f79cdac0 c3ab0a50 c3ab0b08 000006ea 00000005 c011fc65 c3ab0a50 2fb52e90 446b5b0a 2fb52e90 00000000 c3923b00 00000000 ffffffff c3923a50 00000001 c3924e58 c3924e5c Call Trace: release_task+0x94/0x34e do_wait+0x805/0xad4 default_wake_function+0x0/0x15 sys_wait4+0x35/0x39 sys_waitpid+0x27/0x2b sysenter_past_esp+0x54/0x75 Code: 3f e5 ff b8 00 f0 ff ff 21 e0 8b 40 08 a8 08 75 27 8b 43 04 85 c0 75 07 c7 43 04 01 00 00 00 0f b6 03 84 c0 7f b8 8b 43 04 85 c0 <74> b1 f3 90 0f b6 03 84 c0 7e f0 eb a6 90 e8 13 f2 ff ff eb d1 console shuts up ... Linux version 2.6.17-rc4-cptr (fewy@nexus) (gcc version 4.0.4 20060507 (prerelease) (Debian 4.0.3-3)) #1 PREEMPT Tue May 16 15:06:50 JST 2006 BIOS-provided physical RAM map: BIOS-e820: 0000000000000100 - 000000000009f800 (usable) BIOS-e820: 000000000009f800 - 00000000000a0000 (reserved) BIOS-e820: 0000000000100000 - 000000003fee0000 (usable) BIOS-e820: 000000003fee0000 - 000000003fee3000 (ACPI NVS) BIOS-e820: 000000003fee3000 - 000000003fef0000 (ACPI data) BIOS-e820: 000000003fef0000 - 000000003ff00000 (reserved) BIOS-e820: 00000000fec00000 - 0000000100000000 (reserved) user-defined physical RAM map: user: 0000000000000000 - 00000000000a0000 (usable) user: 0000000001000000 - 0000000001291000 (usable) user: 0000000001331400 - 0000000003000000 (usable) 0MB HIGHMEM available. 48MB LOWMEM available. found SMP MP-table at 000f5750 DMI 2.3 present. ACPI: PM-Timer IO Port: 0x408 ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) Processor #0 15:2 APIC version 20 ACPI: LAPIC (acpi_id[0x01] lapic_id[0x06] enabled) Processor #6 15:2 APIC version 20 WARNING: NR_CPUS limit of 1 reached. Processor ignored. ACPI: LAPIC (acpi_id[0x02] lapic_id[0x07] enabled) Processor #7 15:2 APIC version 20 WARNING: NR_CPUS limit of 1 reached. Processor ignored. ACPI: LAPIC (acpi_id[0x03] lapic_id[0x01] enabled) Processor #1 15:2 APIC version 20 WARNING: NR_CPUS limit of 1 reached. Processor ignored. ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1]) ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1]) ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1]) ACPI: IOAPIC (id[0x04] address[0xfec00000] gsi_base[0]) IOAPIC[0]: apic_id 4, version 32, address 0xfec00000, GSI 0-23 ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Enabling APIC mode: Flat. Using 1 I/O APICs Using ACPI (MADT) for SMP configuration information Allocating PCI resources starting at 10000000 (gap: 03000000:fd000000) Built 1 zonelists Kernel command line: root=/dev/sda1 init 1 irqpoll console=ttyS0,38400 console=tty0 memmap=exactmap memmap=640K@0K memmap=2628K@16384K memmap=29499K@19653K elfcorehdr=19652K Misrouted IRQ fixup and polling support enabled This may significantly impact system performance Enabling fast FPU save and restore... done. Enabling unmasked SIMD FPU exception support... done. Initializing CPU#0 CPU 0 irqstacks, hard=c1255000 soft=c1256000 PID hash table entries: 256 (order: 8, 1024 bytes) Detected 2405.413 MHz processor. Using pmtmr for high-res timesource Console: colour VGA+ 80x25 Uhhuh. NMI received for unknown reason 3d on CPU 0. Dazed and confused, but trying to continue Do you have a strange power saving mode enabled? unexpected IRQ trap at vector 11 Dentry cache hash table entries: 8192 (order: 3, 32768 bytes) Inode-cache hash table entries: 4096 (order: 2, 16384 bytes) Memory: 29676k/49152k available (1672k kernel code, 3068k reserved, 532k data, 156k init, 0k highmem) Checking if this processor honours the WP bit even in supervisor mode... Ok. Calibrating delay using timer specific routine.. 4815.59 BogoMIPS (lpj=2407795) Mount-cache hash table entries: 512 CPU: Trace cache: 12K uops, L1 D cache: 8K CPU: L2 cache: 512K Intel machine check architecture supported. Intel machine check reporting enabled on CPU#0. CPU0: Intel P4/Xeon Extended MCE MSRs (12) available CPU0: Thermal monitoring enabled CPU: Intel(R) Xeon(TM) CPU 2.40GHz stepping 05 Checking 'hlt' instruction... OK. SMP alternatives: switching to UP code Freeing SMP alternatives: 0k freed ENABLING IO-APIC IRQs ..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1 NET: Registered protocol family 16 ACPI: bus type pci registered PCI: PCI BIOS revision 2.10 entry at 0xfb7f0, last bus=3 Setting up standard PCI resources ACPI: Subsystem revision 20060127 ACPI: Interpreter enabled ACPI: Using IOAPIC for interrupt routing ACPI: PCI Root Bridge [PCI0] (0000:00) PCI quirk: region 0400-047f claimed by ICH4 ACPI/GPIO/TCO PCI quirk: region 0480-04bf claimed by ICH4 GPIO PCI: Ignoring BAR0-3 of IDE controller 0000:00:1f.1 PCI: Transparent bridge - 0000:00:1e.0 ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 *5 7 9 10 11 12 14 15), disabled. ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 7 *9 10 11 12 14 15), disabled. ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 7 9 10 *11 12 14 15), disabled. ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 7 *9 10 11 12 14 15), disabled. ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 7 9 10 *11 12 14 15), disabled. ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LNK0] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LNK1] (IRQs 3 4 *5 7 9 10 11 12 14 15), disabled. SCSI subsystem initialized PCI: Using ACPI for IRQ routing PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report PCI: Bridge: 0000:00:01.0 IO window: disabled. MEM window: f8000000-f9ffffff PREFETCH window: e0000000-efffffff PCI: Bridge: 0000:00:03.0 IO window: a000-afff MEM window: fa000000-fa0fffff PREFETCH window: disabled. PCI: Bridge: 0000:00:1e.0 IO window: disabled. MEM window: fa100000-fa1fffff PREFETCH window: disabled. NET: Registered protocol family 2 IP route cache hash table entries: 512 (order: -1, 2048 bytes) TCP established hash table entries: 2048 (order: 1, 8192 bytes) TCP bind hash table entries: 1024 (order: 0, 4096 bytes) TCP: Hash tables configured (established 2048 bind 1024) TCP reno registered Initializing Cryptographic API io scheduler noop registered io scheduler anticipatory registered (default) io scheduler deadline registered io scheduler cfq registered Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A Intel(R) PRO/1000 Network Driver - version 7.0.33-k2-NAPI Copyright (c) 1999-2005 Intel Corporation. ACPI: PCI Interrupt 0000:02:01.0[A] -> GSI 18 (level, low) -> IRQ 16 e1000: 0000:02:01.0: e1000_probe: (PCI:33MHz:32-bit) 00:11:2f:e3:60:5c e1000: eth0: e1000_probe: Intel(R) PRO/1000 Network Connection ata_piix 0000:00:1f.2: MAP [ P0 -- P1 -- ] ACPI: PCI Interrupt 0000:00:1f.2[A] -> GSI 18 (level, low) -> IRQ 16 ata1: SATA max UDMA/133 cmd 0xC000 ctl 0xC402 bmdma 0xD000 irq 16 ata2: SATA max UDMA/133 cmd 0xC800 ctl 0xCC02 bmdma 0xD008 irq 16 ata1: dev 0 ATA-7, max UDMA/133, 320173056 sectors: LBA48 ata1: dev 0 configured for UDMA/133 scsi0 : ata_piix ata2: dev 0 ATA-6, max UDMA/133, 156301488 sectors: LBA48 ata2: dev 0 configured for UDMA/133 scsi1 : ata_piix Vendor: ATA Model: Maxtor 6Y160M0 Rev: YAR5 Type: Direct-Access ANSI SCSI revision: 05 Vendor: ATA Model: ST380817AS Rev: 3.42 Type: Direct-Access ANSI SCSI revision: 05 SCSI device sda: 320173056 512-byte hdwr sectors (163929 MB) sda: Write Protect is off SCSI device sda: drive cache: write back SCSI device sda: 320173056 512-byte hdwr sectors (163929 MB) sda: Write Protect is off SCSI device sda: drive cache: write back sda: sda1 sda2 sda3 sda4 < sda5 sda6 > sd 0:0:0:0: Attached scsi disk sda SCSI device sdb: 156301488 512-byte hdwr sectors (80026 MB) sdb: Write Protect is off SCSI device sdb: drive cache: write back SCSI device sdb: 156301488 512-byte hdwr sectors (80026 MB) sdb: Write Protect is off SCSI device sdb: drive cache: write back sdb: sdb1 sdb2 sd 1:0:0:0: Attached scsi disk sdb serio: i8042 AUX port at 0x60,0x64 irq 12 serio: i8042 KBD port at 0x60,0x64 irq 1 mice: PS/2 mouse device common for all mice TCP bic registered NET: Registered protocol family 1 Using IPI Shortcut mode ACPI wakeup devices: SLPB PCI0 CSAD HUB0 UAR1 UAR2 USB0 USB1 USB2 USB3 USBE MODM ACPI: (supports S0 S1 S3 S4 S5) ReiserFS: sda1: found reiserfs format "3.6" with standard journal input: AT Translated Set 2 keyboard as /class/input/input0 ReiserFS: sda1: using ordered data mode ReiserFS: sda1: journal params: device sda1, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 ReiserFS: sda1: checking transaction log (sda1) ReiserFS: sda1: replayed 10 transactions in 0 seconds ReiserFS: sda1: Using r5 hash to sort names VFS: Mounted root (reiserfs filesystem) readonly. Freeing unused kernel memory: 156k freed Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx usbcore: registered new driver usbfs usbcore: registered new driver hub ACPI: PCI Interrupt 0000:00:1d.7[D] -> <6>USB Universal Host Controller Interface driver v3.0 GSI 23 (level, low) -> IRQ 17 ehci_hcd 0000:00:1d.7: EHCI Host Controller ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1 ehci_hcd 0000:00:1d.7: irq 17, io mem 0xfa200000 ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 usb usb1: configuration #1 chosen from 1 choice hub 1-0:1.0: USB hub found hub 1-0:1.0: 8 ports detected hw_random hardware driver 1.0.0 loaded ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 16 (level, low) -> IRQ 18 uhci_hcd 0000:00:1d.0: UHCI Host Controller uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 uhci_hcd 0000:00:1d.0: irq 18, io base 0x0000b000 usb usb2: configuration #1 chosen from 1 choice hub 2-0:1.0: USB hub found hub 2-0:1.0: 2 ports detected ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19 uhci_hcd 0000:00:1d.1: UHCI Host Controller uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000b400 usb usb3: configuration #1 chosen from 1 choice hub 3-0:1.0: USB hub found hub 3-0:1.0: 2 ports detected ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 16 uhci_hcd 0000:00:1d.2: UHCI Host Controller uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 uhci_hcd 0000:00:1d.2: irq 16, io base 0x0000b800 usb usb4: configuration #1 chosen from 1 choice hub 4-0:1.0: USB hub found hub 4-0:1.0: 2 ports detected ACPI: PCI Interrupt 0000:00:1d.3[A] -> GSI 16 (level, low) -> IRQ 18 uhci_hcd 0000:00:1d.3: UHCI Host Controller uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5 uhci_hcd 0000:00:1d.3: irq 18, io base 0x0000bc00 usb usb5: configuration #1 chosen from 1 choice hub 5-0:1.0: USB hub found hub 5-0:1.0: 2 ports detected input: ImExPS/2 Generic Explorer Mouse as /class/input/input1 ICH5: IDE controller at PCI slot 0000:00:1f.1 ACPI: PCI Interrupt 0000:00:1f.1[A] -> GSI 18 (level, low) -> IRQ 16 ICH5: chipset revision 2 ICH5: not 100% native mode: will probe irqs later ide0: BM-DMA at 0xf000-0xf007, BIOS settings: hda:DMA, hdb:pio ide1: BM-DMA at 0xf008-0xf00f, BIOS settings: hdc:DMA, hdd:pio hdc: PLEXTOR DVDR PX-712A, ATAPI CD/DVD-ROM drive ide1 at 0x170-0x177,0x376 on irq 15 ACPI: PCI Interrupt 0000:00:1f.5[B] -> GSI 17 (level, low) -> IRQ 20 intel8x0_measure_ac97_clock: measured 50060 usecs intel8x0: clocking to 48000 ACPI: PCI Interrupt 0000:03:03.0[A] -> GSI 20 (level, low) -> IRQ 21 ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[21] MMIO=[fa104000-fa1047ff] Max Packet=[2048] IR/IT contexts=[4/8] hdc: ATAPI 94X DVD-ROM DVD-R CD-R/RW drive, 8192kB Cache, UDMA(33) Uniform CD-ROM driver Revision: 3.20 Adding 1076312k swap on /dev/sda5. Priority:-1 extents:1 across:1076312k eth1394: eth1: IEEE-1394 IPv4 over 1394 Ethernet (fw-host0) Real Time Clock Driver v1.12ac kjournald starting. Commit interval 5 seconds EXT3 FS on sda2, internal journal EXT3-fs: recovery complete. EXT3-fs: mounted filesystem with ordered data mode. e1000: eth0: e1000_watchdog_task: NIC Link is Up 1000 Mbps Full Duplex NET: Registered protocol family 10 IPv6 over IPv4 tunneling driver