Re: [patch] Real-Time Preemption, -VP-2.6.9-rc4-mm1-U1

[Mark_H_Johnson@RAYTHEON.COM]

[-- Attachment #1: Type: text/plain, Size: 1086 bytes --]

>i have released the -U1 PREEMPT_REALTIME patch:
>
>
http://redhat.com/~mingo/voluntary-preempt/voluntary-preempt-2.6.9-rc4-mm1-U1

Not sure if I can bring this up to multi user yet. Some initial testing
in single user mode indicates problems when I turn on networking. See
the attached messages from /var/log/messages to see the kinds of problems
I am having. The key ones appear after doing
  ./S10network start
as part of single stepping the init sequence. I stopped at this point
to make sure I had a good record of the messages.

I also managed to get the machine stuck with
  /sbin/reboot
not sure why.

And yes, the .config is basically the same as in all previous tests.
(no changes since my first tests with -T4...)

A side question - if
  CONFIG_PREEMPT_REALTIME=y
you say that IRQ's must be threaded, is this going to be "permanent" and
if so - why?

I would prefer to not use threaded IRQ's if possible due to lower CPU
overhead [see previous email describing results...] and some problems
I see with setting priorities on those IRQ's (relative to real time tasks).

 --Mark

[-- Attachment #2: VPU1.message --]
[-- Type: application/octet-stream, Size: 28163 bytes --]

Oct 14 11:43:45 localhost syslogd 1.4.1: restart.
Oct 14 11:43:45 localhost syslog: syslogd startup succeeded
Oct 14 11:43:45 localhost kernel: klogd 1.4.1, log source = /proc/kmsg started.
Oct 14 11:43:45 localhost syslog: klogd startup succeeded
Oct 14 11:43:45 localhost kernel: Linux version 2.6.9-rc4-mm1-VP-U1 (root@dws77) (gcc version 3.3.3 20040412 (Red Hat Linux 3.3.3-7)) #1 SMP Thu Oct 14 10:45:43 CDT 2004
Oct 14 11:43:45 localhost kernel: BIOS-provided physical RAM map:
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 0000000000100000 - 000000001fff0000 (usable)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 000000001fff0000 - 000000001fff8000 (ACPI data)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 000000001fff8000 - 0000000020000000 (ACPI NVS)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 00000000fec00000 - 00000000fec01000 (reserved)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
Oct 14 11:43:45 localhost kernel:  BIOS-e820: 00000000ffff0000 - 0000000100000000 (reserved)
Oct 14 11:43:45 localhost kernel: 0MB HIGHMEM available.
Oct 14 11:43:45 localhost kernel: 511MB LOWMEM available.
Oct 14 11:43:45 localhost kernel: found SMP MP-table at 000fb170
Oct 14 11:43:45 localhost kernel: DMI 2.3 present.
Oct 14 11:43:45 localhost kernel: Using APIC driver default
Oct 14 11:43:45 localhost kernel: ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
Oct 14 11:43:45 localhost kernel: Processor #0 6:8 APIC version 17
Oct 14 11:43:45 localhost kernel: ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
Oct 14 11:43:45 localhost kernel: Processor #1 6:8 APIC version 17
Oct 14 11:43:45 localhost kernel: Using ACPI for processor (LAPIC) configuration information
Oct 14 11:43:45 localhost kernel: Intel MultiProcessor Specification v1.1
Oct 14 11:43:45 localhost kernel:     Virtual Wire compatibility mode.
Oct 14 11:43:45 localhost kernel: OEM ID: VIA      Product ID: VT3075       APIC at: 0xFEE00000
Oct 14 11:43:45 localhost kernel: I/O APIC #2 Version 17 at 0xFEC00000.
Oct 14 11:43:45 localhost kernel: Enabling APIC mode:  Flat.  Using 1 I/O APICs
Oct 14 11:43:45 localhost kernel: Processors: 2
Oct 14 11:43:45 localhost kernel: Built 1 zonelists
Oct 14 11:43:45 localhost kernel: Initializing CPU#0
Oct 14 11:43:45 localhost kernel: Kernel command line: ro root=LABEL=/ nmi_watchdog=1 single
Oct 14 11:43:45 localhost kernel: (swapper/0): new 230766 us maximum-latency critical section.
Oct 14 11:43:45 localhost kernel:  => started at: <start_kernel+0x48/0x1e0>
Oct 14 11:43:45 localhost kernel:  => ended at:   <cond_resched+0x25/0x80>
Oct 14 11:43:45 localhost kernel:  [<c013a1e8>] touch_preempt_timing+0x48/0x50
Oct 14 11:43:45 localhost kernel:  [<c013a102>] check_preempt_timing+0x162/0x200
Oct 14 11:43:45 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:43:45 localhost kernel:  [<c013a1e8>] touch_preempt_timing+0x48/0x50
Oct 14 11:43:45 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:43:45 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:43:45 localhost kernel:  [<c013b69d>] register_cpu_notifier+0x2d/0x80
Oct 14 11:43:45 localhost kernel:  [<c03c7977>] rcu_init+0x97/0xa0
Oct 14 11:43:45 localhost kernel:  [<c03b696c>] start_kernel+0xbc/0x1e0
Oct 14 11:43:45 localhost kernel:  [<c03b6440>] unknown_bootoption+0x0/0x180
Oct 14 11:43:45 localhost kernel: PID hash table entries: 2048 (order: 11, 32768 bytes)
Oct 14 11:43:45 localhost kernel: Detected 864.193 MHz processor.
Oct 14 11:43:45 localhost kernel: Using tsc for high-res timesource
Oct 14 11:43:45 localhost kernel: (swapper/0): new 335856 us maximum-latency critical section.
Oct 14 11:43:45 localhost kernel:  => started at: <cond_resched+0x25/0x80>
Oct 14 11:43:45 localhost kernel:  => ended at:   <cond_resched+0x25/0x80>
Oct 14 11:43:45 localhost kernel:  [<c013a1e8>] touch_preempt_timing+0x48/0x50
Oct 14 11:43:45 localhost kernel:  [<c013a102>] check_preempt_timing+0x162/0x200
Oct 14 11:43:45 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:43:45 localhost kernel:  [<c013a1e8>] touch_preempt_timing+0x48/0x50
Oct 14 11:43:45 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:43:45 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:43:45 localhost kernel:  [<c0138df1>] _mutex_lock+0x31/0x70
Oct 14 11:43:45 localhost kernel:  [<c0138e86>] _mutex_lock_irqsave+0x16/0x20
Oct 14 11:43:45 localhost kernel:  [<c0202117>] tty_register_ldisc+0x37/0xc0
Oct 14 11:43:45 localhost kernel:  [<c03d0248>] console_init+0x28/0x50
Oct 14 11:43:45 localhost kernel:  [<c03b698a>] start_kernel+0xda/0x1e0
Oct 14 11:43:45 localhost kernel:  [<c03b6440>] unknown_bootoption+0x0/0x180
Oct 14 11:43:45 localhost kernel: Console: colour VGA+ 80x25
Oct 14 11:43:45 localhost kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Oct 14 11:43:45 localhost kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Oct 14 11:43:45 localhost kernel: Memory: 513460k/524224k available (2142k kernel code, 10164k reserved, 617k data, 292k init, 0k highmem)
Oct 14 11:43:45 localhost kernel: Checking if this processor honours the WP bit even in supervisor mode... Ok.
Oct 14 11:43:45 localhost kernel: Security Scaffold v1.0.0 initialized
Oct 14 11:43:45 localhost kernel: SELinux:  Initializing.
Oct 14 11:43:45 localhost kernel: SELinux:  Starting in permissive mode
Oct 14 11:43:45 localhost kernel: There is already a security framework initialized, register_security failed.
Oct 14 11:43:45 localhost kernel: selinux_register_security:  Registering secondary module capability
Oct 14 11:43:45 localhost kernel: Capability LSM initialized as secondary
Oct 14 11:43:45 localhost kernel: Mount-cache hash table entries: 512 (order: 0, 4096 bytes)
Oct 14 11:43:45 localhost kernel: CPU: L1 I cache: 16K, L1 D cache: 16K
Oct 14 11:43:45 localhost kernel: CPU: L2 cache: 256K
Oct 14 11:43:45 localhost kernel: Intel machine check architecture supported.
Oct 14 11:43:45 localhost kernel: Intel machine check reporting enabled on CPU#0.
Oct 14 11:43:45 localhost kernel: Enabling fast FPU save and restore... done.
Oct 14 11:43:45 localhost kernel: Enabling unmasked SIMD FPU exception support... done.
Oct 14 11:43:45 localhost kernel: Checking 'hlt' instruction... OK.
Oct 14 11:43:45 localhost kernel: CPU0: Intel Pentium III (Coppermine) stepping 06
Oct 14 11:43:45 localhost kernel: per-CPU timeslice cutoff: 730.77 usecs.
Oct 14 11:43:45 localhost kernel: task migration cache decay timeout: 1 msecs.
Oct 14 11:43:45 localhost kernel: Booting processor 1/1 eip 2000
Oct 14 11:43:45 localhost kernel: Initializing CPU#1
Oct 14 11:43:46 localhost kernel: CPU: L1 I cache: 16K, L1 D cache: 16K
Oct 14 11:43:46 localhost kernel: CPU: L2 cache: 256K
Oct 14 11:43:46 localhost kernel: Intel machine check architecture supported.
Oct 14 11:43:46 localhost kernel: Intel machine check reporting enabled on CPU#1.
Oct 14 11:43:46 localhost kernel: CPU1: Intel Pentium III (Coppermine) stepping 06
Oct 14 11:43:46 localhost kernel: Total of 2 processors activated (3395.58 BogoMIPS).
Oct 14 11:43:46 localhost kernel: ENABLING IO-APIC IRQs
Oct 14 11:43:46 localhost kernel: ..TIMER: vector=0x31 pin1=2 pin2=0
Oct 14 11:43:46 localhost kernel: testing NMI watchdog ... OK.
Oct 14 11:43:46 localhost kernel: checking TSC synchronization across 2 CPUs: passed.
Oct 14 11:43:46 localhost kernel: ksoftirqd started up.
Oct 14 11:43:46 localhost kernel: Brought up 2 CPUs
Oct 14 11:43:46 localhost kernel: ksoftirqd started up.
Oct 14 11:43:46 localhost kernel: checking if image is initramfs...it isn't (no cpio magic); looks like an initrd
Oct 14 11:43:46 localhost kernel: Freeing initrd memory: 205k freed
Oct 14 11:43:46 localhost kernel: NET: Registered protocol family 16
Oct 14 11:43:46 localhost kernel: PCI: PCI BIOS revision 2.10 entry at 0xfdb01, last bus=1
Oct 14 11:43:46 localhost kernel: PCI: Using configuration type 1
Oct 14 11:43:46 localhost kernel: mtrr: v2.0 (20020519)
Oct 14 11:43:46 localhost kernel: mtrr: your CPUs had inconsistent variable MTRR settings
Oct 14 11:43:46 localhost kernel: mtrr: probably your BIOS does not setup all CPUs.
Oct 14 11:43:46 localhost kernel: mtrr: corrected configuration.
Oct 14 11:43:46 localhost kernel: Linux Plug and Play Support v0.97 (c) Adam Belay
Oct 14 11:43:46 localhost kernel: usbcore: registered new driver usbfs
Oct 14 11:43:46 localhost kernel: usbcore: registered new driver hub
Oct 14 11:43:46 localhost kernel: PCI: Probing PCI hardware
Oct 14 11:43:46 localhost kernel: PCI: Probing PCI hardware (bus 00)
Oct 14 11:43:46 localhost kernel: PCI: Using IRQ router VIA [1106/0686] at 0000:00:07.0
Oct 14 11:43:46 localhost kernel: audit: initializing netlink socket (disabled)
Oct 14 11:43:46 localhost kernel: audit(1097772163.451:0): initialized
Oct 14 11:43:46 localhost kernel: Total HugeTLB memory allocated, 0
Oct 14 11:43:46 localhost kernel: VFS: Disk quotas dquot_6.5.1
Oct 14 11:43:46 localhost kernel: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Oct 14 11:43:46 localhost kernel: SELinux:  Registering netfilter hooks
Oct 14 11:43:46 localhost kernel: Initializing Cryptographic API
Oct 14 11:43:46 localhost kernel: PCI: Enabling Via external APIC routing
Oct 14 11:43:46 localhost kernel: pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Oct 14 11:43:46 localhost kernel: vesafb: probe of vesafb0 failed with error -6
Oct 14 11:43:46 localhost kernel: isapnp: Scanning for PnP cards...
Oct 14 11:43:46 localhost kernel: isapnp: No Plug & Play device found
Oct 14 11:43:46 localhost kernel: Real Time Clock Driver v1.12
Oct 14 11:43:46 localhost kernel: Linux agpgart interface v0.100 (c) Dave Jones
Oct 14 11:43:46 localhost kernel: agpgart: Detected VIA Apollo Pro 133 chipset
Oct 14 11:43:46 localhost kernel: agpgart: Maximum main memory to use for agp memory: 439M
Oct 14 11:43:46 localhost kernel: agpgart: AGP aperture is 128M @ 0xe0000000
Oct 14 11:43:46 localhost kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
Oct 14 11:43:46 localhost kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
Oct 14 11:43:46 localhost kernel: Serial: 8250/16550 driver $Revision: 1.90 $ 8 ports, IRQ sharing enabled
Oct 14 11:43:46 localhost kernel: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
Oct 14 11:43:46 localhost kernel: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
Oct 14 11:43:46 localhost kernel: io scheduler noop registered
Oct 14 11:43:46 localhost kernel: io scheduler anticipatory registered
Oct 14 11:43:46 localhost kernel: io scheduler deadline registered
Oct 14 11:43:46 localhost kernel: io scheduler cfq registered
Oct 14 11:43:46 localhost kernel: RAMDISK driver initialized: 16 RAM disks of 16384K size 1024 blocksize
Oct 14 11:43:46 localhost kernel: Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
Oct 14 11:43:46 localhost kernel: ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
Oct 14 11:43:46 localhost kernel: VP_IDE: IDE controller at PCI slot 0000:00:07.1
Oct 14 11:43:46 localhost kernel: VP_IDE: chipset revision 16
Oct 14 11:43:46 localhost kernel: VP_IDE: not 100%% native mode: will probe irqs later
Oct 14 11:43:46 localhost kernel: VP_IDE: VIA vt82c686a (rev 22) IDE UDMA66 controller on pci0000:00:07.1
Oct 14 11:43:46 localhost kernel:     ide0: BM-DMA at 0xffa0-0xffa7, BIOS settings: hda:DMA, hdb:pio
Oct 14 11:43:46 localhost kernel:     ide1: BM-DMA at 0xffa8-0xffaf, BIOS settings: hdc:pio, hdd:DMA
Oct 14 11:43:46 localhost kernel: hda: WDC WD300BB-00AUA1, ATA DISK drive
Oct 14 11:43:46 localhost kernel: elevator: using anticipatory as default io scheduler
Oct 14 11:43:46 localhost kernel: ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
Oct 14 11:43:46 localhost kernel: hdd: CD-ROM Drive/F5E, ATAPI CD/DVD-ROM drive
Oct 14 11:43:46 localhost kernel: ide1 at 0x170-0x177,0x376 on irq 15
Oct 14 11:43:46 localhost kernel: hda: max request size: 128KiB
Oct 14 11:43:46 localhost kernel: hda: 58633344 sectors (30020 MB) w/2048KiB Cache, CHS=58168/16/63, UDMA(66)
Oct 14 11:43:46 localhost kernel:  hda: hda1 hda2 hda3 hda4 < hda5 hda6 >
Oct 14 11:43:46 localhost kernel: hdd: ATAPI 52X CD-ROM drive, 128kB Cache, UDMA(33)
Oct 14 11:43:46 localhost kernel: Uniform CD-ROM driver Revision: 3.20
Oct 14 11:43:46 localhost kernel: ide-floppy driver 0.99.newide
Oct 14 11:43:46 localhost kernel: usbcore: registered new driver hiddev
Oct 14 11:43:46 localhost kernel: usbcore: registered new driver usbhid
Oct 14 11:43:46 localhost kernel: drivers/usb/input/hid-core.c: v2.0:USB HID core driver
Oct 14 11:43:46 localhost kernel: mice: PS/2 mouse device common for all mice
Oct 14 11:43:46 localhost kernel: input: AT Translated Set 2 keyboard on isa0060/serio0
Oct 14 11:43:46 localhost kernel: md: md driver 0.90.0 MAX_MD_DEVS=256, MD_SB_DISKS=27
Oct 14 11:43:46 localhost kernel: NET: Registered protocol family 2
Oct 14 11:43:46 localhost kernel: IP: routing cache hash table of 512 buckets, 20Kbytes
Oct 14 11:43:46 localhost kernel: TCP: Hash tables configured (established 4096 bind 6553)
Oct 14 11:43:46 localhost kernel: Initializing IPsec netlink socket
Oct 14 11:43:46 localhost kernel: NET: Registered protocol family 1
Oct 14 11:43:46 localhost kernel: NET: Registered protocol family 17
Oct 14 11:43:46 localhost kernel: Starting balanced_irq
Oct 14 11:43:46 localhost kernel: md: Autodetecting RAID arrays.
Oct 14 11:43:46 localhost kernel: md: autorun ...
Oct 14 11:43:46 localhost kernel: md: ... autorun DONE.
Oct 14 11:43:46 localhost kernel: RAMDISK: Compressed image found at block 0
Oct 14 11:43:46 localhost kernel: VFS: Mounted root (ext2 filesystem).
Oct 14 11:43:46 localhost kernel: kjournald starting.  Commit interval 5 seconds
Oct 14 11:43:46 localhost kernel: EXT3-fs: mounted filesystem with ordered data mode.
Oct 14 11:43:46 localhost kernel: Freeing unused kernel memory: 292k freed
Oct 14 11:43:46 localhost kernel: USB Universal Host Controller Interface driver v2.2
Oct 14 11:43:46 localhost kernel: uhci_hcd 0000:00:07.2: UHCI Host Controller
Oct 14 11:43:46 localhost kernel: uhci_hcd 0000:00:07.2: irq 10, io base 0xd000
Oct 14 11:43:46 localhost kernel: uhci_hcd 0000:00:07.2: new USB bus registered, assigned bus number 1
Oct 14 11:43:46 localhost kernel: hub 1-0:1.0: USB hub found
Oct 14 11:43:46 localhost kernel: hub 1-0:1.0: 2 ports detected
Oct 14 11:43:46 localhost kernel: uhci_hcd 0000:00:07.3: UHCI Host Controller
Oct 14 11:43:46 localhost kernel: uhci_hcd 0000:00:07.3: irq 10, io base 0xd400
Oct 14 11:43:46 localhost kernel: uhci_hcd 0000:00:07.3: new USB bus registered, assigned bus number 2
Oct 14 11:43:46 localhost kernel: hub 2-0:1.0: USB hub found
Oct 14 11:43:46 localhost kernel: hub 2-0:1.0: 2 ports detected
Oct 14 11:43:46 localhost kernel: usb 1-2: new low speed USB device using address 2
Oct 14 11:43:46 localhost kernel: input: USB HID v1.00 Mouse [1241:1111] on usb-0000:00:07.2-2
Oct 14 11:43:46 localhost kernel: EXT3 FS on hda3, internal journal
Oct 14 11:43:46 localhost kernel: device-mapper: 4.1.0-ioctl (2003-12-10) initialised: dm@uk.sistina.com
Oct 14 11:43:46 localhost kernel: cdrom: open failed.
Oct 14 11:43:46 localhost kernel: Adding 1052216k swap on /dev/hda5.  Priority:-1 extents:1
Oct 14 11:43:46 localhost kernel: Adding 1052216k swap on /dev/hda6.  Priority:-2 extents:1
Oct 14 11:43:46 localhost kernel: kjournald starting.  Commit interval 5 seconds
Oct 14 11:43:46 localhost kernel: EXT3 FS on hda1, internal journal
Oct 14 11:43:46 localhost kernel: EXT3-fs: mounted filesystem with ordered data mode.
Oct 14 11:43:46 localhost kernel: kjournald starting.  Commit interval 5 seconds
Oct 14 11:43:46 localhost kernel: EXT3 FS on hda2, internal journal
Oct 14 11:43:46 localhost kernel: EXT3-fs: mounted filesystem with ordered data mode.
Oct 14 11:44:15 localhost sysctl: net.ipv4.ip_forward = 0
Oct 14 11:44:15 localhost sysctl: net.ipv4.conf.default.rp_filter = 1
Oct 14 11:44:15 localhost sysctl: kernel.sysrq = 1
Oct 14 11:44:15 localhost sysctl: kernel.core_uses_pid = 1
Oct 14 11:44:15 localhost sysctl: net.core.rmem_default = 109568
Oct 14 11:44:15 localhost sysctl: net.core.rmem_max = 109568
Oct 14 11:44:15 localhost sysctl: net.core.wmem_default = 109568
Oct 14 11:44:15 localhost sysctl: net.core.wmem_max = 109568
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_fin_timeout = 60
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_keepalive_time = 7200
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_keepalive_probes = 9
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_syn_retries = 5
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_max_syn_backlog = 1024
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_retries1 = 3
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_retries2 = 15
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_syncookies = 0
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_retrans_collapse = 1
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_sack = 1
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_timestamps = 1
Oct 14 11:44:15 localhost sysctl: net.ipv4.tcp_window_scaling = 1
Oct 14 11:44:15 localhost sysctl: net.ipv4.icmp_ignore_bogus_error_responses = 0
Oct 14 11:44:15 localhost sysctl: net.ipv4.icmp_echo_ignore_all = 0
Oct 14 11:44:15 localhost sysctl: net.ipv4.icmp_echo_ignore_broadcasts = 0
Oct 14 11:44:15 localhost sysctl: net.ipv4.ip_default_ttl = 64
Oct 14 11:44:15 localhost sysctl: net.ipv4.ipfrag_time = 30
Oct 14 11:44:15 localhost sysctl: net.ipv4.conf.all.rp_filter = 0
Oct 14 11:44:15 localhost sysctl: net.ipv4.ip_no_pmtu_disc = 0
Oct 14 11:44:15 localhost sysctl: net.unix.max_dgram_qlen = 10
Oct 14 11:44:15 localhost sysctl: fs.file-max = 50834
Oct 14 11:44:15 localhost sysctl: vm.overcommit_memory = 0
Oct 14 11:44:15 localhost sysctl: vm.page-cluster = 3
Oct 14 11:44:15 localhost sysctl: kernel.ctrl-alt-del = 0
Oct 14 11:44:15 localhost sysctl: kernel.panic = 0
Oct 14 11:44:15 localhost sysctl: kernel.acct = 4 2 30
Oct 14 11:44:15 localhost sysctl: kernel.printk = 6
Oct 14 11:44:15 localhost sysctl: kernel.shmall = 2097152
Oct 14 11:44:15 localhost sysctl: kernel.shmmax = 33554432
Oct 14 11:44:15 localhost sysctl: dev.raid.speed_limit_min = 1000
Oct 14 11:44:15 localhost sysctl: dev.raid.speed_limit_max = 200000
Oct 14 11:44:15 localhost network: Setting network parameters:  succeeded
Oct 14 11:44:16 localhost kernel: Debug: sleeping function called from invalid context iptables(1384) at kernel/mutex.c:25
Oct 14 11:44:16 localhost kernel: in_atomic():1 [00000001], irqs_disabled():0
Oct 14 11:44:16 localhost kernel:  [<c011f26a>] __might_sleep+0xca/0xe0
Oct 14 11:44:16 localhost kernel:  [<c0138de9>] _mutex_lock+0x29/0x70
Oct 14 11:44:16 localhost kernel:  [<c0138e86>] _mutex_lock_irqsave+0x16/0x20
Oct 14 11:44:16 localhost kernel:  [<c01c4f4e>] avc_has_perm_noaudit+0x2e/0x1d0
Oct 14 11:44:16 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:16 localhost kernel:  [<c01c5104>] avc_has_perm+0x14/0x80
Oct 14 11:44:16 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:16 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:16 localhost kernel:  [<c01c5133>] avc_has_perm+0x43/0x80
Oct 14 11:44:16 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:16 localhost kernel:  [<c01c65a4>] task_has_capability+0x14/0x80
Oct 14 11:44:16 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:16 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:16 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:16 localhost kernel:  [<c01c6f16>] selinux_capable+0x26/0x50
Oct 14 11:44:16 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:16 localhost kernel:  [<c02f50ce>] inet_create+0x9e/0x2f0
Oct 14 11:44:16 localhost kernel:  [<c02a28f5>] __sock_create+0x135/0x350
Oct 14 11:44:16 localhost kernel:  [<c02a2b1b>] sock_create+0xb/0x40
Oct 14 11:44:16 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:16 localhost kernel:  [<c02a2b41>] sock_create+0x31/0x40
Oct 14 11:44:16 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:16 localhost kernel:  [<c02a3bf9>] sys_socketcall+0x69/0x250
Oct 14 11:44:16 localhost kernel:  [<c0118690>] do_page_fault+0x0/0x748
Oct 14 11:44:16 localhost kernel:  [<c0107b09>] sysenter_past_esp+0x52/0x71
Oct 14 11:44:16 localhost kernel: scheduling while atomic: iptables/0x04000001/1384
Oct 14 11:44:16 localhost kernel: caller is cond_resched+0x61/0x80
Oct 14 11:44:16 localhost kernel:  [<c031551c>] schedule+0x7ec/0x830
Oct 14 11:44:16 localhost kernel:  [<c0315a31>] cond_resched+0x61/0x80
Oct 14 11:44:16 localhost kernel:  [<c013a132>] check_preempt_timing+0x192/0x200
Oct 14 11:44:16 localhost kernel:  [<c013a1e8>] touch_preempt_timing+0x48/0x50
Oct 14 11:44:16 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:44:16 localhost kernel:  [<c0315a31>] cond_resched+0x61/0x80
Oct 14 11:44:16 localhost kernel:  [<c0138df1>] _mutex_lock+0x31/0x70
Oct 14 11:44:16 localhost kernel:  [<c0138e86>] _mutex_lock_irqsave+0x16/0x20
Oct 14 11:44:16 localhost kernel:  [<c01c4f4e>] avc_has_perm_noaudit+0x2e/0x1d0
Oct 14 11:44:16 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:16 localhost kernel:  [<c01c5104>] avc_has_perm+0x14/0x80
Oct 14 11:44:16 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:16 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:16 localhost kernel:  [<c01c5133>] avc_has_perm+0x43/0x80
Oct 14 11:44:16 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:16 localhost kernel:  [<c01c65a4>] task_has_capability+0x14/0x80
Oct 14 11:44:16 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:17 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:17 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:17 localhost kernel:  [<c01c6f16>] selinux_capable+0x26/0x50
Oct 14 11:44:17 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:17 localhost kernel:  [<c02f50ce>] inet_create+0x9e/0x2f0
Oct 14 11:44:17 localhost kernel:  [<c02a28f5>] __sock_create+0x135/0x350
Oct 14 11:44:17 localhost kernel:  [<c02a2b1b>] sock_create+0xb/0x40
Oct 14 11:44:17 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:17 localhost kernel:  [<c02a2b41>] sock_create+0x31/0x40
Oct 14 11:44:17 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:17 localhost kernel:  [<c02a3bf9>] sys_socketcall+0x69/0x250
Oct 14 11:44:17 localhost kernel:  [<c0118690>] do_page_fault+0x0/0x748
Oct 14 11:44:17 localhost kernel:  [<c0107b09>] sysenter_past_esp+0x52/0x71
Oct 14 11:44:17 localhost kernel: ip_tables: (C) 2000-2002 Netfilter core team
Oct 14 11:44:17 localhost network: Bringing up loopback interface:  succeeded
Oct 14 11:44:17 localhost kernel: 8139too Fast Ethernet driver 0.9.27
Oct 14 11:44:17 localhost kernel: eth0: RealTek RTL8139 at 0xdc00, 00:50:bf:39:11:fc, IRQ 11
Oct 14 11:44:17 localhost kernel: Debug: sleeping function called from invalid context iptables(1505) at kernel/mutex.c:25
Oct 14 11:44:17 localhost kernel: in_atomic():1 [00000001], irqs_disabled():0
Oct 14 11:44:17 localhost kernel:  [<c011f26a>] __might_sleep+0xca/0xe0
Oct 14 11:44:17 localhost kernel:  [<c0138de9>] _mutex_lock+0x29/0x70
Oct 14 11:44:17 localhost kernel:  [<c0138e86>] _mutex_lock_irqsave+0x16/0x20
Oct 14 11:44:17 localhost kernel:  [<c01c4f4e>] avc_has_perm_noaudit+0x2e/0x1d0
Oct 14 11:44:17 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:17 localhost kernel:  [<c01c5104>] avc_has_perm+0x14/0x80
Oct 14 11:44:17 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:17 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:17 localhost kernel:  [<c01c5133>] avc_has_perm+0x43/0x80
Oct 14 11:44:17 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:17 localhost kernel:  [<c01c65a4>] task_has_capability+0x14/0x80
Oct 14 11:44:17 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:17 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:17 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:17 localhost kernel:  [<c01c6f16>] selinux_capable+0x26/0x50
Oct 14 11:44:17 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:17 localhost kernel:  [<c02f50ce>] inet_create+0x9e/0x2f0
Oct 14 11:44:17 localhost kernel:  [<c02a28f5>] __sock_create+0x135/0x350
Oct 14 11:44:17 localhost kernel:  [<c02a2b1b>] sock_create+0xb/0x40
Oct 14 11:44:17 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:17 localhost kernel:  [<c02a2b41>] sock_create+0x31/0x40
Oct 14 11:44:17 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:17 localhost kernel:  [<c02a3bf9>] sys_socketcall+0x69/0x250
Oct 14 11:44:17 localhost kernel:  [<c0118690>] do_page_fault+0x0/0x748
Oct 14 11:44:17 localhost kernel:  [<c0107b09>] sysenter_past_esp+0x52/0x71
Oct 14 11:44:17 localhost kernel: scheduling while atomic: iptables/0x04000001/1505
Oct 14 11:44:17 localhost kernel: caller is cond_resched+0x61/0x80
Oct 14 11:44:17 localhost ifup: 
Oct 14 11:44:17 localhost kernel:  [<c031551c>] schedule+0x7ec/0x830
Oct 14 11:44:17 localhost ifup: Determining IP information for eth0...
Oct 14 11:44:17 localhost kernel:  [<c0315a31>] cond_resched+0x61/0x80
Oct 14 11:44:17 localhost kernel:  [<c013a132>] check_preempt_timing+0x192/0x200
Oct 14 11:44:17 localhost kernel:  [<c013a1e8>] touch_preempt_timing+0x48/0x50
Oct 14 11:44:17 localhost kernel:  [<c03159f5>] cond_resched+0x25/0x80
Oct 14 11:44:17 localhost kernel:  [<c0315a31>] cond_resched+0x61/0x80
Oct 14 11:44:17 localhost kernel:  [<c0138df1>] _mutex_lock+0x31/0x70
Oct 14 11:44:18 localhost kernel:  [<c0138e86>] _mutex_lock_irqsave+0x16/0x20
Oct 14 11:44:18 localhost kernel:  [<c01c4f4e>] avc_has_perm_noaudit+0x2e/0x1d0
Oct 14 11:44:18 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:18 localhost kernel:  [<c01c5104>] avc_has_perm+0x14/0x80
Oct 14 11:44:18 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:18 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:18 localhost kernel:  [<c01c5133>] avc_has_perm+0x43/0x80
Oct 14 11:44:18 localhost kernel:  [<c013994d>] __mcount+0x1d/0x30
Oct 14 11:44:18 localhost kernel:  [<c01c65a4>] task_has_capability+0x14/0x80
Oct 14 11:44:18 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:18 localhost kernel:  [<c0114b30>] mcount+0x14/0x18
Oct 14 11:44:18 localhost kernel:  [<c01c65fb>] task_has_capability+0x6b/0x80
Oct 14 11:44:18 localhost kernel:  [<c01c6f16>] selinux_capable+0x26/0x50
Oct 14 11:44:18 localhost kernel:  [<c01c20c9>] capable+0x29/0x50
Oct 14 11:44:18 localhost kernel:  [<c02f50ce>] inet_create+0x9e/0x2f0
Oct 14 11:44:18 localhost kernel:  [<c02a28f5>] __sock_create+0x135/0x350
Oct 14 11:44:18 localhost kernel:  [<c02a2b1b>] sock_create+0xb/0x40
Oct 14 11:44:18 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:18 localhost kernel:  [<c02a2b41>] sock_create+0x31/0x40
Oct 14 11:44:18 localhost kernel:  [<c02a2bbe>] sys_socket+0x2e/0x60
Oct 14 11:44:18 localhost kernel:  [<c02a3bf9>] sys_socketcall+0x69/0x250
Oct 14 11:44:18 localhost kernel:  [<c0118690>] do_page_fault+0x0/0x748
Oct 14 11:44:18 localhost kernel:  [<c0107b09>] sysenter_past_esp+0x52/0x71
Oct 14 11:44:18 localhost kernel: ip_tables: (C) 2000-2002 Netfilter core team
Oct 14 11:44:18 localhost kernel: eth0: link up, 100Mbps, half-duplex, lpa 0x40A1
Oct 14 11:44:23 localhost dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
Oct 14 11:44:23 localhost dhclient: DHCPACK from 192.52.216.221
Oct 14 11:44:23 localhost dhclient: bound to 192.52.215.87 -- renewal in 1049711384 seconds.
Oct 14 11:44:23 localhost ifup:  done.
Oct 14 11:44:23 localhost network: Bringing up interface eth0:  succeeded