Re: One minute delay when booting 2.6.24.1

Previous thread: [PATCH 8/8] kgdb: kgdboc 8250 I/O module by jason.wessel on Saturday, February 9, 2008 - 9:35 am. (1 message)

Next thread: acer aspire 5720ZG APIC error on CPU0: 40(40) ACPI/USB by Mr Souissi on Saturday, February 9, 2008 - 10:59 am. (1 message)
To: <linux-kernel@...>
Date: Saturday, February 9, 2008 - 9:29 am

Hi all,

As the subject says I get ~1 minute delay when booting 2.6.24.1 pretty
reliably. It is possible it is not new to 2.6.24.1 but I can't tell due recent
hardware changes.

I don't know who in particular to CC about this so I'll just send it like this
in hope someone notices it. :)

Tvrtko

dmesg excerpt where it happens looks like this (full one attached):

[ 16.927370] checking if image is initramfs... it is
[ 17.171242] Switched to high resolution mode on CPU 1
[ 17.171754] Switched to high resolution mode on CPU 0
[ 17.293466] Freeing initrd memory: 4807k freed
[ 17.297669] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 17.297673] io scheduler noop registered
[ 17.297674] io scheduler anticipatory registered
[ 17.297675] io scheduler deadline registered
[ 17.297741] io scheduler cfq registered (default)
[ 80.466114] Boot video device is 0000:00:10.0
[ 80.466228] PCI: Setting latency timer of device 0000:00:0b.0 to 64

Hardware is:

00:00.0 Host bridge: nVidia Corporation Unknown device 07c1 (rev a2)
00:00.1 RAM memory: nVidia Corporation Unknown device 07cb (rev a2)
00:01.0 RAM memory: nVidia Corporation Unknown device 07cd (rev a1)
00:01.1 RAM memory: nVidia Corporation Unknown device 07ce (rev a1)
00:01.2 RAM memory: nVidia Corporation Unknown device 07cf (rev a1)
00:01.3 RAM memory: nVidia Corporation Unknown device 07d0 (rev a1)
00:01.4 RAM memory: nVidia Corporation Unknown device 07d1 (rev a1)
00:01.5 RAM memory: nVidia Corporation Unknown device 07d2 (rev a1)
00:01.6 RAM memory: nVidia Corporation Unknown device 07d3 (rev a1)
00:02.0 RAM memory: nVidia Corporation Unknown device 07d6 (rev a1)
00:03.0 ISA bridge: nVidia Corporation Unknown device 07d7 (rev a2)
00:03.1 SMBus: nVidia Corporation Unknown device 07d8 (rev a1)
00:03.2 RAM memory: nVidia Corporation Unknown device 07d9 (rev a1)
00:03.4 RAM memory: nVidia Corporation Unknown device 07c8 (rev a1)
00:04.0 USB Controller: nVidia Corporation Unknown devic...

To: Tvrtko A. Ursulin <tvrtko@...>
Cc: <linux-kernel@...>
Date: Saturday, February 9, 2008 - 6:01 pm

Do you really experience a 1 minute wait, or is this perhaps
just the clock skipping?

--

To: Jan Engelhardt <jengelh@...>
Cc: <linux-kernel@...>, <mingo@...>, <tglx@...>, Tvrtko Ursulin <tvrtko.ursulin@...>
Date: Tuesday, February 12, 2008 - 4:33 am

This seemed to slipped everyone's attention so I took the liberty of copying a
couple of you guys. I don't know better than to guess it could something to
do with timers or scheduling so apologies if you are not the right people.

As said in my previous reply it is a real ~60 second delay early in the boot
process with some logs attached in my initial report.

Thanks,

Tvrtko
--

To: Tvrtko A. Ursulin <tvrtko@...>
Cc: Jan Engelhardt <jengelh@...>, <linux-kernel@...>, <mingo@...>, <tglx@...>
Date: Monday, February 25, 2008 - 9:11 am

--=-/lupvHXrnRqc0eJcGiuO
Content-Type: text/plain; charset=UTF-8
Content-Transfer-Encoding: quoted-printable

Le mardi 12 f=C3=A9vrier 2008 =C3=A0 08:33 +0000, Tvrtko A. Ursulin a =C3=

Hello,

I've already reported the same issue.
With 2.6.24, udevsettle seems to be the culprit.
Anyone can please confirm ?
Thanks.

--=20
Beno=C3=AEt Dejean
GNOME http://www.gnomefr.org/
LibGTop http://directory.fsf.org/libgtop.html

--=-/lupvHXrnRqc0eJcGiuO
Content-Disposition: attachment; filename=bootchart.svgz
Content-Type: image/svg+xml-compressed; name=bootchart.svgz
Content-Transfer-Encoding: base64

H4sIAGS8wkcA/+29/XPjOJIg+nPPX6GtjY2YuWepmPhGdXdd7E7v3U28u5uJ7dn3dXFx4bJVXY5y
2T5LNd29f/0DkCAlASAk0UyqqpflGbNpgkkkgPxEIvO7//jLp/vF39bPm7vHh+9fwap5tdhsrx9u
r+8fH9bfv3p4fPUf3/7uu7/74c9//Ov/+5d/Xmz+9tPiL//6T//1T39cvFq+fv1/8z++fv3DX39Y
/Ph//ecFaxpobCNev/7n//5q8erDdvv05vXrn3/+efUzXz0+//T6r//y2rd5/S///Mele2HZveAg
vHaQoVndbm9fvf2d++Byufjh7tP6wfdrsVy6PvhP/3x3u/3w/Summubpl1eLD+u7nz5s3X2jtb93
uDxsvi982X2p8V9wsL/57nb9fuOu33y32f56v15sf31yiG7Xv2xf32w2r95+93f/448//ONf//F/
uCbfvP4Pix9Dq82H9Xq7+A+v/R/d///n/3z73evwvof4OoJ0//m8vtkufvn+lRvHX8Pv2GVomn/Y
dRjvwvvfv3p/d3//ZvHzh7vt+ttXrxGMx/+/rK9v188L37MwAt98F/6zfevxYbt8f/3p7v7XN4vN
9cNmuVk/373/dhEebO7+bf1mAeJpG//wc/jym8W7x/vbb1/5HgJ2kbFXb//p8XG7uPlw/bx1jZ8X
d+8eHz8ufv/f3Mj/p/W7BZML4G+kfSNg8cd//qufZ/OH7177zvhO/XROj2zoUED475vwz3Vm++wa
uw9/ctPg//P+erv+PTRXCyb+8CrMlB+OH3/dbNefFncPvuX1tl0X38Rhuf3VL1+2/vTq7eeH60/u
W//17uHzLwu2UismVmyJWP09LP764XPAC8QCjMeL2Q6vxdPTTYcafvfPP1a/yVbCf/N5fb++3riv
/rB+d3f9sPjP//1fX2MH7tcPD7++3tzdJnD/+Jd/PQCcQeYr5SG7dm8WN0+fv/nmzUILof/xanF9
v7372/pmsfn89PT4vF3fLn4Pf0jA/5/r54f1/eLm0+393cM6Ay5WxgP/iK0en3wXNm8Wz24lfO+W
899ef7i95u7WdfHO/WXz7u7htRvAbVglt4vn9ebzp3XXUiySr4cVtXUEnH1YrRr/Yf/MLdA3Qu5W
0uufdovfj8794/VtXJa4/n8qLxW3UoA3f0gI6sExsG9x+fS/t5S4wnaEyzwjcf1cQmApHfnu8xu8
2/va8vHp+uZu69Z9s9KyW+FKmZt37FvX8vnx43r3B0flZ9NykXJuPR1L3xk/tEvfY79eFr//7AD8
H5tfN3urYocisOalSO5wvGH6Wl/v4Rj/MC6OPEHyT6//vPj9z9d32/1lH9aP586I6cFq+Pv34d9e
P9eN/0FeWOfW0o/E67iS...

To: <linux-kernel@...>
Date: Thursday, February 14, 2008 - 1:19 pm

--=-Jym2l9P+BLZNtlEwXdEE
Content-Type: text/plain; charset=UTF-8
Content-Transfer-Encoding: quoted-printable

Le mardi 12 f=C3=A9vrier 2008 =C3=A0 08:33 +0000, Tvrtko A. Ursulin a =C3=

I've upgraded from vanilla 2.6.23 to 2.6.24 and get a 34s delay on boot

[ 14.680874] input: HID 05ac:1000
as /devices/pci0001:10/0001:10:1a.0/usb2/2-1/2-1:1.0/input/input5
[ 14.716702] input,hidraw0: USB HID v1.11 Keyboard [HID 05ac:1000] on
usb-0001:10:1a.0-1
[ 14.742128] input: HID 05ac:1000
as /devices/pci0001:10/0001:10:1a.0/usb2/2-1/2-1:1.1/input/input6
[ 14.780009] input,hidraw1: USB HID v1.11 Mouse [HID 05ac:1000] on
usb-0001:10:1a.0-1
[ 14.786938] usbcore: registered new interface driver usbhid
[ 14.793692] drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver
[ 48.279840] hda: UDMA/100 mode selected
[ 49.471289] Adding 1506444k swap on /dev/hda4. Priority:-1 extents:1
across:1506444k
[ 50.955529] [drm] Initialized drm 1.1.0 20060810
[ 51.006960] [drm] Initialized radeon 1.28.0 20060524 on minor 0
[ 51.057858] adt746x: version 1 (supported)
[ 51.064397] adt746x: Thermostat bus: 1, address: 0x2e, limit_adjust:
0, fan_speed: -1
[ 51.070993] sensor 0: PWR/MEMORY BOTTOMSIDE
[ 51.077649] sensor 1: CPU BOTTOMSIDE
[ 51.084210] sensor 2: GPU ON DIE

--=20
Beno=C3=AEt Dejean
GNOME http://www.gnomefr.org/
LibGTop http://directory.fsf.org/libgtop.html

--=-Jym2l9P+BLZNtlEwXdEE
Content-Disposition: attachment; filename=config.gz
Content-Type: application/x-gzip; name=config.gz
Content-Transfer-Encoding: base64

H4sIABMEm0cCA4w8a3PbuK7f91d4unfm7s6c09rOo8nO5ANFUTbXejAk5Ue/aNLE7fo2TXJiZ0/3
31+QkixSIunubFsbAEkQBAEQBP3rL7+O0Nvh+fvdYXd/9/j4z+jr9mn7enfYPoy+333bju6fn77s
vv4xenh++t/DaPuwO0CLdPf09mP0bfv6tH0c/b193e+en/4YTd9fvp+e/3v3+fn5GxCJu8Poz7un
0fRyNBn/cfHxj7Pr0XQ8vvrlV0DiIk/orGIMX56PdvvR0/NhtN8eftFI9vp8v93vn19H+7eXl+dX
GPKXpsHljx83/1jtq6uLHz/MLmykB3c+9sDP3XACnJsIY4iElcBSA0CppEuCO4CiEDKusqx0Aquz
aX9CWVaJlGIinJyIjLkZ0R01X1cFjytBP5Gbs6k5aEb4jHRkFlMzkhNOcYWzQlQli...

To: Benoît <benoit@...>
Cc: <linux-kernel@...>
Date: Thursday, February 14, 2008 - 1:23 pm

Could you please show the output with 'initcall_debug'?

--=20
Jiri Kosina

To: Jan Engelhardt <jengelh@...>
Cc: <linux-kernel@...>
Date: Sunday, February 10, 2008 - 2:51 am

It is a real delay.

Tvrtko
--

Previous thread: [PATCH 8/8] kgdb: kgdboc 8250 I/O module by jason.wessel on Saturday, February 9, 2008 - 9:35 am. (1 message)

Next thread: acer aspire 5720ZG APIC error on CPU0: 40(40) ACPI/USB by Mr Souissi on Saturday, February 9, 2008 - 10:59 am. (1 message)