Bug#498645: initramfs-tools: Boot takes three minutes to finish (!) - Debian

This is a discussion on Bug#498645: initramfs-tools: Boot takes three minutes to finish (!) - Debian ; Package: initramfs-tools Version: 0.92i After installing a lenny system today, it happened that the boot process takes more than 3 minutes to finish. Needless to say, I first believed it was frozen and didn't work at all. I was lucky ...

+ Reply to Thread
Results 1 to 9 of 9

Thread: Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

  1. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    Package: initramfs-tools
    Version: 0.92i

    After installing a lenny system today, it happened that the boot
    process takes more than 3 minutes to finish. Needless to say, I first
    believed it was frozen and didn't work at all. I was lucky to discover
    (by accident) that it was a very long waiting time instead.

    After a bit of investigation, it happened that this value, 180 seconds,
    is the default timeout for "udevadm settle", according to udevadm(8).

    Unfortunately, there is not a simple way to change this. First I tried
    changing "udevadm settle" invocation in /etc/init.d/udev but this only
    worked for linux images not using a ramdisk (I built several of those as
    I first suspected to be a kernel problem).

    What worked finally was to change "udevadm settle" invocation at

    /usr/share/initramfs-tools/scripts/init-premount/udev

    and then rebuilding the initramfs via dpkg-reconfigure linux-image-etc-etc.

    While doing this I noticed that "udevadm settle" is called three times
    in /usr/share/initramfs-tools/*. Two of them are wrapped via wait_for_udev()
    from /usr/share/initramfs-tools/scripts/functions and they have 10 seconds
    as the timeout value. The other one is the one I had to hardcode by hand.

    To summarize: No matter how faulty my hardware might be (the boot
    never took so long with etch), I don't think it is reasonable at all
    that a user has to do this in order for the boot process not to take
    more than three minutes.

    Maybe every "udevadm settle" invocation should be wrapped via wait_for_udev(),
    not just two of them. Or maybe this is a bug in udev for having such a long
    waiting time. Feel free to reassign.

    Note: I see this as a serious bug, but as I don't know the number of
    people having this problem, I prefer not to use a severity at all.

    Thanks.



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  2. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    On Thu, Sep 11, 2008 at 08:40:30PM +0200, Santiago Vila wrote:
    > Package: initramfs-tools
    > Version: 0.92i
    >
    > After installing a lenny system today, it happened that the boot
    > process takes more than 3 minutes to finish. Needless to say, I first
    > believed it was frozen and didn't work at all. I was lucky to discover
    > (by accident) that it was a very long waiting time instead.
    >
    > After a bit of investigation, it happened that this value, 180 seconds,
    > is the default timeout for "udevadm settle", according to udevadm(8).
    >
    > Unfortunately, there is not a simple way to change this. First I tried
    > changing "udevadm settle" invocation in /etc/init.d/udev but this only
    > worked for linux images not using a ramdisk (I built several of those as
    > I first suspected to be a kernel problem).


    your hardware must be seriously broken,
    never seen any box reaching that timeout.

    > What worked finally was to change "udevadm settle" invocation at
    >
    > /usr/share/initramfs-tools/scripts/init-premount/udev
    >
    > and then rebuilding the initramfs via dpkg-reconfigure linux-image-etc-etc.
    >
    > While doing this I noticed that "udevadm settle" is called three times
    > in /usr/share/initramfs-tools/*. Two of them are wrapped via wait_for_udev()
    > from /usr/share/initramfs-tools/scripts/functions and they have 10 seconds
    > as the timeout value. The other one is the one I had to hardcode by hand.
    >
    > To summarize: No matter how faulty my hardware might be (the boot
    > never took so long with etch), I don't think it is reasonable at all
    > that a user has to do this in order for the boot process not to take
    > more than three minutes.
    >
    > Maybe every "udevadm settle" invocation should be wrapped via wait_for_udev(),
    > not just two of them. Or maybe this is a bug in udev for having such a long
    > waiting time. Feel free to reassign.
    >
    > Note: I see this as a serious bug, but as I don't know the number of
    > people having this problem, I prefer not to use a severity at all.


    this looks more like a kernel bug,
    please provide lspci and dmesg of that box.

    --
    maks



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  3. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    On Thu, 11 Sep 2008, maximilian attems wrote:

    > > To summarize: No matter how faulty my hardware might be (the boot
    > > never took so long with etch), I don't think it is reasonable at all
    > > that a user has to do this in order for the boot process not to take
    > > more than three minutes.
    > >
    > > Maybe every "udevadm settle" invocation should be wrapped via wait_for_udev(),
    > > not just two of them. Or maybe this is a bug in udev for having such a long
    > > waiting time. Feel free to reassign.
    > >
    > > Note: I see this as a serious bug, but as I don't know the number of
    > > people having this problem, I prefer not to use a severity at all.

    >
    > this looks more like a kernel bug,
    > please provide lspci and dmesg of that box.


    Sure.

    This is lspci -v:

    00:00.0 Host bridge: VIA Technologies, Inc. VT8363/8365 [KT133/KM133] (rev 03)
    Flags: bus master, medium devsel, latency 8
    Memory at d0000000 (32-bit, prefetchable) [size=64M]
    Capabilities: [a0] AGP version 2.0
    Capabilities: [c0] Power Management version 2
    Kernel driver in use: agpgart-via
    Kernel modules: via-agp

    00:01.0 PCI bridge: VIA Technologies, Inc. VT8363/8365 [KT133/KM133 AGP]
    Flags: bus master, 66MHz, medium devsel, latency 0
    Bus: primary=00, secondary=01, subordinate=01, sec-latency=0
    I/O behind bridge: 00009000-00009fff
    Memory behind bridge: d8000000-d9ffffff
    Prefetchable memory behind bridge: d4000000-d7ffffff
    Capabilities: [80] Power Management version 2
    Kernel modules: shpchp

    00:07.0 ISA bridge: VIA Technologies, Inc. VT82C686 [Apollo Super South] (rev 40)
    Subsystem: VIA Technologies, Inc. Device 0000
    Flags: bus master, stepping, medium devsel, latency 0
    Capabilities: [c0] Power Management version 2
    Kernel driver in use: parport_pc
    Kernel modules: parport_pc

    00:07.1 IDE interface: VIA Technologies, Inc. VT82C586A/B/VT82C686/A/B/VT823x/A/C PIPC Bus Master IDE (rev 06) (prog-if 8a [Master SecP PriP])
    Flags: bus master, medium devsel, latency 32
    [virtual] Memory at 000001f0 (32-bit, non-prefetchable) [size=8]
    [virtual] Memory at 000003f0 (type 3, non-prefetchable) [size=1]
    [virtual] Memory at 00000170 (32-bit, non-prefetchable) [size=8]
    [virtual] Memory at 00000370 (type 3, non-prefetchable) [size=1]
    I/O ports at a000 [size=16]
    Capabilities: [c0] Power Management version 2
    Kernel driver in use: VIA_IDE
    Kernel modules: via82cxxx

    00:07.2 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 1a)
    Subsystem: First International Computer, Inc. Device 1234
    Flags: bus master, medium devsel, latency 32, IRQ 10
    I/O ports at a400 [size=32]
    Capabilities: [80] Power Management version 2
    Kernel driver in use: uhci_hcd
    Kernel modules: uhci-hcd

    00:07.3 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 1a)
    Subsystem: First International Computer, Inc. Device 1234
    Flags: bus master, medium devsel, latency 32, IRQ 10
    I/O ports at a800 [size=32]
    Capabilities: [80] Power Management version 2
    Kernel driver in use: uhci_hcd
    Kernel modules: uhci-hcd

    00:07.4 Host bridge: VIA Technologies, Inc. VT82C686 [Apollo Super ACPI] (rev 40)
    Flags: medium devsel, IRQ 11
    Capabilities: [68] Power Management version 2
    Kernel modules: i2c-viapro, via686a

    00:09.0 Ethernet controller: Realtek Semiconductor Co., Ltd. RTL-8139/8139C/8139C+ (rev 10)
    Subsystem: Realtek Semiconductor Co., Ltd. RTL-8139/8139C/8139C+
    Flags: bus master, medium devsel, latency 32, IRQ 11
    I/O ports at b000 [size=256]
    Memory at da000000 (32-bit, non-prefetchable) [size=256]
    Capabilities: [50] Power Management version 2
    Kernel driver in use: 8139too
    Kernel modules: 8139too, 8139cp

    00:0a.0 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 61)
    Subsystem: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller
    Flags: bus master, medium devsel, latency 32, IRQ 12
    I/O ports at b400 [size=32]
    Capabilities: [80] Power Management version 2
    Kernel driver in use: uhci_hcd
    Kernel modules: uhci-hcd

    00:0a.1 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 61)
    Subsystem: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller
    Flags: bus master, medium devsel, latency 32, IRQ 10
    I/O ports at b800 [size=32]
    Capabilities: [80] Power Management version 2
    Kernel driver in use: uhci_hcd
    Kernel modules: uhci-hcd

    00:0a.2 USB Controller: VIA Technologies, Inc. USB 2.0 (rev 63) (prog-if 20)
    Subsystem: VIA Technologies, Inc. USB 2.0
    Flags: bus master, medium devsel, latency 32, IRQ 5
    Memory at da001000 (32-bit, non-prefetchable) [size=256]
    Capabilities: [80] Power Management version 2
    Kernel driver in use: ehci_hcd
    Kernel modules: ehci-hcd

    00:0e.0 Multimedia audio controller: Creative Labs SB Live! EMU10k1 (rev 0a)
    Subsystem: Creative Labs Device 8066
    Flags: bus master, medium devsel, latency 32, IRQ 12
    I/O ports at bc00 [size=32]
    Capabilities: [dc] Power Management version 1
    Kernel driver in use: EMU10K1_Audigy
    Kernel modules: snd-emu10k1

    00:0e.1 Input device controller: Creative Labs SB Live! Game Port (rev 0a)
    Subsystem: Creative Labs Device 0020
    Flags: bus master, medium devsel, latency 32
    I/O ports at c000 [size=8]
    Capabilities: [dc] Power Management version 1
    Kernel driver in use: Emu10k1_gameport
    Kernel modules: emu10k1-gp

    01:00.0 VGA compatible controller: ATI Technologies Inc Rage 128 PF/PRO AGP 4x TMDS
    Subsystem: ATI Technologies Inc Device 0048
    Flags: bus master, stepping, 66MHz, medium devsel, latency 32, IRQ 10
    Memory at d4000000 (32-bit, prefetchable) [size=64M]
    I/O ports at 9000 [size=256]
    Memory at d9000000 (32-bit, non-prefetchable) [size=16K]
    [virtual] Expansion ROM at d8000000 [disabled] [size=128K]
    Capabilities: [50] AGP version 2.0
    Capabilities: [5c] Power Management version 2
    Kernel modules: aty128fb


    And this is dmesg:

    [ 0.000000] Initializing cgroup subsys cpuset
    [ 0.000000] Initializing cgroup subsys cpu
    [ 0.000000] Linux version 2.6.26-1-686 (Debian 2.6.26-4) (waldi@debian.org) (gcc version 4.1.3 20080623 (prerelease) (Debian 4.1.2-23)) #1 SMP Thu Aug 28 12:00:54 UTC 2008
    [ 0.000000] BIOS-provided physical RAM map:
    [ 0.000000] BIOS-e820: 0000000000000000 - 00000000000a0000 (usable)
    [ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
    [ 0.000000] BIOS-e820: 0000000000100000 - 000000000fff0000 (usable)
    [ 0.000000] BIOS-e820: 000000000fff0000 - 000000000fff3000 (ACPI NVS)
    [ 0.000000] BIOS-e820: 000000000fff3000 - 0000000010000000 (ACPI data)
    [ 0.000000] BIOS-e820: 00000000ffff0000 - 0000000100000000 (reserved)
    [ 0.000000] 0MB HIGHMEM available.
    [ 0.000000] 255MB LOWMEM available.
    [ 0.000000] Entering add_active_range(0, 0, 65520) 0 entries of 256 used
    [ 0.000000] Zone PFN ranges:
    [ 0.000000] DMA 0 -> 4096
    [ 0.000000] Normal 4096 -> 65520
    [ 0.000000] HighMem 65520 -> 65520
    [ 0.000000] Movable zone start PFN for each node
    [ 0.000000] early_node_map[1] active PFN ranges
    [ 0.000000] 0: 0 -> 65520
    [ 0.000000] On node 0 totalpages: 65520
    [ 0.000000] DMA zone: 32 pages used for memmap
    [ 0.000000] DMA zone: 0 pages reserved
    [ 0.000000] DMA zone: 4064 pages, LIFO batch:0
    [ 0.000000] Normal zone: 480 pages used for memmap
    [ 0.000000] Normal zone: 60944 pages, LIFO batch:15
    [ 0.000000] HighMem zone: 0 pages used for memmap
    [ 0.000000] Movable zone: 0 pages used for memmap
    [ 0.000000] DMI 2.2 present.
    [ 0.000000] ACPI: RSDP 000F7610, 0014 (r0 VIA694)
    [ 0.000000] ACPI: RSDT 0FFF3000, 0028 (r1 VIA694 MSI ACPI 42302E31 AWRD 0)
    [ 0.000000] ACPI: FACP 0FFF3040, 0074 (r1 VIA694 MSI ACPI 42302E31 AWRD 0)
    [ 0.000000] ACPI: DSDT 0FFF30C0, 259F (r1 VIA694 AWRDACPI 1000 MSFT 100000C)
    [ 0.000000] ACPI: FACS 0FFF0000, 0040
    [ 0.000000] ACPI: PM-Timer IO Port: 0x4008
    [ 0.000000] Allocating PCI resources starting at 20000000 (gap: 10000000:efff0000)
    [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
    [ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
    [ 0.000000] SMP: Allowing 0 CPUs, 0 hotplug CPUs
    [ 0.000000] PERCPU: Allocating 37960 bytes of per cpu data
    [ 0.000000] NR_CPUS: 8, nr_cpu_ids: 1
    [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 65008
    [ 0.000000] Kernel command line: root=/dev/hda2 ro vga=4
    [ 0.000000] Local APIC disabled by BIOS -- you can enable it with "lapic"
    [ 0.000000] mapped APIC to ffffb000 (0120c000)
    [ 0.000000] Enabling fast FPU save and restore... done.
    [ 0.000000] Initializing CPU#0
    [ 0.000000] PID hash table entries: 1024 (order: 10, 4096 bytes)
    [ 0.000000] Detected 799.646 MHz processor.
    [ 0.004000] Console: colour VGA+ 80x30
    [ 0.004000] console [tty0] enabled
    [ 0.004000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
    [ 0.004000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
    [ 0.004000] Memory: 250188k/262080k available (1767k kernel code, 11344k reserved, 749k data, 244k init, 0k highmem)
    [ 0.004000] virtual kernel memory layout:
    [ 0.004000] fixmap : 0xfff4c000 - 0xfffff000 ( 716 kB)
    [ 0.004000] pkmap : 0xff800000 - 0xffc00000 (4096 kB)
    [ 0.004000] vmalloc : 0xd0800000 - 0xff7fe000 ( 751 MB)
    [ 0.004000] lowmem : 0xc0000000 - 0xcfff0000 ( 255 MB)
    [ 0.004000] .init : 0xc037d000 - 0xc03ba000 ( 244 kB)
    [ 0.004000] .data : 0xc02b9f63 - 0xc0375620 ( 749 kB)
    [ 0.004000] .text : 0xc0100000 - 0xc02b9f63 (1767 kB)
    [ 0.004000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
    [ 0.004000] CPA: page pool initialized 1 of 1 pages preallocated
    [ 0.084292] Calibrating delay using timer specific routine.. 1601.65 BogoMIPS (lpj=3203310)
    [ 0.084492] Security Framework initialized
    [ 0.084558] SELinux: Disabled at boot.
    [ 0.084618] Capability LSM initialized
    [ 0.084710] Mount-cache hash table entries: 512
    [ 0.085130] Initializing cgroup subsys ns
    [ 0.085195] Initializing cgroup subsys cpuacct
    [ 0.085254] Initializing cgroup subsys devices
    [ 0.085353] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line)
    [ 0.085425] CPU: L2 Cache: 64K (64 bytes/line)
    [ 0.085487] Intel machine check architecture supported.
    [ 0.085549] Intel machine check reporting enabled on CPU#0.
    [ 0.085642] Checking 'hlt' instruction... OK.
    [ 0.100396] SMP alternatives: switching to UP code
    [ 0.117583] Freeing SMP alternatives: 16k freed
    [ 0.117653] ACPI: Core revision 20080321
    [ 0.125783] ACPI: setting ELCR to 0800 (from 1c20)
    [ 0.127655] weird, boot CPU (#0) not listedby the BIOS.
    [ 0.127719] SMP motherboard not detected.
    [ 0.127776] Local APIC not detected. Using dummy APIC emulation.
    [ 0.127839] SMP disabled
    [ 0.128008] Brought up 1 CPUs
    [ 0.128008] Total of 1 processors activated (1601.65 BogoMIPS).
    [ 0.128008] CPU0 attaching sched-domain:
    [ 0.128008] domain 0: span 0
    [ 0.128008] groups: 0
    [ 0.128652] net_namespace: 660 bytes
    [ 0.128740] Booting paravirtualized kernel on bare hardware
    [ 0.129471] NET: Registered protocol family 16
    [ 0.130237] ACPI: bus type pci registered
    [ 0.163596] PCI: PCI BIOS revision 2.10 entry at 0xfb160, last bus=1
    [ 0.163670] PCI: Using configuration type 1 for base access
    [ 0.163767] Setting up standard PCI resources
    [ 0.167287] ACPI: EC: Look up EC in DSDT
    [ 0.175435] ACPI: Interpreter enabled
    [ 0.175510] ACPI: (supports S0 S1 S4 S5)
    [ 0.175725] ACPI: Using PIC for interrupt routing
    [ 0.187015] ACPI: PCI Root Bridge [PCI0] (0000:00)
    [ 0.187314] pci 0000:00:00.0: Disabling VIA memory write queue (PCI ID 0305, rev 03): [55] 8d & 1f -> 0d
    [ 0.187726] pci 0000:00:07.4: quirk: region 6000-607f claimed by vt82c686 HW-mon
    [ 0.187805] pci 0000:00:07.4: quirk: region 5000-500f claimed by vt82c686 SMB
    [ 0.188472] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
    [ 0.231689] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 5 6 7 *10 11 12 14 15)
    [ 0.232640] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 *5 6 7 10 11 12 14 15)
    [ 0.233517] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 7 10 *11 12 14 15)
    [ 0.234388] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 10 11 *12 14 15)
    [ 0.235339] Linux Plug and Play Support v0.97 (c) Adam Belay
    [ 0.235504] pnp: PnP ACPI init
    [ 0.235581] ACPI: bus type pnp registered
    [ 0.244479] pnp: PnP ACPI: found 12 devices
    [ 0.244554] ACPI: ACPI bus type pnp unregistered
    [ 0.244619] PnPBIOS: Disabled by ACPI PNP
    [ 0.245452] PCI: Using ACPI for IRQ routing
    [ 0.246099] system 00:00: iomem range 0xcb000-0xcbfff has been reserved
    [ 0.246186] system 00:00: iomem range 0xf0000-0xf7fff could not be reserved
    [ 0.246259] system 00:00: iomem range 0xf8000-0xfbfff could not be reserved
    [ 0.246329] system 00:00: iomem range 0xfc000-0xfffff could not be reserved
    [ 0.246400] system 00:00: iomem range 0xfff0000-0xfffffff could not be reserved
    [ 0.246481] system 00:00: iomem range 0xffff0000-0xffffffff could not be reserved
    [ 0.246560] system 00:00: iomem range 0x0-0x9ffff could not be reserved
    [ 0.246627] system 00:00: iomem range 0x100000-0xffeffff could not be reserved
    [ 0.246705] system 00:00: iomem range 0xfee00000-0xfee00fff has been reserved
    [ 0.246791] system 00:02: ioport range 0x4d0-0x4d1 has been reserved
    [ 0.278218] PCI: Bridge: 0000:00:01.0
    [ 0.278287] IO window: 9000-9fff
    [ 0.278343] MEM window: 0xd8000000-0xd9ffffff
    [ 0.278403] PREFETCH window: 0x00000000d4000000-0x00000000d7ffffff
    [ 0.278490] PCI: Setting latency timer of device 0000:00:01.0 to 64
    [ 0.278564] NET: Registered protocol family 2
    [ 0.278858] IP route cache hash table entries: 2048 (order: 1, 8192 bytes)
    [ 0.279493] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
    [ 0.279846] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
    [ 0.280246] TCP: Hash tables configured (established 8192 bind 8192)
    [ 0.280316] TCP reno registered
    [ 0.280640] NET: Registered protocol family 1
    [ 0.281017] checking if image is initramfs...<7>Switched to high resolution mode on CPU 0
    [ 0.837836] it is
    [ 1.497826] Freeing initrd memory: 5788k freed
    [ 1.499617] audit: initializing netlink socket (disabled)
    [ 1.499724] type=2000 audit(1221214481.496:1): initialized
    [ 1.500129] Total HugeTLB memory allocated, 0
    [ 1.500369] VFS: Disk quotas dquot_6.5.1
    [ 1.500499] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
    [ 1.500663] msgmni has been set to 500
    [ 1.501122] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
    [ 1.501210] io scheduler noop registered
    [ 1.501267] io scheduler anticipatory registered
    [ 1.501325] io scheduler deadline registered
    [ 1.501402] io scheduler cfq registered (default)
    [ 1.501486] pci 0000:00:00.0: Applying VIA southbridge workaround
    [ 1.501557] PCI: VIA PCI bridge detected.Disabling DAC.
    [ 1.501623] pci 0000:00:07.0: Disabling VIA external APIC routing
    [ 1.501785] pci 0000:01:00.0: Boot video device
    [ 1.502790] isapnp: Scanning for PnP cards...
    [ 1.857766] isapnp: No Plug & Play device found
    [ 1.866187] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
    [ 1.866546] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
    [ 1.866870] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
    [ 1.867847] 00:08: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
    [ 1.868422] 00:09: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
    [ 1.872923] brd: module loaded
    [ 1.873264] PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1
    [ 1.873335] PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
    [ 1.873726] serio: i8042 KBD port at 0x60,0x64 irq 1
    [ 1.874168] mice: PS/2 mouse device common for all mice
    [ 1.874577] rtc_cmos 00:04: rtc core: registered rtc_cmos as rtc0
    [ 1.874680] rtc0: alarms up to one year, y3k
    [ 1.874840] cpuidle: using governor ladder
    [ 1.874899] cpuidle: using governor menu
    [ 1.874963] No iBFT detected.
    [ 1.876250] TCP cubic registered
    [ 1.876309] NET: Registered protocol family 17
    [ 1.876378] Using IPI No-Shortcut mode
    [ 1.876885] registered taskstats version 1
    [ 1.877277] rtc_cmos 00:04: setting system clock to 2008-09-12 10:14:42 UTC (1221214482)
    [ 1.878104] Freeing unused kernel memory: 244k freed
    [ 1.899347] input: AT Translated Set 2 keyboard as /class/input/input0
    [ 2.194793] ACPI: CPU0 (power states: C1[C1] C2[C2])
    [ 2.195121] ACPI: ACPI0007:00 is registered as cooling_device0
    [ 2.196271] ACPI: Processor [CPU0] (supports 2 throttling states)
    [ 3.089342] No dock devices found.
    [ 3.243715] SCSI subsystem initialized
    [ 3.458141] libata version 3.00 loaded.
    [ 3.526511] usbcore: registered new interface driver usbfs
    [ 3.526655] usbcore: registered new interface driver hub
    [ 3.526801] usbcore: registered new device driver usb
    [ 3.559666] USB Universal Host Controller Interface driver v3.0
    [ 3.560900] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
    [ 3.560976] PCI: setting IRQ 10 as level-triggered
    [ 3.560985] ACPI: PCI Interrupt 0000:00:07.2[D] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10
    [ 3.561153] uhci_hcd 0000:00:07.2: UHCI Host Controller
    [ 3.561510] uhci_hcd 0000:00:07.2: new USB bus registered, assigned bus number 1
    [ 3.561634] uhci_hcd 0000:00:07.2: irq 10, io base 0x0000a400
    [ 3.561951] usb usb1: configuration #1 chosen from 1 choice
    [ 3.562087] hub 1-0:1.0: USB hub found
    [ 3.562168] hub 1-0:1.0: 2 ports detected
    [ 3.664587] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
    [ 3.664672] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [ 3.664749] usb usb1: Product: UHCI Host Controller
    [ 3.664810] usb usb1: Manufacturer: Linux 2.6.26-1-686 uhci_hcd
    [ 3.664874] usb usb1: SerialNumber: 0000:00:07.2
    [ 3.665080] ACPI: PCI Interrupt 0000:00:07.3[D] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10
    [ 3.665247] uhci_hcd 0000:00:07.3: UHCI Host Controller
    [ 3.665396] uhci_hcd 0000:00:07.3: new USB bus registered, assigned bus number 2
    [ 3.665509] uhci_hcd 0000:00:07.3: irq 10, io base 0x0000a800
    [ 3.665809] usb usb2: configuration #1 chosen from 1 choice
    [ 3.665945] hub 2-0:1.0: USB hub found
    [ 3.666020] hub 2-0:1.0: 2 ports detected
    [ 3.768387] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
    [ 3.768474] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [ 3.768553] usb usb2: Product: UHCI Host Controller
    [ 3.768613] usb usb2: Manufacturer: Linux 2.6.26-1-686 uhci_hcd
    [ 3.768676] usb usb2: SerialNumber: 0000:00:07.3
    [ 3.769859] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 12
    [ 3.769931] PCI: setting IRQ 12 as level-triggered
    [ 3.769940] ACPI: PCI Interrupt 0000:00:0a.0[A] -> Link [LNKD] -> GSI 12 (level, low) -> IRQ 12
    [ 3.770105] uhci_hcd 0000:00:0a.0: UHCI Host Controller
    [ 3.770278] uhci_hcd 0000:00:0a.0: new USB bus registered, assigned bus number 3
    [ 3.770390] uhci_hcd 0000:00:0a.0: irq 12, io base 0x0000b400
    [ 3.770691] usb usb3: configuration #1 chosen from 1 choice
    [ 3.770827] hub 3-0:1.0: USB hub found
    [ 3.770907] hub 3-0:1.0: 2 ports detected
    [ 3.872432] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
    [ 3.872519] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [ 3.872596] usb usb3: Product: UHCI Host Controller
    [ 3.872655] usb usb3: Manufacturer: Linux 2.6.26-1-686 uhci_hcd
    [ 3.872719] usb usb3: SerialNumber: 0000:00:0a.0
    [ 3.872871] ACPI: PCI Interrupt 0000:00:0a.1[B] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10
    [ 3.873041] uhci_hcd 0000:00:0a.1: UHCI Host Controller
    [ 3.873166] uhci_hcd 0000:00:0a.1: new USB bus registered, assigned bus number 4
    [ 3.873280] uhci_hcd 0000:00:0a.1: irq 10, io base 0x0000b800
    [ 3.873601] usb usb4: configuration #1 chosen from 1 choice
    [ 3.873738] hub 4-0:1.0: USB hub found
    [ 3.873822] hub 4-0:1.0: 2 ports detected
    [ 3.925412] 8139too Fast Ethernet driver 0.9.28
    [ 3.976429] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
    [ 3.976514] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [ 3.976591] usb usb4: Product: UHCI Host Controller
    [ 3.976650] usb usb4: Manufacturer: Linux 2.6.26-1-686 uhci_hcd
    [ 3.976714] usb usb4: SerialNumber: 0000:00:0a.1
    [ 3.978019] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
    [ 3.978095] PCI: setting IRQ 11 as level-triggered
    [ 3.978102] ACPI: PCI Interrupt 0000:00:09.0[A] -> Link [LNKC] -> GSI 11 (level, low) -> IRQ 11
    [ 3.979213] eth0: RealTek RTL8139 at 0xb000, 00:05:1c:04:cf:92, IRQ 11
    [ 3.979282] eth0: Identified 8139 chip type 'RTL-8139C'
    [ 3.996569] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 5
    [ 3.996650] PCI: setting IRQ 5 as level-triggered
    [ 3.996659] ACPI: PCI Interrupt 0000:00:0a.2[C] -> Link [LNKB] -> GSI 5 (level, low) -> IRQ 5
    [ 3.996835] ehci_hcd 0000:00:0a.2: EHCI Host Controller
    [ 3.997009] ehci_hcd 0000:00:0a.2: new USB bus registered, assigned bus number 5
    [ 3.997173] ehci_hcd 0000:00:0a.2: irq 5, io mem 0xda001000
    [ 4.013866] Uniform Multi-Platform E-IDE driver
    [ 4.013946] ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
    [ 4.030982] 8139cp: 10/100 PCI Ethernet driver v1.3 (Mar 22, 2004)
    [ 4.032823] ehci_hcd 0000:00:0a.2: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
    [ 4.033193] usb usb5: configuration #1 chosen from 1 choice
    [ 4.033335] hub 5-0:1.0: USB hub found
    [ 4.033415] hub 5-0:1.0: 4 ports detected
    [ 4.136427] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
    [ 4.136512] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [ 4.136589] usb usb5: Product: EHCI Host Controller
    [ 4.136649] usb usb5: Manufacturer: Linux 2.6.26-1-686 ehci_hcd
    [ 4.136713] usb usb5: SerialNumber: 0000:00:0a.2
    [ 4.137796] VP_IDE: IDE controller (0x1106:0x0571 rev 0x06) at PCI slot 0000:00:07.1
    [ 4.137926] VP_IDE: not 100% native mode: will probe irqs later
    [ 4.138030] VP_IDE: VIA vt82c686b (rev 40) IDE UDMA100 controller on pci0000:00:07.1
    [ 4.138122] ide0: BM-DMA at 0xa000-0xa007
    [ 4.138195] ide1: BM-DMA at 0xa008-0xa00f
    [ 4.138259] Probing IDE interface ide0...
    [ 4.218010] Floppy drive(s): fd0 is 1.44M
    [ 4.235905] FDC 0 is a post-1991 82077
    [ 4.288137] usb 2-2: new full speed USB device using uhci_hcd and address 2
    [ 4.452736] usb 2-2: configuration #1 chosen from 1 choice
    [ 4.458903] usb 2-2: New USB device found, idVendor=05e3, idProduct=0502
    [ 4.458992] usb 2-2: New USB device strings: Mfr=0, Product=1, SerialNumber=0
    [ 4.459066] usb 2-2: Product: USB Host To Host Bridge
    [ 4.552315] hda: Maxtor 91021U2, ATA DISK drive
    [ 4.948033] Marking TSC unstable due to: TSC halts in idle.
    [ 5.227181] hda: host max PIO5 wanted PIO255(auto-tune) selected PIO4
    [ 5.227408] hda: host side 80-wire cable detection failed, limiting max speed to UDMA33
    [ 5.227500] hda: UDMA/33 mode selected
    [ 5.227768] Probing IDE interface ide1...
    [ 5.392979] usb 3-2: new low speed USB device using uhci_hcd and address 2
    [ 5.567822] usb 3-2: configuration #1 chosen from 1 choice
    [ 5.576265] usb 3-2: New USB device found, idVendor=046d, idProduct=c00e
    [ 5.576348] usb 3-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
    [ 5.576420] usb 3-2: Product: USB-PS/2 Optical Mouse
    [ 5.576482] usb 3-2: Manufacturer: Logitech
    [ 5.648263] usbcore: registered new interface driver hiddev
    [ 5.662384] input: Logitech USB-PS/2 Optical Mouse as /class/input/input1
    [ 5.664342] input,hidraw0: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:0a.0-2
    [ 5.664637] usbcore: registered new interface driver usbhid
    [ 5.664704] usbhid: v2.6:USB HID core driver
    [ 6.088257] hdc: AOPEN CD-RW CRW2040, ATAPI CD/DVD-ROM drive
    [ 6.872257] hdd: CDU5211, ATAPI CD/DVD-ROM drive
    [ 6.928187] hdc: host max PIO5 wanted PIO255(auto-tune) selected PIO4
    [ 6.928383] hdc: MWDMA2 mode selected
    [ 6.928805] hdd: host max PIO5 wanted PIO255(auto-tune) selected PIO4
    [ 6.928881] hdd: UDMA/33 mode selected
    [ 6.929087] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
    [ 6.929227] ide1 at 0x170-0x177,0x376 on irq 15
    [ 7.045833] hda: max request size: 128KiB
    [ 7.049017] hda: 20010816 sectors (10245 MB) w/512KiB Cache, CHS=19852/16/63
    [ 7.049171] hda: cache flushes not supported
    [ 7.049352] hda: hda1 hda2 hda3 < hda5 hda6 hda7 >
    [ 7.128261] hdc: ATAPI 40X CD-ROM CD-R/RW drive, 2048kB Cache
    [ 7.128507] Uniform CD-ROM driver Revision: 3.20
    [ 7.136119] hdd: ATAPI 52X CD-ROM drive, 120kB Cache
    [ 7.171277] hdc: status error: status=0x59 { DriveReady SeekComplete DataRequest Error }
    [ 7.171543] hdc: status error: error=0x20 { LastFailedSense=0x02 }
    [ 7.171708] ide: failed opcode was: unknown
    [ 7.171806] hdc: drive not ready for command
    [ 22.384476] kjournald starting. Commit interval 5 seconds
    [ 22.384476] EXT3-fs: mounted filesystem with ordered data mode.
    [ 24.880975] udevd version 125 started
    [ 25.610720] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.610948] ide: failed opcode was: unknown
    [ 25.611049] hdc: drive not ready for command
    [ 25.611143] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.611351] ide: failed opcode was: unknown
    [ 25.612526] hdc: drive not ready for command
    [ 25.612612] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.612818] ide: failed opcode was: unknown
    [ 25.612908] hdc: drive not ready for command
    [ 25.612966] hdc: weird block size 0
    [ 25.613019] hdc: default to 2kb block size
    [ 25.613101] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.613310] ide: failed opcode was: unknown
    [ 25.613399] hdc: drive not ready for command
    [ 25.613482] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.613690] ide: failed opcode was: unknown
    [ 25.613798] hdc: drive not ready for command
    [ 25.613884] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.614090] ide: failed opcode was: unknown
    [ 25.614179] hdc: drive not ready for command
    [ 25.614265] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.614470] ide: failed opcode was: unknown
    [ 25.614560] hdc: drive not ready for command
    [ 25.614643] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.614847] ide: failed opcode was: unknown
    [ 25.614936] hdc: drive not ready for command
    [ 25.616893] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.617151] ide: failed opcode was: unknown
    [ 25.617265] hdc: drive not ready for command
    [ 25.620042] hdc: status error: status=0x58 { DriveReady SeekComplete DataRequest }
    [ 25.620042] ide: failed opcode was: unknown
    [ 25.620203] hdc: drive not ready for command
    [ 28.279095] parport_pc: VIA 686A/8231 detected
    [ 28.279105] parport_pc: probing current configuration
    [ 28.279130] parport_pc: Current parallel port base: 0x378
    [ 28.279186] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE,EPP]
    [ 28.329610] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
    [ 28.375878] parport_pc: VIA parallel port: io=0x378, irq=7
    [ 28.383694] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
    [ 28.404478] Linux agpgart interface v0.103
    [ 28.440089] agpgart: Detected VIA Twister-K/KT133x/KM133 chipset
    [ 28.446566] agpgart: AGP aperture is 64M @ 0xd0000000
    [ 29.608405] usb0: register 'gl620a' at usb-0000:00:07.3-2, Genesys GeneLink, ee:0e:32:fb:d4:76
    [ 29.608539] usbcore: registered new interface driver gl620a
    [ 29.624785] input: Power Button (FF) as /class/input/input2
    [ 29.653902] ACPI: Power Button (FF) [PWRF]
    [ 29.654169] input: Power Button (CM) as /class/input/input3
    [ 29.676479] ACPI: Power Button (CM) [PWRB]
    [ 29.676744] input: Sleep Button (CM) as /class/input/input4
    [ 29.706978] ACPI: Sleep Button (CM) [SLPB]
    [ 31.025861] input: PC Speaker as /class/input/input5
    [ 31.344882] ACPI: PCI Interrupt 0000:00:0e.0[A] -> Link [LNKD] -> GSI 12 (level, low) -> IRQ 12
    [ 31.701326] gameport: EMU10K1 is pci0000:00:0e.1/gameport0, io 0xc000, speed 1242kHz
    [ 32.059902] Error: Driver 'pcspkr' is already registered, aborting...
    [ 34.299257] Adding 489940k swap on /dev/hda1. Priority:-1 extents:1 across:489940k
    [ 34.795297] EXT3 FS on hda2, internal journal
    [ 35.425632] loop: module loaded
    [ 36.693281] kjournald starting. Commit interval 5 seconds
    [ 36.693685] EXT3 FS on hda5, internal journal
    [ 36.693787] EXT3-fs: mounted filesystem with ordered data mode.
    [ 36.731289] kjournald starting. Commit interval 5 seconds
    [ 36.731672] EXT3 FS on hda6, internal journal
    [ 36.731771] EXT3-fs: mounted filesystem with ordered data mode.
    [ 38.702907] eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
    [ 38.750239] NET: Registered protocol family 10
    [ 38.751532] lo: Disabled Privacy Extensions
    [ 41.934858] nf_conntrack version 0.5.0 (4096 buckets, 16384 max)
    [ 42.283154] ip_tables: (C) 2000-2006 Netfilter Core Team
    [ 46.362120] lp0: using parport0 (interrupt-driven).
    [ 46.429524] ppdev: user-space parallel port driver
    [ 48.820075] eth0: no IPv6 routers present
    [ 50.188621] warning: `ntpd' uses 32-bit capabilities (legacy support in use)


    Note: Between 7.171806 and 22.384476 there is the huge waiting time, which
    I reduced by modifying one of the file in the initramfs.



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  4. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    On Thu, 11 Sep 2008, maximilian attems wrote:

    > this looks more like a kernel bug,


    One detail I've just noticed: After the boot, the eject button of /dev/hdc
    does not work at all. This didn't happen with etch.



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  5. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    reassign 498645 linux-2.6
    stop

    On Fri, Sep 12, 2008 at 02:25:21PM +0200, Santiago Vila wrote:
    > On Thu, 11 Sep 2008, maximilian attems wrote:
    >
    > > this looks more like a kernel bug,

    >
    > One detail I've just noticed: After the boot, the eject button of /dev/hdc
    > does not work at all. This didn't happen with etch.


    this was my next question which was the last 2.6.XX image that
    was known working on that box?

    --
    maks



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  6. Processed: Re: Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    Processing commands for control@bugs.debian.org:

    > reassign 498645 linux-2.6

    Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)
    Bug reassigned from package `initramfs-tools' to `linux-2.6'.

    > stop

    Stopping processing here.

    Please contact me if you need assistance.

    Debian bug tracking system administrator
    (administrator, Debian Bugs database)


    --
    To UNSUBSCRIBE, email to debian-kernel-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  7. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    On Fri, 12 Sep 2008, maximilian attems wrote:

    > reassign 498645 linux-2.6
    > stop
    >
    > On Fri, Sep 12, 2008 at 02:25:21PM +0200, Santiago Vila wrote:
    > > On Thu, 11 Sep 2008, maximilian attems wrote:
    > >
    > > > this looks more like a kernel bug,

    > >
    > > One detail I've just noticed: After the boot, the eject button of /dev/hdc
    > > does not work at all. This didn't happen with etch.

    >
    > this was my next question which was the last 2.6.XX image that
    > was known working on that box?


    After a few checks, the one in etch, unfortunately. To summarize:

    linux-image-2.6.18-6-686 version 2.6.18.dfsg.1-22etch2 works ok
    linux-image-2.6.20-1-686 version 2.6.20-3 does not work
    linux-image-2.6.26-1-686 version 2.6.26-5 does not work

    [ The 2.6.20 image was taken somewhere from snapshot.debian.net ]

    Should I try 2.6.19 from kernel.org now?



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  8. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    On Fri, Sep 12, 2008 at 04:19:24PM +0200, Santiago Vila wrote:
    > linux-image-2.6.18-6-686 version 2.6.18.dfsg.1-22etch2 works ok
    > linux-image-2.6.20-1-686 version 2.6.20-3 does not work
    > linux-image-2.6.26-1-686 version 2.6.26-5 does not work
    >
    > [ The 2.6.20 image was taken somewhere from snapshot.debian.net ]
    >
    > Should I try 2.6.19 from kernel.org now?


    yes please, also please file with result upstream in bugzilla.kernel.org
    and mark the bug with forward

    thanks

    --
    maks



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

  9. Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

    On Fri, 12 Sep 2008, maximilian attems wrote:

    > On Fri, Sep 12, 2008 at 04:19:24PM +0200, Santiago Vila wrote:
    > > linux-image-2.6.18-6-686 version 2.6.18.dfsg.1-22etch2 works ok
    > > linux-image-2.6.20-1-686 version 2.6.20-3 does not work
    > > linux-image-2.6.26-1-686 version 2.6.26-5 does not work
    > >
    > > [ The 2.6.20 image was taken somewhere from snapshot.debian.net ]
    > >
    > > Should I try 2.6.19 from kernel.org now?

    >
    > yes please, also please file with result upstream in bugzilla.kernel.org
    > and mark the bug with forward


    Ok. Did a git-bisect and then I've reported this upstream:

    http://bugzilla.kernel.org/show_bug.cgi?id=11581

    I don't know how to mark this as "forwarded" properly.
    Could you do that, please?

    Thanks.



    --
    To UNSUBSCRIBE, email to debian-bugs-dist-REQUEST@lists.debian.org
    with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org

+ Reply to Thread