FAQ Search Today's Posts Mark Forums Read
» Video Reviews

» Linux Archive

Linux-archive is a website aiming to archive linux email lists and to make them easily accessible for linux users/developers.


» Sponsor

» Partners

» Sponsor

Go Back   Linux Archive > Debian > Debian Kernel

 
 
LinkBack Thread Tools
 
Old 09-11-2008, 06:40 PM
Santiago Vila
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 09-11-2008, 09:05 PM
maximilian attems
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 09-12-2008, 10:32 AM
Santiago Vila
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 09-12-2008, 12:25 PM
Santiago Vila
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 09-12-2008, 01:28 PM
maximilian attems
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 09-12-2008, 02:19 PM
Santiago Vila
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 09-12-2008, 02:26 PM
maximilian attems
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 09-17-2008, 11:58 AM
Santiago Vila
 
Default 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-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
 
Old 03-02-2009, 02:17 PM
Oliver Schwank
 
Default Bug#498645: initramfs-tools: Boot takes three minutes to finish (!)

Hello,

I am experiencing the same problem here with the fglrx kernel.
fglrx-kernel-2.6.18-4-686

After updating and start using the Lenny fglrx kernel I have the same
timeout on hda / ide0 with my homebrewn kernel 2.6.27 there is no such
problem.

Bye
--
Oli



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

Thread Tools




All times are GMT. The time now is 11:54 PM.

VBulletin, Copyright ©2000 - 2014, Jelsoft Enterprises Ltd.
Content Relevant URLs by vBSEO ©2007, Crawlability, Inc.
Copyright 2007 - 2008, www.linux-archive.org