Hi All,
The kernel issue is under study right now. I got some boot informations
from "demsg", please check the attached file. we can see the kernel is
doing for what at boot time.
here are some interesting places for kernel at boot time:
1. Mount filesystem needs 3.6secs:
[ 3.265000] CRCFAIL 0x1a3f
>> [ 3.265000] Current Request Command:5, ARG:0x00000000
flags: 0x0008
>> [ 6.805000] VFS: Mounted root (jffs2 filesystem).
[ 6.805000] Freeing init memory: 124K
[ 6.935000] CRCFAIL 0x1a3f
2. Framebuffer and console stuffs need 0.5 sec:
[ 1.010000] SMEDIA Glamo frame buffer driver (C) 2007 Openmoko, Inc.
[ 1.610000] Console: switching to colour frame buffer device 80x58
3. sdio_wlan needs 1 sec or ?:
[ 7.010000] sdio_wlan 00:01: driver attached
[ 7.010000] sdio_wlan 00:01: SDIO device, IDs SD_0001 (active)
[ 8.090000] Unsupported configuration opcode: 3
[ 8.090000] Unsupported configuration opcode: 5
4. ar6000 needs 1 sec or?
[ 8.225000] ar6000_avail: name=eth0 htcTarget=0xc7f46000,
dev=0xc74b0000 (0), ar=0xc74b04a0
[ 9.205000] PM: Removing info for No Bus:vcs1
[ 9.210000] PM: Removing info for No Bus:vcsa1
[ 9.215000] PM: Removing info for No Bus:vcs1
[ 9.215000] PM: Removing info for No Bus:vcsa1
[ 9.305000] PM: Removing info for No Bus:vcs1
[ 9.310000] PM: Removing info for No Bus:vcsa1
[ 9.315000] PM: Removing info for No Bus:vcs1
[ 9.315000] PM: Removing info for No Bus:vcsa1
[ 9.320000] PM: Removing info for No Bus:vcs1
[ 9.325000] PM: Removing info for No Bus:vcsa1
Cheers,
Fred
於 二，2008-07-08 於 20:42 +1000，Carsten Haitzler 提到：
> On Sun, 06 Jul 2008 10:29:20 +0100 Andy Green <[EMAIL PROTECTED]> babbled:
>
> > -----BEGIN PGP SIGNED MESSAGE-----
> > Hash: SHA1
> >
> > Somebody in the thread at some point said:
> > | after collect informations, we can sum up the most important issues for
> > | boot time:
> >
> > Hey bootchart is really good step to understand and measure the real
> > issues, nice work.
> >
> > | 1. initializing kernel(9 secs)
> >
> > What actually does that, JFFS2 mount? I use ext2 on SD card, there is
> > no 9 second delay there.
>
> i think so - jffs2 and flash IO. our flash is abysmally slow. i am amazed how
> slow it is... is there something perhaps wrong with how we drive it?
>
> > | 2. initializing boot splash (exquisite/exquisite-write) (8 secs)
> > | 3. udev (udev/udevd) (29 secs)
> >
> > mdev on busybox is possible replacement.
> >
> > | 4. updating dynamic library cache will waste a lot of time (ldconfig)
> > | (18secs)
> >
> > I already mentioned this some weeks ago, I took it out on the DM2 boot
> > here and it makes a big difference. And most of the time, it is doing
> > nothing at all.
> >
> > - -Andy
> > -----BEGIN PGP SIGNATURE-----
> > Version: GnuPG v1.4.9 (GNU/Linux)
> > Comment: Using GnuPG with Fedora - http://enigmail.mozdev.org
> >
> > iEYEARECAAYFAkhwkHAACgkQOjLpvpq7dMo6dwCeIV/lmzHaXavthGsQpXMBsdSK
> > wd0AnjLL1AKtOHiAebdrbJ2psC5cXtO1
> > =4+Ya
> > -----END PGP SIGNATURE-----
> >
>
>
20000] Bluetooth: Core ver 2.11
[ 0.620000] NET: Registered protocol family 31
[ 0.620000] Bluetooth: HCI device and connection manager initialized
[ 0.625000] Bluetooth: HCI socket layer initialized
[ 0.625000] pnp: the driver 'system' has been registered
[ 0.645000] NET: Registered protocol family 2
[ 0.695000] IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.700000] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.700000] TCP bind hash table entries: 4096 (order: 5, 147456 bytes)
[ 0.705000] TCP: Hash tables configured (established 4096 bind 4096)
[ 0.705000] TCP reno registered
[ 0.725000] s3c24xx_pwm s3c24xx_pwm.0: s3c24xx_pwm is registered
[ 0.725000] Enabling FIQ using irq 29
[ 0.725000] not changing prescaler of PWM 3, since it's shared with timer4 (clock tick)
[ 0.730000] NetWinder Floating Point Emulator V0.97 (double precision)
[ 0.730000] neo1973-version neo1973-version.0: starting
[ 0.730000] neo1973-pm-host neo1973-pm-host.0: starting
[ 0.740000] neo1973-resume neo1973-resume.0: starting
[ 0.755000] JFFS2 version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc.
[ 0.760000] io scheduler noop registered
[ 0.760000] io scheduler deadline registered (default)
[ 0.795000] s3c2440-uart.0: s3c2410_serial0 at MMIO 0x50000000 (irq = 70) is a S3C2440
[ 0.800000] s3c2440-uart.1: s3c2410_serial1 at MMIO 0x50004000 (irq = 73) is a S3C2440
[ 0.800000] s3c2440-uart.2: s3c2410_serial2 at MMIO 0x50008000 (irq = 76) is a S3C2440
[ 0.830000] RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize
[ 0.845000] glamo3362 glamo3362.0: Detected Glamo core 3650 Revision 0002 (49119232Hz CPU / 81887232Hz Memory)
[ 0.885000] glamo3362 glamo3362.0: Glamo core now 49119232Hz CPU / 81887232Hz Memory)
[ 0.885000] Detected S-Media IRQ# pullup, enabling interrupt
[ 0.980000] glamo-spi-gpio glamo-spi-gpio.0: registering c0389570: jbt6k74
[ 1.010000] SMEDIA Glamo frame buffer driver (C) 2007 Openmoko, Inc.
[ 1.610000] Console: switching to colour frame buffer device 80x58
[ 1.700000] fb0: SMedia Glamo frame buffer device
[ 1.705000] glamo-mci glamo-mci.0: glamo_mci driver (C)2007 Openmoko, Inc
[ 1.705000] glamo-mci glamo-mci.0: probe: mapped mci_base:c8864400 irq:0.
[ 1.710000] glamo-mci glamo-mci.0: glamo_mci_set_ios: power down.
[ 1.710000] glamo-mci glamo-mci.0: initialisation done.
[ 1.710000] mmc_set_power(power_mode=1, vdd=20
[ 1.715000] physmap platform flash device: 00200000 at 18000000
[ 1.715000] physmap-flash.0: Found 1 x16 devices at 0x0 in 16-bit bank
[ 1.715000] Intel/Sharp Extended Query Table at 0x0039
[ 1.715000] Intel/Sharp Extended Query Table at 0x0039
[ 1.715000] Intel/Sharp Extended Query Table at 0x0039
[ 1.715000] Intel/Sharp Extended Query Table at 0x0039
[ 1.715000] Intel/Sharp Extended Query Table at 0x0039
[ 1.715000] cfi_cmdset_0001: Erase suspend on write enabled
[ 1.715000] erase region 0: offset=0x0,size=0x2000,blocks=8
[ 1.715000] erase region 1: offset=0x10000,size=0x10000,blocks=31
[ 1.720000] physmap-flash.0: 1 set(s) of 1 interleaved chips --> 4 partitions of 512 KiB
[ 1.720000] RedBoot partition parsing not available
[ 1.725000] S3C24XX NAND Driver, (c) 2004 Simtec Electronics
[ 1.730000] s3c2410_nand_probe(c0389c50)
[ 1.730000] s3c2440-nand s3c2440-nand: mapped registers at c8a00000
[ 1.730000] result 3 from 100000, 20
[ 1.730000] result 7 from 100000, 60
[ 1.730000] result 3 from 100000, 20
[ 1.730000] s3c2440-nand s3c2440-nand: Tacls=3, 30ns Twrph0=7 70ns, Twrph1=3 30ns
[ 1.730000] s3c2440-nand s3c2440-nand: NF_CONF is 0x2620
[ 1.730000] initialising set 0 (c7d62c00, info c7d3fae0)
[ 1.730000] NAND device: Manufacturer ID: 0xec, Chip ID: 0xaa (Samsung NAND 256MiB 1,8V 8-bit)
[ 1.730000] s3c2410_nand_update_chip: chip c7d62cb8: 11
[ 1.730000] Bad block table found at page 131008, version 0x01
[ 1.730000] Bad block table found at page 130944, version 0x01
[ 1.730000] nand_read_bbt: Bad block at 0x00b80000
[ 1.730000] nand_read_bbt: Bad block at 0x06320000
[ 1.730000] nand_read_bbt: Bad block at 0x07ee0000
[ 1.730000] nand_read_bbt: Bad block at 0x0aaa0000
[ 1.735000] 6 cmdlinepart partitions found on MTD device neo1973-nand
[ 1.735000] Creating 6 MTD partitions on "neo1973-nand":
[ 1.735000] 0x00000000-0x00040000 : "u-boot"
[ 1.740000] 0x00040000-0x00080000 : "u-boot_env"
[ 1.745000] 0x00080000-0x00880000 : "kernel"
[ 1.750000] 0x00880000-0x00920000 : "splash"
[ 1.755000] 0x00920000-0x00960000 : "factory"
[ 1.760000] 0x00960000-0x10000000 : "rootfs"
[ 1.765000] initialised ok
[ 1.770000] spi_s3c24xx_gpio spi_s3c24xx_gpio.1: registering c03894ec: lis302dl
[ 1.775000] spi_s3c24xx_gpio spi_s3c24xx_gpio.1: registering c0389518: lis302dl
[ 1.780000] ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver
[ 1.785000] s3c2410-ohci s3c2410-ohci: S3C24XX OHCI
[ 1.790000] s3c2410-ohci s3c2410-ohci: new USB bus registered, assigned bus number 1
[ 1.795000] s3c2410-ohci s3c2410-ohci: irq 42, io mem 0x49000000
[ 1.860000] usb usb1: configuration #1 chosen from 1 choice
[ 1.865000] hub 1-0:1.0: USB hub found
[ 1.865000] hub 1-0:1.0: 2 ports detected
[ 1.975000] usbcore: registered new interface driver libusual
[ 1.990000] s3c2440-usbgadget s3c2440-usbgadget: S3C2440: increasing FIFO to 128 bytes
[ 1.990000] gta02_udc_command(2)
[ 1.990000] ether gadget: using random self ethernet address
[ 1.990000] ether gadget: using random host ethernet address
[ 2.000000] usb0: Ethernet Gadget, version: May Day 2005
[ 2.000000] usb0: using s3c2410_udc, OUT ep2-bulk IN ep1-bulk STATUS ep3-bulk
[ 2.000000] usb0: MAC ce:c0:f9:11:77:a7
[ 2.000000] usb0: HOST MAC c2:78:a2:24:ef:eb
[ 2.000000] usb0: RNDIS ready
[ 2.000000] gta02_udc_command(1)
[ 2.000000] mice: PS/2 mouse device common for all mice
[ 2.005000] input: Neo1973 Buttons as /devices/platform/neo1973-button.0/input/input0
[ 2.040000] wake enabled for irq 48
[ 2.045000] s3c2410 TouchScreen successfully loaded
[ 2.050000] input: s3c2410 TouchScreen as /devices/virtual/input/input1
[ 2.070000] input: lis302-1 (top) as /devices/virtual/input/input2
[ 2.095000] lis302dl spi0.0: Found lis302-1 (top)
[ 2.095000] input: lis302-2 (bottom) as /devices/virtual/input/input3
[ 2.120000] lis302dl spi0.1: Found lis302-2 (bottom)
[ 2.120000] i2c /dev entries driver
[ 2.125000] s3c2440-i2c s3c2440-i2c: slave address 0x10
[ 2.125000] s3c2440-i2c s3c2440-i2c: bus frequency set to 390 KHz
[ 2.130000] s3c2440-i2c s3c2440-i2c: i2c-0: S3C I2C adapter
[ 2.155000] input: GTA02 PMU events as /devices/platform/s3c2440-i2c/i2c-adapter/i2c-0/0-0073/input/input4
[ 2.225000] glamo-mci glamo-mci.0: powered (vdd = 20) clk: 195kHz div=255 (req: 0kHz). Bus width=0
[ 2.225000] glamo-mci glamo-mci.0: powered (vdd = 20) clk: 195kHz div=255 (req: 195kHz). Bus width=0
[ 2.225000] glamo-mci glamo-mci.0: powered (vdd = 20) clk: 195kHz div=255 (req: 195kHz). Bus width=0
[ 2.230000] glamo-mci glamo-mci.0: powered (vdd = 20) clk: 195kHz div=255 (req: 195kHz). Bus width=0
[ 2.230000] glamo-mci glamo-mci.0: Error after cmd: 0x120
[ 2.230000] glamo-mci glamo-mci.0: Error after cmd: 0x8120
[ 2.235000] glamo-mci glamo-mci.0: Error after cmd: 0x120
[ 2.235000] glamo-mci glamo-mci.0: Error after cmd: 0x8120
[ 2.235000] glamo-mci glamo-mci.0: Error after cmd: 0x120
[ 2.235000] glamo-mci glamo-mci.0: Error after cmd: 0x8120
[ 2.240000] glamo-mci glamo-mci.0: Error after cmd: 0x4120
[ 2.240000] glamo-mci glamo-mci.0: Error after cmd: 0x8120
[ 2.240000] glamo-mci glamo-mci.0: Error after cmd: 0x120
[ 2.240000] glamo-mci glamo-mci.0: Error after cmd: 0x8120
[ 2.240000] mmc_set_power(power_mode=0, vdd=0
[ 2.270000] wake enabled for irq 53
[ 2.270000] pcf50633: dev (254:0)
[ 2.270000] pcf50633 0-0073: rtc core: registered pcf50633 as rtc0
[ 2.310000] glamo-mci glamo-mci.0: glamo_mci_set_ios: power down.
[ 2.360000] neo1973-pm-bt neo1973-pm-bt.0: FIC Neo1973 Bluetooth Power Management: starting
[ 2.530000] neo1973-pm-gps neo1973-pm-gps.0: FIC Neo1973 GPS Power Managerment:starting
[ 2.530000] APM Battery Driver
[ 2.530000] bq27000-battery bq27000-battery.0: BQ27000 Battery Driver (C) 2008 Openmoko, Inc
[ 2.535000] power_supply bat: uevent
[ 2.535000] power_supply bat: No power supply yet
[ 2.535000] power_supply bat: power_supply_changed
[ 2.535000] Bluetooth: HCI USB driver ver 2.9
[ 2.540000] usbcore: registered new interface driver hci_usb
[ 2.545000] S3c2440 SDIO Host controller
[ 2.645000] SDIO BusDriver - SDIO_GetBusOSDevice, registering driver: sdio_s3c24xx_hcd DMAmask: 0x0
[ 2.645000] pnp: the driver 'sdio_s3c24xx_hcd' has been registered
[ 2.650000] mapped channel 0 to 0
[ 2.650000] S3c24xx SDIO: IRQ:37 Detect IRQ:0 DMA channel:0 [EMAIL PROTECTED] [EMAIL PROTECTED] kHz
[ 2.650000] SDIO Bus Driver: HCD:sdio_s3c24xx should set module ptr!
[ 2.650000] sdio_s3c24xx_hcd 00:00: driver attached
[ 2.650000] sdio_s3c24xx_hcd 00:00: SDIO device, IDs SD_0008 (active)
[ 2.650000] pnp: the driver 'sdio_wlan' has been registered
[ 2.660000] Registered led device: neo1973:vibrator
[ 2.665000] Registered led device: gta02-power:orange
[ 2.665000] Registered led device: gta02-power:blue
[ 2.670000] Registered led device: gta02-aux:red
[ 2.670000] usbcore: registered new interface driver usbhid
[ 2.670000] drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver
[ 2.675000] Advanced Linux Sound Architecture Driver Version 1.0.15 (Tue Nov 20 19:16:42 2007 UTC).
[ 2.680000] ASoC version 0.13.1
[ 2.680000] Only GTA01 hardware supported by ASoc driver
[ 2.685000] wm8753: WM8753 Audio Codec 0.16
[ 2.705000] power_supply bat: power_supply_changed_work
[ 2.725000] asoc: WM8753 HiFi <-> s3c24xx-i2s mapping ok
[ 2.730000] asoc: WM8753 Voice <-> Bluetooth mapping ok
[ 2.735000] usb0: full speed config #1: 500 mA, Ethernet Gadget, using CDC Ethernet
[ 2.795000] power_supply bat: power_supply_update_bat_leds 3
[ 2.795000] power_supply bat: uevent
[ 2.795000] power_supply bat: POWER_SUPPLY_NAME=bat
[ 2.795000] power_supply bat: Static prop TYPE=Battery
[ 2.795000] power_supply bat: 11 dynamic props
[ 2.885000] power_supply bat: prop STATUS=Not charging
[ 2.925000] ALSA device list:
[ 2.925000] #0: neo1973-gta02 (WM8753)
[ 2.925000] TCP cubic registered
[ 2.925000] NET: Registered protocol family 1
[ 2.930000] NET: Registered protocol family 17
[ 2.930000] Bridge firewalling registered
[ 2.930000] Bluetooth: L2CAP ver 2.9
[ 2.930000] Bluetooth: L2CAP socket layer initialized
[ 2.930000] Bluetooth: SCO (Voice Link) ver 0.5
[ 2.930000] Bluetooth: SCO socket layer initialized
[ 2.930000] power_supply bat: prop VOLTAGE_NOW=4132000
[ 2.930000] Bluetooth: RFCOMM socket layer initialized
[ 2.930000] Bluetooth: RFCOMM TTY layer initialized
[ 2.935000] Bluetooth: RFCOMM ver 1.8
[ 2.935000] Bluetooth: BNEP (Ethernet Emulation) ver 1.2
[ 2.935000] Bluetooth: BNEP filters: protocol multicast
[ 2.935000] Bluetooth: HIDP (Human Interface Emulation) ver 1.2
[ 2.990000] power_supply bat: prop CURRENT_NOW=0
[ 3.010000] pcf50633 0-0073: setting system clock to 2008-07-09 03:31:56 UTC (1215574316)
[ 3.035000] power_supply bat: prop CHARGE_FULL=1212372
[ 3.055000] Using lowest clock rate
[ 3.085000] power_supply bat: prop TEMP=246
[ 3.085000] power_supply bat: prop TECHNOLOGY=Li-ion
[ 3.100000] power_supply bat: prop PRESENT=1
[ 3.145000] power_supply bat: prop TIME_TO_EMPTY_NOW=3932100
[ 3.190000] power_supply bat: prop TIME_TO_FULL_NOW=3932100
[ 3.190000] power_supply bat: driver failed to report `model_name' property
[ 3.265000] CRCFAIL 0x1a3f
[ 3.265000] CRCFAIL 0x1a3f
[ 3.265000] Current Request Command:5, ARG:0x00000000 flags: 0x0008
[ 6.805000] VFS: Mounted root (jffs2 filesystem).
[ 6.805000] Freeing init memory: 124K
[ 6.935000] CRCFAIL 0x1a3f
[ 6.935000] CRCFAIL 0x1a3f
[ 6.935000] Current Request Command:5, ARG:0x00100000 flags: 0x0008
[ 6.955000] CRCFAIL 0x1a3f
[ 6.955000] CRCFAIL 0x1a3f
[ 6.955000] Current Request Command:5, ARG:0x00100000 flags: 0x0008
[ 7.010000] sdio_wlan 00:01: driver attached
[ 7.010000] sdio_wlan 00:01: SDIO device, IDs SD_0001 (active)
[ 8.090000] Unsupported configuration opcode: 3
[ 8.090000] Unsupported configuration opcode: 5
[ 8.100000] ar6000_available
[ 8.110000] BMI Get Target Info: Exit (ver: 0x20000059 type: 0x1)
[ 8.115000] Block Size Set: 128 (target address:0x8000066C)
[ 8.125000] ar6000_init() Got WMI @ 0xc7e3a200.
[ 8.175000] SDIO_INT_CTRL enable IRQ
[ 8.185000] mac address = 00:12:cf:74:21:03
[ 8.190000] ar6000_init() WMI is ready
[ 8.190000] AR6000 Reg Code = 0x40000060
[ 8.225000] ar6000_avail: name=eth0 htcTarget=0xc7f46000, dev=0xc74b0000 (0), ar=0xc74b04a0
[ 9.205000] PM: Removing info for No Bus:vcs1
[ 9.210000] PM: Removing info for No Bus:vcsa1
[ 9.215000] PM: Removing info for No Bus:vcs1
[ 9.215000] PM: Removing info for No Bus:vcsa1
[ 9.305000] PM: Removing info for No Bus:vcs1
[ 9.310000] PM: Removing info for No Bus:vcsa1
[ 9.315000] PM: Removing info for No Bus:vcs1
[ 9.315000] PM: Removing info for No Bus:vcsa1
[ 9.320000] PM: Removing info for No Bus:vcs1
[ 9.325000] PM: Removing info for No Bus:vcsa1
[ 20.475000] power_supply bat: uevent
[ 20.475000] power_supply bat: POWER_SUPPLY_NAME=bat
[ 20.475000] power_supply bat: Static prop TYPE=Battery
[ 20.475000] power_supply bat: 11 dynamic props
[ 20.535000] power_supply bat: prop STATUS=Charging
[ 20.580000] power_supply bat: prop VOLTAGE_NOW=4153000
[ 20.640000] power_supply bat: prop CURRENT_NOW=-133125
[ 20.685000] power_supply bat: prop CHARGE_FULL=1212372
[ 20.730000] power_supply bat: prop TEMP=248
[ 20.730000] power_supply bat: prop TECHNOLOGY=Li-ion
[ 20.745000] power_supply bat: prop PRESENT=1
[ 20.790000] power_supply bat: prop TIME_TO_EMPTY_NOW=3932100
[ 20.835000] power_supply bat: prop TIME_TO_FULL_NOW=1440
[ 20.835000] power_supply bat: driver failed to report `model_name' property
[ 76.980000] PM: Removing info for No Bus:vcs2
[ 76.985000] PM: Removing info for No Bus:vcsa2
[ 77.470000] PM: Removing info for No Bus:vcs2
[ 77.470000] PM: Removing info for No Bus:vcsa2
[ 117.940000] power_supply bat: uevent
[ 117.940000] power_supply bat: POWER_SUPPLY_NAME=bat
[ 117.940000] power_supply bat: Static prop TYPE=Battery
[ 117.940000] power_supply bat: 11 dynamic props
[ 118.000000] power_supply bat: prop STATUS=Charging
[ 118.045000] power_supply bat: prop VOLTAGE_NOW=4156000
[ 118.105000] power_supply bat: prop CURRENT_NOW=-104062
[ 118.150000] power_supply bat: prop CHARGE_FULL=1212372
[ 118.200000] power_supply bat: prop TEMP=253
[ 118.200000] power_supply bat: prop TECHNOLOGY=Li-ion
[ 118.215000] power_supply bat: prop PRESENT=1
[ 118.260000] power_supply bat: prop TIME_TO_EMPTY_NOW=3932100
[ 118.305000] power_supply bat: prop TIME_TO_FULL_NOW=0
[ 118.305000] power_supply bat: driver failed to report `model_name' property
[ 127.355000] JFFS2 notice: (1019) check_node_data: wrong data CRC in data node at 0x0d8ecbf4: read 0xe2f40bc0, calculated 0xbb9d9c6a.
