boot timings

pgf at laptop.org pgf at laptop.org
Fri Jun 27 15:55:59 EDT 2008


hello -- 

yesterday, as much for an exercise in using the serial port,
manipulating the kernel commandline, and doing a little
exploring, i resurrected an old tool of mine which timestamps
lines received over a serial port (or a socket), and i used it to
get a trace of XO startup and shutdown.

there's no scientific method here, nor any great conclusions, but
since we don't usually even see the boot logs, i thought i'd pass
along the results, for general interest.

oh -- this was done using build 708, on a unit with the dev key
installed, of course.

paul

=---------------------
 paul fox, pgf at laptop.org



  0.000|  0.000|Forthmacs
  0.000|  1.216|Type 'i' to interrupt stand-init sequence
  0.000|  0.000|First stand-init:
  0.209|  0.208|Exceptions
  0.209|  0.000|CIF
  0.209|  0.000|DHCP init
  0.209|  0.000|memory node
  0.209|  0.000|gpio
  0.209|  0.000|Probing memory
  0.209|  0.000|MMU
  0.209|  0.000|Reclaim dictionary
  0.209|  0.000|PCI host bridge
  0.209|  0.000|ISA
  0.209|  0.000|RTC
  0.209|  0.000|CPU nodes
  0.209|  0.000|CMOS
  0.209|  0.000|Null-NVRAM
  0.209|  0.000|board revision
  0.209|  0.000|Date to EC
  0.240|  0.031|Wireless reset
  0.257|  0.016|PCI properties
  0.257|  0.000|Manufacturing data
  0.257|  0.000|USB setup
  0.561|  0.303|Suspend/resume
  0.561|  0.000|Century
  0.577|  0.015|Init SHA-1 variables
  0.577|  0.000|
  0.577|  0.000|USB2 devices:
  2.241|  1.664|/pci/usb at f,5/wlan at 0,0
  2.529|  0.288|USB1 devices:
  2.529|  0.000|OLPC C2, 256 MiB memory installed, S/N CSN748056BF
  2.685|  0.156|OpenFirmware  CL1   Q2D16  Q2D
  2.685|  0.000|
  2.685|  0.000|Type the Esc key to interrupt automatic startup
  2.701|  0.015|5
  3.708|  1.006|4 3
  5.724|  2.016|2 1
  7.740|  2.016| Boot device: /nandflash:\boot\olpc.fth  Arguments: Boot device: /nandflash:\boot\olpc.fth  Arguments:
 15.632|  7.891|Boot device: /pci/nandflash at c:\boot\vmlinuz  Arguments: ro root=mtd0 rootfstype=jffs2 console=ttyS0,115200 fbcon=font:SUN12x22Boot device: /pci/nandflash at c:\boot\vmlinuz  Arguments: ro root=mtd0 rootfstype=jffs2 console=ttyS0,115200 fbcon=font:SUN12x22
 16.609|  0.976|Loading ramdisk image from /pci/nandflash at c:\boot\olpcrd.img ...
 21.341|  4.732|[    0.000000] Linux version 2.6.22-20080523.1.olpc.28f4cb6e780db07 (root at teach) (gcc version 4.1.2 20070925 (Red Hat 4.1.2-27)) #1 PREEMPT Fri May 23 03:06:12 EDT 2008
 23.481|  2.139|[    0.000000] BIOS-provided physical RAM map:
 23.481|  0.000|[    0.000000]  BIOS-e801: 0000000000000000 - 000000000009f000 (usable)
 23.481|  0.000|[    0.000000]  BIOS-e801: 0000000000100000 - 000000000edfd000 (usable)
 23.481|  0.000|[    0.000000] 237MB LOWMEM available.
 23.482|  0.000|[    0.000000] Zone PFN ranges:
 23.482|  0.000|[    0.000000]   DMA             0 ->     4096
 23.482|  0.000|[    0.000000]   Normal       4096 ->    60925
 23.482|  0.000|[    0.000000] early_node_map[1] active PFN ranges
 23.524|  0.041|[    0.000000]     0:        0 ->    60925
 23.524|  0.000|[    0.000000] DMI not present or invalid.
 23.524|  0.000|[    0.000000] Allocating PCI resources starting at 10000000 (gap: 0edfd000:f1203000)
 23.524|  0.000|[    0.000000] Built 1 zonelists.  Total pages: 60450
 23.524|  0.000|[    0.000000] Kernel command line: ro root=mtd0 rootfstype=jffs2 console=ttyS0,115200 fbcon=font:SUN12x22
 23.525|  0.000|[    0.000000] Initializing CPU#0
 23.525|  0.000|[    0.000000] CPU 0 irqstacks, hard=c0714000 soft=c0713000
 23.525|  0.000|[    0.000000] PID hash table entries: 1024 (order: 10, 4096 bytes)
 23.567|  0.041|[    0.000000] Detected 431.221 MHz processor.
 23.567|  0.000|[   23.150198] Console: colour EGA 80x25
 23.567|  0.000|[   23.150328] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
 23.567|  0.000|[   23.150936] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
 23.567|  0.000|[   23.188408] Memory: 228104k/243700k available (2142k kernel code, 15040k reserved, 810k data, 168k init, 0k highmem)
 23.568|  0.000|[   23.188473] virtual kernel memory layout:
 23.568|  0.000|[   23.188483]     fixmap  : 0xffffd000 - 0xfffff000   (   8 kB)
 23.611|  0.042|[   23.188496]     vmalloc : 0xcf800000 - 0xffffb000   ( 775 MB)
 23.611|  0.000|[   23.188508]     lowmem  : 0xc0000000 - 0xcedfd000   ( 237 MB)
 23.611|  0.000|[   23.188520]       .init : 0xc06e4000 - 0xc070e000   ( 168 kB)
 23.611|  0.000|[   23.188533]       .data : 0xc06178ae - 0xc06e21b4   ( 810 kB)
 23.611|  0.000|[   23.188545]       .text : 0xc0400000 - 0xc06178ae   (2142 kB)
 23.612|  0.000|[   23.188575] Checking if this processor honours the WP bit even in supervisor mode... Ok.
 23.612|  0.000|[   23.339364] Calibrating delay using timer specific routine.. 863.54 BogoMIPS (lpj=4317730)
 23.654|  0.041|[   23.339627] Security Framework v1.0.0 initialized
 23.654|  0.000|[   23.339658] Capability LSM initialized
 23.654|  0.000|[   23.339772] Mount-cache hash table entries: 512
 23.654|  0.000|[   23.340331] CPU: L1 I Cache: 64K (32 bytes/line), D cache 64K (32 bytes/line)
 23.654|  0.000|[   23.340354] CPU: L2 Cache: 128K (32 bytes/line)
 23.655|  0.000|[   23.340428] Compat vDSO mapped to ffffe000.
 23.655|  0.000|[   23.340458] CPU: AMD Geode(TM) Integrated Processor by AMD PCS stepping 02
 23.655|  0.000|[   23.340492] Checking 'hlt' instruction... OK.
 23.697|  0.041|[   23.380308] NET: Registered protocol family 16
 23.697|  0.000|[   23.380363] geode-mfgpt:  Registered timer 0
 23.697|  0.000|[   23.380398] mfgpt-timer:  registering the MFGT timer as a clock event.
 23.697|  0.000|[   23.380778] geode-mfgpt:  8 timers available.
 23.697|  0.000|[   23.380970] OLPC board with OpenFirmware: CL1   Q2D16  Q2D
 23.697|  0.000|[   23.392239] OLPC board revision: C2 (EC=52)
 23.698|  0.000|[   23.393799] PCI: Using configuration type OLPC
 23.698|  0.000|[   23.393817] Setting up standard PCI resources
 23.698|  0.000|[   23.400281] SCSI subsystem initialized
 23.698|  0.000|[   23.400622] usbcore: registered new interface driver usbfs
 23.740|  0.041|[   23.400817] usbcore: registered new interface driver hub
 23.740|  0.000|[   23.401037] usbcore: registered new device driver usb
 23.740|  0.000|[   23.401361] PCI: Probing PCI hardware
 23.740|  0.000|[   23.407307] NET: Registered protocol family 2
 23.740|  0.000|[   23.411809] Time: tsc clocksource has been installed.
 23.741|  0.000|[   23.412079] Switched to high resolution mode on CPU 0
 23.741|  0.000|[   23.485182] IP route cache hash table entries: 2048 (order: 1, 8192 bytes)
 23.741|  0.000|[   23.485440] TCP established hash table entries: 8192 (order: 5, 163840 bytes)
 23.783|  0.041|[   23.485969] TCP bind hash table entries: 8192 (order: 5, 163840 bytes)
 23.783|  0.000|[   23.486587] TCP: Hash tables configured (established 8192 bind 8192)
 23.783|  0.000|[   23.486607] TCP reno registered
 23.783|  0.000|[   23.513083] checking if image is initramfs... it is
 23.783|  0.000|[   23.625471] Freeing initrd memory: 9401k freed
 23.784|  0.000|[   23.698504] input: OLPC PM as /class/input/input0
 23.784|  0.000|[   23.706728] input: OLPC lid switch as /class/input/input1
 23.784|  0.000|[   23.714961] input: OLPC ebook switch as /class/input/input2
 23.826|  0.041|[   23.714986] SCI is mapped to IRQ 3
 23.826|  0.000|[   23.715014] Set IRQ 3 for 6
 23.826|  0.000|[   23.715100] Set IRQ 3 for 7
 23.826|  0.000|[   23.768257] Total HugeTLB memory allocated, 0
 23.826|  0.000|[   23.768637] VFS: Disk quotas dquot_6.5.1
 23.826|  0.000|[   23.768702] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
 23.826|  0.000|[   23.769124] JFFS2 version 2.2. (NAND) (SUMMARY)  © 2001-2006 Red Hat, Inc.
 23.827|  0.000|[   23.868720] PROM: Built device tree with 36534 bytes of memory.
 23.827|  0.000|[   23.868914] io scheduler noop registered
 23.827|  0.000|[   23.869009] io scheduler cfq registered (default)
 23.870|  0.042|[   23.893814] lxfb 0000:00:01.1: 16384 KB of video memory at 0xfd000000
 23.870|  0.000|[   23.975473] Console: switching to colour frame buffer device 100x40
 23.870|  0.000|[   24.021220] fb0: Geode LX frame buffer device
 23.870|  0.000|[   24.594524] Non-volatile memory driver v1.2
 23.870|  0.000|[   24.594560] AMD Geode RNG detected
 23.871|  0.000|[   24.614659] Serial: 8250/16550 driver $Revision: 1.90 $ 1 ports, IRQ sharing enabled
 23.871|  0.000|[   24.639094] serial8250.0: ttyS0 at I/O 0x3f8 (irq = 4) is a NS16550A
 23.871|  0.000|[   25.083836] serial8250 serial8250.0: unable to register port at index 1 (IO2f8 MEM0 IRQ3): -28
 23.907|  0.035|[   25.092649] serial8250 serial8250.0: unable to register port at index 2 (IO3e8 MEM0 IRQ4): -28
 23.907|  0.000|[   25.101433] serial8250 serial8250.0: unable to register port at index 3 (IO2e8 MEM0 IRQ3): -28
 23.907|  0.000|[   25.247865] RAMDISK driver initialized: 16 RAM disks of 16384K size 1024 blocksize
 24.070|  0.162|[   25.258741] Linux video capture interface: v2.00
 24.070|  0.000|[   25.263526] Marvell M88ALP01 'CAFE' Camera Controller version 2
 24.070|  0.000|[   25.280567] PCI: Enabling device 0000:00:0c.2 (0000 -> 0002)
 24.086|  0.015|[   25.316059] i2c-adapter i2c-0: SMBus Quick command not supported, can't probe for chips
 24.129|  0.043|[   25.324298] olpc-dcon: No DCON found on SMBus
 24.129|  0.000|[   25.372763] OmniVision ov7670 sensor driver, at your service
 24.177|  0.047|[   25.752466] NAND device: Manufacturer ID: 0xad, Chip ID: 0xdc (Hynix NAND 512MiB 3,3V 8-bit)
 24.617|  0.440|[   25.761081] 2 NAND chips detected
 24.617|  0.000|[   25.765911] Searching for RedBoot partition table in NAND 512MiB 3,3V 8-bit at offset 0xfd80000
 24.617|  0.000|[   25.781377] No RedBoot partition table detected in NAND 512MiB 3,3V 8-bit
 24.618|  0.000|[   25.796472] ehci_hcd 0000:00:0f.5: EHCI Host Controller
 24.618|  0.000|[   25.809876] ehci_hcd 0000:00:0f.5: new USB bus registered, assigned bus number 1
 24.618|  0.000|[   25.847212] ehci_hcd 0000:00:0f.5: irq 10, io mem 0xfe01b000
 24.688|  0.069|[   25.852893] ehci_hcd 0000:00:0f.5: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
 24.688|  0.000|[   25.870107] usb usb1: configuration #1 chosen from 1 choice
 24.688|  0.000|[   25.883396] hub 1-0:1.0: USB hub found
 24.688|  0.000|[   25.887196] hub 1-0:1.0: 4 ports detected
 24.689|  0.000|[   26.014152] ohci_hcd 0000:00:0f.4: OHCI Host Controller
 24.843|  0.154|[   26.027577] ohci_hcd 0000:00:0f.4: new USB bus registered, assigned bus number 2
 24.844|  0.000|[   26.035177] ohci_hcd 0000:00:0f.4: irq 10, io mem 0xfe01a000
 24.844|  0.000|[   26.134589] usb usb2: configuration #1 chosen from 1 choice
 24.954|  0.109|[   26.147118] hub 2-0:1.0: USB hub found
 24.954|  0.000|[   26.150922] hub 2-0:1.0: 4 ports detected
 24.954|  0.000|[   26.227211] hub_port_wait_reset: portstatus=503 portchange=10
 25.035|  0.080|[   26.267534] Initializing USB Mass Storage driver...
 25.066|  0.031|[   26.287584] usb 1-1: new high speed USB device using ehci_hcd and address 2
 25.095|  0.029|[   26.356937] hub_port_wait_reset: portstatus=503 portchange=10
 25.164|  0.069|[   26.454186] usb 1-1: configuration #1 chosen from 1 choice
 25.260|  0.095|[   26.485044] usbcore: registered new interface driver usb-storage
 25.313|  0.052|[   26.491224] USB Mass Storage support registered.
 25.313|  0.000|[   26.504211] usbcore: registered new interface driver libusual
 25.313|  0.000|[   26.568650] serio: i8042 KBD port at 0x60,0x64 irq 1
 25.380|  0.066|[   26.573967] serio: i8042 AUX port at 0x60,0x64 irq 12
 25.380|  0.000|[   26.679928] input: AT Translated Set 2 keyboard as /class/input/input3
 25.487|  0.107|[   26.723029] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
 25.530|  0.042|[   26.729564] rtc0: alarms up to one year, y3k
 25.530|  0.000|[   27.227525] drivers/input/mouse/olpc.c: OLPC touchpad revision 0x50.
 26.035|  0.504|[   27.716365] drivers/input/mouse/olpc.c: OLPC touchpad revision 0x50.
 26.523|  0.488|[   27.844614] input: OLPC ALPS GlideSensor as /class/input/input4
 26.651|  0.127|[   27.904174] input: OLPC ALPS PenTablet as /class/input/input5
 26.711|  0.060|[   27.928915] olpc-dcon:  Discovered DCON version 2
 26.736|  0.024|[   27.933803] Set IRQ 6 for 2
 26.736|  0.000|[   28.298217] sdhci: Secure Digital Host Controller Interface driver
 27.134|  0.397|[   28.304520] sdhci: Copyright(c) Pierre Ossman
 27.134|  0.000|[   28.317075] sdhci: SDHCI controller found at 0000:00:0c.1 [11ab:4101] (rev 10)
 27.134|  0.000|[   28.324439] PCI: Enabling device 0000:00:0c.1 (0000 -> 0002)
 27.135|  0.000|[   28.330125] sdhci: Invalid iomem size. You may experience problems.
 27.135|  0.000|[   28.351054] mmc0: SDHCI at 0xfe024000 irq 11 DMA
 27.150|  0.015|[   28.366124] geode-aes: GEODE AES engine enabled.
 27.166|  0.015|[   28.381767] usbcore: registered new interface driver hiddev
 27.214|  0.048|[   28.395715] usbcore: registered new interface driver usbhid
 27.214|  0.000|[   28.401441] drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver
 27.214|  0.000|[   28.407826] Advanced Linux Sound Architecture Driver Version 1.0.14 (Thu May 31 09:03:25 2007 UTC).
 27.215|  0.000|[   28.437160] Failure reading codec reg 0x7e,Last value=0x7e805368
 27.250|  0.035|[   28.443428] Failure reading codec reg 0x7e,Last value=0x7e805368
 27.250|  0.000|[   28.508418] ALSA device list:
 27.298|  0.047|[   28.511411]   #0: CS5535 Audio cs5535audio at 0x1480, irq 5
 27.345|  0.047|[   28.517997] TCP bic registered
 27.345|  0.000|[   28.521069] Initializing XFRM netlink socket
 27.345|  0.000|[   28.525533] NET: Registered protocol family 1
 27.345|  0.000|[   28.530148] NET: Registered protocol family 10
 27.346|  0.000|[   28.535024] lo: Disabled Privacy Extensions
 27.346|  0.000|[   28.539283] Mobile IPv6
 27.346|  0.000|[   28.541872] NET: Registered protocol family 17
 27.346|  0.000|[   28.546329] Using IPI Shortcut mode
 27.346|  0.000|[   28.550611] Freeing unused kernel memory: 168k freed
 27.346|  0.000|[   28.555657] Write protecting the kernel read-only data: 624k
 27.360|  0.013|Hello, (children of the) world!
 28.592|  1.232|[   34.514604] JFFS2 notice: (611) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
 33.330|  4.737|
 34.722|  1.391|INIT: version 2.86 booting
 34.770|  0.048|                Welcome to Fedora
 36.306|  1.536|                Press 'I' to enter interactive startup.
 36.322|  0.016|Setting clock  (utc): Thu Jun 26 21:22:15 GMT 2008 [  OK  ]
 37.905|  1.583|
 38.289|  0.383|Starting udev: [  OK  ]
 43.952|  5.663|Loading default keymap (us): [  OK  ]
 45.361|  1.408|
 45.553|  0.191|Setting hostname localhost.localdomain:  [  OK  ]
 45.569|  0.016|Checking filesystems
 46.353|  0.784|Checking all file systems.
 46.370|  0.017|[  OK  ]
 46.370|  0.000|
 46.882|  0.511|Mounting local filesystems:  [  OK  ]
 46.913|  0.030|Enabling /etc/fstab swaps:  [  OK  ]
 47.377|  0.464|
 47.809|  0.432|INIT: Entering runlevel: 5
 47.857|  0.047|Entering non-interactive startup
 47.970|  0.113|Starting 0-boot-anim-start:  [  OK  ]
 48.321|  0.350|
 48.513|  0.191|Starting olpc-configure:  olpc-configure: configuring hardware...
 48.625|  0.112|[  OK  ]
 48.625|  0.000|Starting system logger: [  OK  ]
 49.634|  1.009|
 49.634|  0.000|Starting kernel logger: [  OK  ]
 49.664|  0.029|Starting system message bus: Unknown username "gdm" in message bus configuration file
 50.576|  0.912|[  OK  ]
 50.576|  0.000|
 51.152|  0.575|Starting rainbow-daemon: [  OK  ]
 53.936|  2.784|Starting sshd: [  OK  ]
 54.464|  0.528|
 54.754|  0.289|Starting ConsoleKit: [  OK  ]
 54.818|  0.064|Starting crond: [  OK  ]
 55.199|  0.381|[  OK  ]
 55.199|  0.000|Starting anacron: [  OK  ]
 55.535|  0.335|
 55.839|  0.304|Starting Avahi daemon... [  OK  ]
 55.999|  0.160|Setting network parameters...
 56.320|  0.320|Starting NetworkManager daemon: [  OK  ]
 56.527|  0.207|
 56.832|  0.304|Starting NetworkManagerDispatcher daemon: [  OK  ]
 56.864|  0.032|Starting HAL daemon: [  OK  ]
 57.488|  0.624|
 58.016|  0.528|Starting the hardware manager: [  OK  ]
 59.600|  1.584|Starting Open Hardware Manager: [  OK  ]
 60.464|  0.864|
 61.023|  0.559|Starting ul-warning:  [  OK  ]
 61.327|  0.304|Starting z-boot-anim-stop:  [  OK  ]
 64.031|  2.704|
 64.975|  0.944|
 65.585|  0.610|X.Org X Server 1.4.0Release Date: 5 September 2007
 65.586|  0.000|X Protocol Version 11, Revision 0Build Operating System: Fedora Core 7 Red Hat, Inc.
 65.586|  0.000|Current Operating System: Linux xo-10-B4-EC.localdomain 2.6.22-20080523.1.olpc.28f4cb6e780db07 #1 PREEMPT Fri May 23 03:06:12 EDT 2008 i586Build Date: 27 May 2008  08:43:14PM
 65.586|  0.000|Build ID: xorg-x11-server 1.4-9.olpc2   Before reporting problems, check http://wiki.x.org
 65.586|  0.000|        to make sure that you have the latest version.Module Loader present
 65.587|  0.000|Markers: (--) probed, (**) from config file, (==) default setting,      (++) from command line, (!!) notice, (II) informational,
 65.623|  0.035|        (WW) warning, (EE) error, (NI) not implemented, (??) unknown.(==) Log file: "/var/log/Xorg.0.log", Time: Thu Jun 26 21:22:42 2008
 65.623|  0.000|(==) Using config file: "/etc/X11/xorg.conf"(EE) Failed to load module "dbe" (module does not exist, 0)
 65.821|  0.197|(EE) Failed to load module "glx" (module does not exist, 0)(EE) Failed to load module "dri" (module does not exist, 0)
 66.028|  0.207|(II) Module "ramdac" already built-in(EE) OLPC ALPS PenTablet: Button: 74.
 66.554|  0.525|(EE) OLPC ALPS PenTablet: state->btn: 0x8237800.(EE) OLPC ALPS PenTablet: Unable to parse 'null' as a map specifier string.
 66.554|  0.000|(EE) OLPC ALPS PenTablet: Unable to parse 'null' as a map specifier string.(EE) OLPC ALPS GlideSensor: Unable to parse 'RelAxis 0' as a map specifier.
 66.554|  0.000|(EE) OLPC ALPS GlideSensor: Unable to parse 'RelAxis 1' as a map specifier.(EE) OLPC ALPS GlideSensor: Button: 74.
 66.555|  0.000|(EE) OLPC ALPS GlideSensor: state->btn: 0x823a260.(EE) OLPC ALPS GlideSensor: Unable to parse 'null' as a map specifier string.
 66.580|  0.024|(EE) OLPC ALPS GlideSensor: Unable to parse 'null' as a map specifier string.Xlib:  extension "XFree86-Misc" missing on display ":0.0".
 69.941|  3.361|The XKEYBOARD keymap compiler (xkbcomp) reports:> Warning:          Type "ONE_LEVEL" has 1 levels, but <RALT> has 2 symbols
 69.941|  0.000|>                   Ignoring extra symbolsErrors from xkbcomp are not fatal to the X server
105.282| 35.340|

[ hit return to enable shell on ttyS0 -pgf ]

105.314|  0.032|bash-3.2#
105.474|  0.160|bash-3.2#
121.361| 15.886|bash-3.2#

[ shutdown commenced from suger, with timestamps reset  -pgf ]

121.376|  0.015|bash-3.2# INIT: Switching to run
  0.000| 12.012|INIT: Sending processes the TERM signal
  0.000|  0.000|
  0.000|  0.000|
  0.000|  0.000|waiting for X server to shut down
  0.992|  0.991|
  0.992|  0.000|xinit:  unexpected signal 15.
  1.008|  0.016|Stopping ul-warning:  Traceback (most recent call last):
  2.053|  1.045|  File "/etc/rc0.d/K01ul-warning", line 94, in <module>
  2.053|  0.000|    fb = initial_setup()
  2.053|  0.000|  File "/etc/rc0.d/K01ul-warning", line 35, in initial_setup
  2.053|  0.000|    chvt(2)
  2.053|  0.000|  File "pyvt.pyx", line 42, in pyvt.chvt
  2.053|  0.000|IOError: [Errno 22] Invalid argument
  2.054|  0.000|[FAILED]
  2.325|  0.271|
  2.469|  0.144|Stopping NetworkManager daemon: [  OK  ]
  3.653|  1.184|Stopping NetworkManagerDispatcher daemon: [  OK  ]
  3.813|  0.159|
  3.941|  0.128|Shutting down Avahi daemon: [  OK  ]
  3.973|  0.032|Stopping HAL daemon: [  OK  ]
  4.117|  0.143|
  4.261|  0.144|Stopping Open Hardware Manager: [  OK  ]
  4.309|  0.048|Stopping the hardware manager: [  OK  ]
  4.581|  0.272|
  4.757|  0.176|Stopping ConsoleKit: [  OK  ]
  4.757|  0.000|Stopping sshd: [  OK  ]
  5.077|  0.319|
  5.221|  0.144|Stopping rainbow-daemon: [  OK  ]
  5.285|  0.063|Stopping crond: [  OK  ]
  5.509|  0.224|
  5.621|  0.111|Stopping system message bus: [  OK  ]
  5.621|  0.000|Shutting down kernel logger: [  OK  ]
  6.869|  1.248|
  6.869|  0.000|Shutting down system logger: [  OK  ]
  6.997|  0.127|Starting killall:  Traceback (most recent call last):
  7.404|  0.407|  File "/etc/init.d/ul-warning", line 94, in <module>
  7.404|  0.000|    fb = initial_setup()
  7.404|  0.000|  File "/etc/init.d/ul-warning", line 35, in initial_setup
  7.405|  0.000|    chvt(2)
  7.405|  0.000|  File "pyvt.pyx", line 42, in pyvt.chvt
  7.405|  0.000|IOError: [Errno 22] Invalid argument
  7.405|  0.000|[FAILED]
  7.596|  0.191|
  7.851|  0.255|Sending all processes the TERM signal...
 12.876|  5.024|Sending all processes the KILL signal...
 12.908|  0.031|Saving mixer settings
 13.260|  0.352|Saving random seed:
 13.276|  0.015|Syncing hardware clock to system time
 14.123|  0.847|Unmounting file systems:  umount2: Invalid argument
 14.155|  0.031|umount: /security/.private: not mounted
 14.155|  0.000|
 16.203|  2.048|Cannot stat /security/.private: No such file or directory
 16.229|  0.026|Cannot stat /security/.private: No such file or directory
 16.229|  0.000|Cannot stat /security/.private: No such file or directory
 21.220|  4.991|Unmounting file systems (retry):  umount2: No such file or directory
 22.164|  0.944|umount: /security/.private: not found
 22.165|  0.000|
 24.216|  2.051|Cannot stat /security/.private: No such file or directory
 24.216|  0.000|Cannot stat /security/.private: No such file or directory
 24.216|  0.000|Cannot stat /security/.private: No such file or directory
 29.207|  4.991|Unmounting file systems (retry):  umount2: No such file or directory
 29.233|  0.026|umount: /security/.private: not found
 29.233|  0.000|
 31.282|  2.048|Cannot stat /security/.private: No such file or directory
 31.282|  0.000|Cannot stat /security/.private: No such file or directory
 31.283|  0.000|Cannot stat /security/.private: No such file or directory
 36.349|  5.066|umount2: No such file or directory
 36.349|  0.000|umount: /security/.private: not found
 36.413|  0.063|mount: / not mounted already, or bad option
 36.429|  0.016|Halting system...
 39.437|  3.008|[  173.985843] Power down.
 39.437|  0.000|[  173.988307] OLPC power off sequence...






More information about the Devel mailing list