Bugzilla – Bug 131508
System hangs on shutdown after showing the shutdown of the service BIND
Last modified: 2005-11-18 10:57:00 UTC
Hi, I made a clean install with SuSE 10.0 and have always problems shutting down the machine. The usual shutdown process starts but hangs after printing the message: Shutting down name server BIND Then I can press enter, get a prompt and sometimes it works to start another shutdown process from here. The problem exists for running 'shutdown -r now', 'shutdown -h now' and pressing the power button. When I try to kick off the second shutdown process I always have to choose another of the three possibilities to shutdown then the first time. IE. I try to shutdown using 'shutdown -r now' but the system hangs as described. Now I can only enter 'shutdown -h now' to force another try which sometimes works. The output in my boot.omesg is: Inspecting /boot/System.map-2.6.13-15-smp Loaded 24953 symbols from /boot/System.map-2.6.13-15-smp. Symbols match kernel version 2.6.13. No module symbols loaded - kernel modules not enabled. klogd 1.4.1, log source = ksyslog started. <5>Linux version 2.6.13-15-smp (geeko@buildhost) (gcc version 4.0.2 20050901 (prerelease) (SUSE Linux)) #1 SMP Tue Sep 13 14:56:15 UTC 2005 <6>BIOS-provided physical RAM map: <4> BIOS-e820: 0000000000000000 - 000000000009fc00 (usable) <4> BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved) <4> BIOS-e820: 00000000000e4000 - 0000000000100000 (reserved) <4> BIOS-e820: 0000000000100000 - 000000003fff0000 (usable) <4> BIOS-e820: 000000003fff0000 - 000000003fffe000 (ACPI data) <4> BIOS-e820: 000000003fffe000 - 0000000040000000 (ACPI NVS) <4> BIOS-e820: 00000000ffb80000 - 0000000100000000 (reserved) <5>127MB HIGHMEM available. <5>896MB LOWMEM available. <6>found SMP MP-table at 000ff780 <7>On node 0 totalpages: 262128 <7> DMA zone: 4096 pages, LIFO batch:1 <7> Normal zone: 225280 pages, LIFO batch:31 <7> HighMem zone: 32752 pages, LIFO batch:15 <6>DMI 2.3 present. <6>Using APIC driver default <7>ACPI: RSDP (v000 ACPIAM ) @ 0x000f6fd0 <7>ACPI: RSDT (v001 A M I OEMRSDT 0x03000502 MSFT 0x00000097) @ 0x3fff0000 <7>ACPI: FADT (v002 A M I OEMFACP 0x03000502 MSFT 0x00000097) @ 0x3fff0200 <7>ACPI: MADT (v001 A M I OEMAPIC 0x03000502 MSFT 0x00000097) @ 0x3fff0390 <7>ACPI: OEMB (v001 A M I OEMBIOS 0x03000502 MSFT 0x00000097) @ 0x3fffe040 <7>ACPI: DSDT (v001 PSCHL PSCHL028 0x00000028 INTL 0x02002026) @ 0x00000000 <6>ACPI: PM-Timer IO Port: 0x808 <7>ACPI: Local APIC address 0xfee00000 <6>ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled) <4>Processor #0 15:2 APIC version 20 <6>ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled) <4>Processor #1 15:2 APIC version 20 <6>ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) <6>ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0]) <4>IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23 <6>ACPI: IOAPIC (id[0x03] address[0xfec10000] gsi_base[24]) <4>IOAPIC[1]: apic_id 3, version 32, address 0xfec10000, GSI 24-47 <6>ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) <6>ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) <7>ACPI: IRQ0 used by override. <7>ACPI: IRQ2 used by override. <7>ACPI: IRQ9 used by override. <4>Enabling APIC mode: Flat. Using 2 I/O APICs <6>Using ACPI (MADT) for SMP configuration information <4>Allocating PCI resources starting at 40000000 (gap: 40000000:bfb80000) <4>Built 1 zonelists <5>Kernel command line: root=/dev/hdb5 vga=773 selinux=0 resume=/dev/hda7 splash=silent showopts <6>bootsplash: silent mode. <6>Initializing CPU#0 <4>PID hash table entries: 4096 (order: 12, 65536 bytes) <4>Detected 2793.518 MHz processor. <6>Using pmtmr for high-res timesource <4>Console: colour dummy device 80x25 <4>Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) <4>Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) <6>Memory: 1032068k/1048512k available (2330k kernel code, 15600k reserved, 750k data, 252k init, 131008k highmem) <4>Checking if this processor honours the WP bit even in supervisor mode... Ok. <4>Calibrating delay using timer specific routine.. 5592.03 BogoMIPS (lpj=11184062) <6>Security Framework v1.0.0 initialized <6>SELinux: Disabled at boot. <4>Mount-cache hash table entries: 512 <7>CPU: After generic identify, caps: bfebfbff 00000000 00000000 00000000 00004400 00000000 00000000 <7>CPU: After vendor identify, caps: bfebfbff 00000000 00000000 00000000 00004400 00000000 00000000 <6>CPU: Trace cache: 12K uops, L1 D cache: 8K <6>CPU: L2 cache: 512K <6>CPU: Physical Processor ID: 0 <7>CPU: After all inits, caps: bfebfbff 00000000 00000000 00000080 00004400 00000000 00000000 <6>Intel machine check architecture supported. <6>Intel machine check reporting enabled on CPU#0. <6>CPU0: Intel P4/Xeon Extended MCE MSRs (12) available <6>CPU0: Thermal monitoring enabled <6>mtrr: v2.0 (20020519) <6>Enabling fast FPU save and restore... done. <6>Enabling unmasked SIMD FPU exception support... done. <6>Checking 'hlt' instruction... OK. <6>checking if image is initramfs... it is <6>Freeing initrd memory: 1723k freed <6>ACPI: Looking for DSDT in initrd... not found! <4> not found! <4>CPU0: Intel(R) Pentium(R) 4 CPU 2.80GHz stepping 09 <4>Booting processor 1/1 eip 3000 <6>Initializing CPU#1 <4>Calibrating delay using timer specific routine.. 5586.44 BogoMIPS (lpj=11172899) <7>CPU: After generic identify, caps: bfebfbff 00000000 00000000 00000000 00004400 00000000 00000000 <7>CPU: After vendor identify, caps: bfebfbff 00000000 00000000 00000000 00004400 00000000 00000000 <6>CPU: Trace cache: 12K uops, L1 D cache: 8K <6>CPU: L2 cache: 512K <6>CPU: Physical Processor ID: 0 <7>CPU: After all inits, caps: bfebfbff 00000000 00000000 00000080 00004400 00000000 00000000 <6>Intel machine check architecture supported. <6>Intel machine check reporting enabled on CPU#1. <6>CPU1: Intel P4/Xeon Extended MCE MSRs (12) available <6>CPU1: Thermal monitoring enabled <4>CPU1: Intel(R) Pentium(R) 4 CPU 2.80GHz stepping 09 <6>Total of 2 processors activated (11178.48 BogoMIPS). <4>ENABLING IO-APIC IRQs <6>..TIMER: vector=0x31 pin1=2 pin2=-1 <6>checking TSC synchronization across 2 CPUs: passed. <6>Brought up 2 CPUs <6>NET: Registered protocol family 16 <6>ACPI: bus type pci registered <6>PCI: PCI BIOS revision 2.10 entry at 0xf0031, last bus=3 <6>PCI: Using configuration type 1 <6>ACPI: Subsystem revision 20050408 <6>ACPI: Interpreter enabled <6>ACPI: Using IOAPIC for interrupt routing <6>ACPI: PCI Root Bridge [PCI0] (0000:00) <4>PCI: Probing PCI hardware (bus 00) <6>ACPI: Assume root bridge [\_SB_.PCI0] segment is 0 <4>EHCI early BIOS handoff failed (BIOS bug ?) <6>PCI: Ignoring BAR0-3 of IDE controller 0000:00:1f.1 <7>Boot video device is 0000:03:03.0 <6>PCI: Transparent bridge - 0000:00:1e.0 <7>ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] <7>ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P4._PRT] <7>ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P5._PRT] <4>ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 *9 10 11 12 14 15) <4>ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 *9 10 11 12 14 15) <4>ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 9 10 11 12 14 15) <4>ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 *10 11 12 14 15) <4>ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 *9 10 11 12 14 15) <4>ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 9 *10 11 12 14 15) <4>ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled. <4>ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 9 10 *11 12 14 15) <6>Linux Plug and Play Support v0.97 (c) Adam Belay <6>pnp: PnP ACPI init <6>pnp: PnP ACPI: found 13 devices <6>PCI: Using ACPI for IRQ routing <6>PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report <4>TC classifier action (bugs to netdev@vger.kernel.org cc hadi@cyberus.ca) <6>pnp: 00:0a: ioport range 0x680-0x6ff has been reserved <6>pnp: 00:0a: ioport range 0x295-0x296 has been reserved <6>PCI: Bridge: 0000:00:03.0 <6> IO window: a000-afff <6> MEM window: f4c00000-f4cfffff <6> PREFETCH window: disabled. <6>PCI: Bridge: 0000:00:1c.0 <6> IO window: b000-bfff <6> MEM window: f4d00000-f5dfffff <6> PREFETCH window: disabled. <6>PCI: Bridge: 0000:00:1e.0 <6> IO window: c000-cfff <6> MEM window: f5e00000-f7efffff <6> PREFETCH window: 40000000-400fffff <7>PCI: Setting latency timer of device 0000:00:1e.0 to 64 <6>apm: BIOS version 1.2 Flags 0x03 (Driver version 1.16ac) <5>apm: disabled - APM is not SMP safe. <6>audit: initializing netlink socket (disabled) <4>audit(1130587248.236:1): initialized <4>highmem bounce pool size: 64 pages <4>Total HugeTLB memory allocated, 0 <5>VFS: Disk quotas dquot_6.5.1 <4>Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) <6>Initializing Cryptographic API <6>vesafb: framebuffer at 0xf6000000, mapped to 0xf8880000, using 3072k, total 8128k <6>vesafb: mode is 1024x768x8, linelength=1024, pages=9 <6>vesafb: protected mode interface info at c000:4a64 <6>vesafb: scrolling: redraw <6>vesafb: Pseudocolor: size=6:6:6:6, shift=0:0:0:0 <4>Console: switching to colour frame buffer device 128x48 <6>fb0: VESA VGA frame buffer device <6>isapnp: Scanning for PnP cards... <6>isapnp: No Plug & Play device found <6>Real Time Clock Driver v1.12 <4>PNP: PS/2 controller doesn't have AUX irq; using default 0xc <6>PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 112 <6>serio: i8042 AUX port at 0x60,0x64 irq 12 <6>serio: i8042 KBD port at 0x60,0x64 irq 1 <6>Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled <4>ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A <4>ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A <4>ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A <4>ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A <6>io scheduler noop registered <6>io scheduler anticipatory registered <6>io scheduler deadline registered <6>io scheduler cfq registered <6>Floppy drive(s): fd0 is 1.44M <6>FDC 0 is a post-1991 82077 <4>RAMDISK driver initialized: 16 RAM disks of 64000K size 1024 blocksize <6>loop: loaded (max 8 devices) <6>mice: PS/2 mouse device common for all mice <6>input: PC Speaker <6>md: md driver 0.90.2 MAX_MD_DEVS=256, MD_SB_DISKS=27 <6>md: bitmap version 3.38 <6>NET: Registered protocol family 2 <4>IP route cache hash table entries: 65536 (order: 6, 262144 bytes) <4>TCP established hash table entries: 262144 (order: 9, 2097152 bytes) <4>TCP bind hash table entries: 65536 (order: 7, 524288 bytes) <6>TCP: Hash tables configured (established 262144 bind 65536) <6>TCP reno registered <6>NET: Registered protocol family 1 <6>Starting balanced_irq <4>Using IPI No-Shortcut mode <4>ACPI wakeup devices: <4>GBEN P0P4 P0P5 WDTR PS2K USB1 USB2 EUSB PWRB <6>ACPI: (supports S0 S1 S4 S5) <6>Freeing unused kernel memory: 252k freed <6>Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 <6>ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx <5>SCSI subsystem initialized <6>ICH5: IDE controller at PCI slot 0000:00:1f.1 <6>ACPI: PCI Interrupt 0000:00:1f.1[A] -> GSI 18 (level, low) -> IRQ 169 <6>ICH5: chipset revision 2 <6>ICH5: not 100% native mode: will probe irqs later <6> ide0: BM-DMA at 0xfc00-0xfc07, BIOS settings: hda:DMA, hdb:DMA <6> ide1: BM-DMA at 0xfc08-0xfc0f, BIOS settings: hdc:DMA, hdd:DMA <7>Probing IDE interface ide0... <6>input: AT Translated Set 2 keyboard on isa0060/serio0 <4>hda: SAMSUNG SV0412H, ATA DISK drive <4>hdb: IC35L080AVVA07-0, ATA DISK drive <4>ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 <6>hda: max request size: 128KiB <6>hda: 78242976 sectors (40060 MB) w/2048KiB Cache, CHS=65535/16/63, UDMA(33) <6>hda: cache flushes supported <6> hda: hda1 < hda5 hda6 hda7 hda8 hda9 hda10 hda11 > <6>hdb: max request size: 128KiB <6>hdb: 160836480 sectors (82348 MB) w/1863KiB Cache, CHS=65535/16/63, UDMA(33) <6>hdb: cache flushes supported <6> hdb: hdb1 < hdb5 > <7>Probing IDE interface ide1... <4>hdc: IBM-DTLA-307020, ATA DISK drive <4>hdd: IDE DVD-ROM 16X, ATAPI CD/DVD-ROM drive <4>ide1 at 0x170-0x177,0x376 on irq 15 <6>hdc: max request size: 128KiB <6>hdc: 40188960 sectors (20576 MB) w/1916KiB Cache, CHS=39870/16/63, UDMA(100) <6>hdc: cache flushes not supported <6> hdc: hdc1 < hdc5 > <4>3ware Storage Controller device driver for Linux v1.26.02.001. <6>ACPI: PCI Interrupt 0000:02:02.0[A] -> GSI 24 (level, low) -> IRQ 177 <6>hdd: ATAPI 48X DVD-ROM drive, 512kB Cache, UDMA(33) <6>Uniform CD-ROM driver Revision: 3.20 <6>scsi0 : 3ware Storage Controller <4>3w-xxxx: scsi0: Found a 3ware Storage Controller at 0xbc00, IRQ: 177. <5> Vendor: 3ware Model: Logical Disk 1 Rev: 1.2 <5> Type: Direct-Access ANSI SCSI revision: 00 <5>SCSI device sda: 625159424 512-byte hdwr sectors (320082 MB) <5>SCSI device sda: drive cache: write back <5>SCSI device sda: 625159424 512-byte hdwr sectors (320082 MB) <5>SCSI device sda: drive cache: write back <6> sda: sda1 < sda5 > <5>Attached scsi disk sda at scsi0, channel 0, id 1, lun 0 <7>libata version 1.12 loaded. <7>sata_promise version 1.02 <6>ACPI: PCI Interrupt 0000:02:05.0[A] -> GSI 27 (level, low) -> IRQ 185 <5>Attached scsi generic sg0 at scsi0, channel 0, id 1, lun 0, type 0 <6>ata1: SATA max UDMA/133 cmd 0xF8806200 ctl 0xF8806238 bmdma 0x0 irq 185 <6>ata2: SATA max UDMA/133 cmd 0xF8806280 ctl 0xF88062B8 bmdma 0x0 irq 185 <6>ata3: SATA max UDMA/133 cmd 0xF8806300 ctl 0xF8806338 bmdma 0x0 irq 185 <4>scsi_id[1353]: 0:0:1:0: page 0 not available. <6>ata4: SATA max UDMA/133 cmd 0xF8806380 ctl 0xF88063B8 bmdma 0x0 irq 185 <4>scsi_id[1356]: 0:0:1:0: page 0 not available. <6>ata1: no device found (phy stat 00000000) <6>scsi1 : sata_promise <6>ata2: no device found (phy stat 00000000) <6>scsi2 : sata_promise <6>ata3: no device found (phy stat 00000000) <6>scsi3 : sata_promise <6>ata4: no device found (phy stat 00000000) <6>scsi4 : sata_promise <6>ACPI: CPU0 (power states: C1[C1]) <6>ACPI: CPU1 (power states: C1[C1]) <4>Attempting manual resume <3>swsusp: Suspend partition has wrong signature? <5>ReiserFS: hdb5: found reiserfs format "3.6" with standard journal <5>ReiserFS: hdb5: using ordered data mode <5>ReiserFS: hdb5: journal params: device hdb5, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 <5>ReiserFS: hdb5: checking transaction log (hdb5) <5>ReiserFS: hdb5: Using r5 hash to sort names <6>md: Autodetecting RAID arrays. <6>md: autorun ... <6>md: ... autorun DONE. <6>Adding 514040k swap on /dev/hda7. Priority:-1 extents:1 <6>device-mapper: 4.4.0-ioctl (2005-01-12) initialised: dm-devel@redhat.com <5>ReiserFS: sda5: found reiserfs format "3.6" with standard journal <5>ReiserFS: sda5: using ordered data mode <5>ReiserFS: sda5: journal params: device sda5, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 <5>ReiserFS: sda5: checking transaction log (sda5) <5>ReiserFS: sda5: Using r5 hash to sort names <5>ReiserFS: hdc5: found reiserfs format "3.6" with standard journal <5>ReiserFS: hdc5: using ordered data mode <5>ReiserFS: hdc5: journal params: device hdc5, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 <5>ReiserFS: hdc5: checking transaction log (hdc5) <5>ReiserFS: hdc5: Using r5 hash to sort names Kernel logging (ksyslog) stopped. Kernel log daemon terminating. Boot logging started on /dev/tty1(/dev/console) at Sat Oct 29 14:01:03 2005 Mounting shared memory FS on /dev/shmdone Activating swap-devices in /etc/fstab... doneActivating device mapper... Creating /dev/mapper/control character device with major:10 minor:63. done Checking file systems... fsck 1.38 (30-Jun-2005) doneSetting up kernel module dependencies (if required)done Mounting local file systems... proc on /proc type proc (rw) sysfs on /sys type sysfs (rw) tmpfs on /dev/shm type tmpfs (rw) devpts on /dev/pts type devpts (rw,mode=0620,gid=5) mount: you didn't specify a filesystem type for /dev/sda5 I will try type reiserfs /dev/sda5 on /opt type reiserfs (rw) mount: you didn't specify a filesystem type for /dev/hdc5 I will try type reiserfs /dev/hdc5 on /opt/backup type reiserfs (rw) doneSetting up the CMOS clock<notice>startproc: execve (/sbin/udevd) [ /sbin/udevd --daemon --stop-exec-queue ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 UDEVD_EVENT_TIMEOUT=1 LC_ALL=POSIX UDEVD_EXPECTED_SEQNUM=820 INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 DO_CONFIRM= RUNLEVEL=S PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/sbin/udevd ] done Starting udevd done Loading required kernel modules done<notice>killproc: kill(2256,29) Creating /var/log/boot.msg doneColdplug Coldplug: cleaning /events hwup: Loading module 'lp' for device 'printer' processing eventsdone Setting up hostname 'igelserver'done Setting up loopback interface lo lo IP address: 127.0.0.1/8 done Restore device permissionsdone Activating remaining swap-devices in /etc/fstab... doneSetting current sysctl status from /etc/sysctl.conf net.ipv4.icmp_echo_ignore_broadcasts = 1 net.ipv4.conf.all.rp_filter = 1 done Enabling syn flood protectiondone Enabling IP forwardingdone done System Boot Control: The system has been set up System Boot Control: Running /etc/init.d/boot.local done<notice>killproc: kill(2256,3) INIT: Entering runlevel: 3 Boot logging started on /dev/tty1(/dev/console) at Sat Oct 29 12:01:21 2005 Master Resource Control: previous runlevel: N, switching to runlevel: 3 <notice>checkproc: /sbin/udevd 2388 <notice>startproc: execve (/usr/bin/dbus-daemon) [ /usr/bin/dbus-daemon --system ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/bin/dbus-daemon ] Initializing random number generatordone Starting D-BUS daemondone <notice>startproc: execve (/sbin/resmgrd) [ /sbin/resmgrd ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/sbin/resmgrd ] Starting resource managerdone Loading keymap qwertz/de-latin1-nodeadkeys.map.gz doneLoading compose table winkeys shiftctrl latin1.adddone Start Unicode mode doneLoading console font lat9w-16.psfu -m trivial G0:loadable Setting up ISDN card contr0 AVM FRITZ!Card PCIdone Loading Driver contr0 1 kcapi capidone Initializing capi for contr0 (1)done doneSetting up network interfaces: lo lo IP address: 127.0.0.1/8 doneWaiting for mandatory devices: eth-id-00:11:d8:e4:e7:be eth-id-00:a0:d2:14:f9:02 19 eth0 device: Intel Corporation 82547GI Gigabit Ethernet Controller eth0 configuration: eth-id-00:11:d8:e4:e7:be eth0 IP address: 192.168.0.100/24 done eth1 device: Realtek Semiconductor Co., Ltd. RTL-8029(AS) eth1 configuration: eth-id-00:a0:d2:14:f9:02 eth1 IP address: 192.168.2.100/24 done dsl0 doneSetting up service network . . . . . . . . . . . . . . . .done <notice>startproc: execve (/usr/sbin/sshd) [ /usr/sbin/sshd -o PidFile=/var/run/sshd.init.pid ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/sshd ] <notice>startproc: execve (/sbin/syslog-ng) [ /sbin/syslog-ng ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/sbin/syslog-ng ] <notice>startproc: execve (/sbin/klogd) [ /sbin/klogd -c 1 -x -x ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/sbin/klogd ] Starting syslog servicesdone Starting SSH daemondone Starting igelhome.local.de done <notice>startproc: execve (/usr/sbin/nmbd) [ /usr/sbin/nmbd -D -s /etc/samba/smb.conf ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/nmbd ] <notice>startproc: execve (/sbin/portmap) [ /sbin/portmap ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/sbin/portmap ] Starting RPC portmap daemondone <notice>startproc: execve (/usr/sbin/capisuite) [ /usr/sbin/capisuite -d ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/capisuite ] Starting Samba NMB daemon done Starting CapiSuite done <notice>startproc: execve (/usr/sbin/xinetd) [ /usr/sbin/xinetd ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/xinetd ] Starting INET services. (xinetd)done <notice>startproc: execve (/usr/sbin/acpid) [ /usr/sbin/acpid ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/acpid ] acpid: loading ACPI modules ( ac battery button ) done Starting acpid done Starting name server BIND <notice>pidofproc: pppd 5069 <notice>startproc: execve (/usr/sbin/named) [ /usr/sbin/named -t /var/lib/named -u named ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 checkAndCopyConfigFilesCalled=yes HOME=/ SHLVL=2 namedConfChecked=yes splash=silent SPLASH=no initializeNamedCalled=yes ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/named ] <notice>checkproc: /usr/sbin/named 5377 done <notice>startproc: execve (/usr/sbin/smpppd) [ /usr/sbin/smpppd ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/smpppd ] Starting SMPPPDdone <notice>startproc: execve (/usr/sbin/nscd) [ /usr/sbin/nscd ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/nscd ] Starting Name Service Cache Daemondone <notice>startproc: execve (/usr/sbin/cupsd) [ /usr/sbin/cupsd ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/cupsd ] Starting cupsddone <notice>startproc: execve (/usr/sbin/smbd) [ /usr/sbin/smbd -D -s /etc/samba/smb.conf ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 TMPDIR=/var/tmp LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/smbd ] Starting Samba SMB daemon done Starting DHCP server [chroot]done <notice>startproc: execve (/usr/sbin/ntpd) [ /usr/sbin/ntpd -p /var/lib/ntp/var/run/ntp/ntpd.pid -u ntp -i /var/lib/ntp ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/ntpd ] Try to get initial date and time via NTP from ptbtime1.ptb.de ntps1-0.cs.tu-berlin.dedone Starting network time protocol daemon (NTPD)done Starting mail service (Postfix)done Starting CRON daemon<notice>startproc: execve (/usr/sbin/cron) [ /usr/sbin/cron ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/cron ] done Starting HAL daemon<notice>startproc: execve (/usr/sbin/hald) [ /usr/sbin/hald --daemon=yes --retain-privileges ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/hald ] done Starting powersaved (accessing ACPI events over acpid) <notice>startproc: execve (/usr/sbin/powersaved) [ /usr/sbin/powersaved -d -f /var/run/acpid.socket -v 3 ], [ CONSOLE=/dev/console ROOTFS_FSTYPE=reiserfs TERM=linux SHELL=/bin/sh ROOTFS_FSCK=0 LC_ALL=POSIX INIT_VERSION=sysvinit-2.85 REDIRECT=/dev/tty1 COLUMNS=128 PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lib/klibc/bin vga=773 RUNLEVEL=3 PWD=/ SPLASHCFG= PREVLEVEL=N LINES=48 HOME=/ SHLVL=2 splash=silent SPLASH=no ROOTFS_BLKDEV=/dev/hdb5 _=/sbin/startproc DAEMON=/usr/sbin/powersaved ] done <notice>checkproc: /usr/sbin/ntpd 5642 <notice>killproc: kill(5642,15) Starting Firewall done Master Resource Control: runlevel 3 has been reached <notice>killproc: kill(2647,3) Boot logging started on /dev/tty1(/dev/console) at Sat Oct 29 21:00:29 2005 Master Resource Control: previous runlevel: 3, switching to runlevel: 0 <notice>killproc: kill(5480,15) <notice>killproc: kill(5617,15) Shutting down Name Service Cache Daemondone <notice>killproc: kill(6134,15) Saving random seeddone <notice>checkproc: /usr/sbin/smbd 5630 <notice>killproc: kill(5630,15) Shutting down Samba SMB daemon done <notice>killproc: kill(5270,15) Shutting down sensors: done <notice>checkproc: /usr/sbin/nmbd 5378 <notice>killproc: kill(5378,15) <notice>killproc: kill(5830,15) Shutting down the Firewall done <notice>killproc: kill(5461,15) Shutting down Samba NMB daemon done <notice>killproc: kill(5580,15) Shutting down DHCP server done <notice>killproc: kill(5237,15) Shutting down network time protocol daemon (NTPD)done done Shutting down SSH daemondone Shutting down CapiSuite done <notice>killproc: kill(5300,3) Shutting down xinetd:done Shutting down SMPPPDdone Shutting down cupsddone <notice>killproc: kill(5253,15) Stopping ISDN done Shutting down RPC portmap daemondone Shutting down httpd2 (waiting for all children to terminate) done <notice>killproc: kill(6471,15) Shutting down powersaved done <notice>killproc: kill(5700,15) Shutting down HAL daemondone <notice>killproc: kill(2835,15) <notice>killproc: kill(5307,15) <notice>killproc: kill(5690,15) Shutting down D-BUS daemondone Shutting down resource managerdone Shutting down acpid done Shutting down CRON daemondone <notice>killproc: kill(5669,15) Shutting down mail service (Postfix)done <notice>checkproc: /usr/sbin/named 7393 Shutting down service MySQL done Shutting down name server BIND INIT: Switching to runlevel: 6 INIT: Sending processes the TERM signal Running /etc/init.d/halt.local done<notice>killproc: kill(3176,3) Sending all processes the TERM signal... Boot logging started on /dev/tty1(/dev/console) at Sat Oct 29 21:01:04 2005 Master Resource Control: previous runlevel: 0, switching to runlevel: 6 Running /etc/init.d/halt.local done<notice>killproc: kill(3531,3) Sending all processes the TERM signal...
When using larger logfiles, please use the attachment-feature of bugzilla.
Please attach (!) 500 lines of your syslog: % tail -500 /var/log/messages > syslog.txt Thanks.
Created attachment 56064 [details] last 500 lines of /var/log/messages
Uwe: Does this help? I'm not sure what I could request here any further, the syslog does not contain much bind-messages either. Please ask about the specifics yourself. Thanks.
please provide the output of "rcnamed status" on a running bind.
two more infos please: 1. does "rnamed stop" work in a running system? 2. does it help to set RUN_PARALLEL=no in /etc/sysconfig/boot
> (In reply to comment #5) > please provide the output of "rcnamed status" on a running bind. > The output is: igelserver:~ # rcnamed status Checking for nameserver BIND number of zones: 3 debug level: 0 xfers running: 0 xfers deferred: 0 soa queries in progress: 0 query logging is OFF recursive clients: 0/1000 tcp clients: 0/100 server is up and running running > (In reply to comment #6) > two more infos please: > > 1. does "rnamed stop" work in a running system? Yes without a problem. > 2. does it help to set RUN_PARALLEL=no in /etc/sysconfig/boot Changing RUN_PARALLEL to 'no' makes it even worse. The shutdown process still hangs after the message for the bind process but I am no longer able to initiate another shutdown task which would complete the shutdown. Maybe not the bind process is the problem but the task that would be shutdown after bind.
with RUN_PARALLEL=yes, please shut down the system and if it hangs during the bind shutdown, check the process list if bind is still running. If it's still running, please do "strace -p" to the PID of the bind process. Maybe we can see where it hangs.
> with RUN_PARALLEL=yes, please shut down the system and if it hangs during the > bind shutdown, check the process list if bind is still running. > If it's still running, please do "strace -p" to the PID of the bind process. > Maybe we can see where it hangs. Now it gets interesting. I tried to strace the running named 5776 0.0 0.3 30324 3324 ? Ssl 22:10 0:00 /usr/sbin/named -t /var/lib/named -u named but that returned nothing. But I found that the '/bin/sh /etc/init.d/named stop' task is still running as well. Stracing this process shows a 'waitpid(-1, '. Then I tried to kill the '/bin/sh /etc/init.d/named stop' process which made the shutdown process continue successfully. So the question is why the stop command hangs on shutdown. I hope you have any idea.
I'm digging in the dark, Can you please try to change the first line of the /etc/rc.d/named script from: "#! /bin/sh" to "#! /bin/sh -x" and then shutdown the system. The shell should print out what's going on and maybe we can see where it hangs.
The shutdown hangs with the command /usr/sbin/rndc status Killing this process continues the shutdown process as well. I tried to strace the /usr/sbin/rndc status (while being in the halted shutdown process) which lead to ---cut--- open("/usr/share/locale/POSIX/libisccc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) open("/usr/share/locale/POSIX/LC_MESSAGES/libisccc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) open("/usr/share/locale/POSIX/libisccc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) open("/usr/share/locale/POSIX/LC_MESSAGES/libisccc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) futex(0x400352f8, FUTEX_WAKE, 2147483647) = 0 open("/usr/share/locale/POSIX/libisc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) open("/usr/share/locale/POSIX/LC_MESSAGES/libisc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) open("/usr/share/locale/POSIX/libisc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) open("/usr/share/locale/POSIX/LC_MESSAGES/libisc.cat", O_RDONLY) = -1 ENOENT (No such file or directory) futex(0x40184aa0, FUTEX_WAKE, 2147483647) = 0 futex(0x40184ac0, FUTEX_WAKE, 2147483647) = 0 futex(0x400352fc, FUTEX_WAKE, 2147483647) = 0 futex(0x8000b4f0, FUTEX_WAKE, 1) = 1 futex(0x8000b4ec, FUTEX_WAKE, 1) = 1 futex(0x8000b4b8, FUTEX_WAKE, 1) = 1 rt_sigaction(SIGHUP, {0x4016c330, ~[RTMIN RT_1], 0}, NULL, 8) = 0 rt_sigsuspend([] --- cut --- Seems like the rt_sigsuspend hangs the whole shutdown process.
does it change anything to set NAMED_RUN_CHROOTED="no" in /etc/sysconfig/named ?
No. (In reply to comment #12) > does it change anything to set NAMED_RUN_CHROOTED="no" in /etc/sysconfig/named > ? No. Still hangs with the same problem.
I tried a lot of stuff but I really can't reproduce that on any of my machines Is this really i586 or some other kind of hardware? I don't I can fix that as long as I can't reproduce it on my own.
I can not reproduce it but I'll keep the problem in mind. Thanks for reporting.