Mesa 4i65 Realtime delay in task 1

More
29 Sep 2014 17:38 - 29 Sep 2014 18:15 #51651 by hardware_crash
Hey guys,

Now that I have my config with the Mesa 4i65 and SmartSerial via Mesa 7i44 Up an running I get some Realtime delay errors after about 20 Sec. linuxcnc is running.

I tried changing some setting in the Boards Bios but that didnt change anything :(

I also checked for overruns with no results..
The latency check gives good results.

The board im using is a Mini-ITX Mainboard (MB896IL)with a Pentium M (1,7GHz) and 1GB DDR2 Ram

The dmesg output is as follows:
user@cnc:~$ dmesg 
[    0.000000] Initializing cgroup subsys cpuset 
[    0.000000] Initializing cgroup subsys cpu 
[    0.000000] Linux version 3.4-9-rtai-686-pae (Debian 3.4.55-3linuxcnc) () (gcc version 4.6.3 (Debian 4.6.3-14) ) #1 SMP PREEMPT Debian 3.4.55-3linuxcnc 
[    0.000000] Disabled fast string operations 
[    0.000000] BIOS-provided physical RAM map: 
[    0.000000]  BIOS-e820: 0000000000000000 - 000000000009f800 (usable) 
[    0.000000]  BIOS-e820: 000000000009f800 - 00000000000a0000 (reserved) 
[    0.000000]  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) 
[    0.000000]  BIOS-e820: 0000000000100000 - 000000003f6f0000 (usable) 
[    0.000000]  BIOS-e820: 000000003f6f0000 - 000000003f700000 (reserved) 
[    0.000000]  BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved) 
[    0.000000]  BIOS-e820: 00000000fec00000 - 00000000fec01000 (reserved) 
[    0.000000]  BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved) 
[    0.000000]  BIOS-e820: 00000000ffb00000 - 0000000100000000 (reserved) 
[    0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel! 
[    0.000000] SMBIOS 2.2 present. 
[    0.000000] DMI:    /Alviso, BIOS 6.00 PG 11/15/2005 
[    0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved) 
[    0.000000] e820 remove range: 00000000000a0000 - 0000000000100000 (usable) 
[    0.000000] last_pfn = 0x3f6f0 max_arch_pfn = 0x100000 
[    0.000000] MTRR default type: uncachable 
[    0.000000] MTRR fixed ranges enabled: 
[    0.000000]   00000-9FFFF write-back 
[    0.000000]   A0000-EFFFF uncachable 
[    0.000000]   F0000-FFFFF write-through 
[    0.000000] MTRR variable ranges enabled: 
[    0.000000]   0 base 000000000 mask FC0000000 write-back 
[    0.000000]   1 base 03F800000 mask FFF800000 uncachable 
[    0.000000]   2 base 03F700000 mask FFFF00000 write-through 
[    0.000000]   3 disabled 
[    0.000000]   4 disabled 
[    0.000000]   5 disabled 
[    0.000000]   6 disabled 
[    0.000000]   7 disabled 
[    0.000000] PAT not supported by CPU. 
[    0.000000] initial memory mapped : 0 - 01800000 
[    0.000000] Base memory trampoline at [c009b000] 9b000 size 16384 
[    0.000000] init_memory_mapping: 0000000000000000-00000000377fe000 
[    0.000000]  0000000000 - 0000400000 page 4k 
[    0.000000]  0000400000 - 0037400000 page 2M 
[    0.000000]  0037400000 - 00377fe000 page 4k 
[    0.000000] kernel direct mapping tables up to 0x377fdfff @ [mem 0x017f8000-0x017fffff] 
[    0.000000] RAMDISK: 3642e000 - 3720f000 
[    0.000000] ACPI Error: A valid RSDP was not found (20120320/tbxfroot-219) 
[    0.000000] 126MB HIGHMEM available. 
[    0.000000] 887MB LOWMEM available. 
[    0.000000]   mapped low ram: 0 - 377fe000 
[    0.000000]   low ram: 0 - 377fe000 
[    0.000000] Zone PFN ranges: 
[    0.000000]   DMA      0x00000010 -> 0x00001000 
[    0.000000]   Normal   0x00001000 -> 0x000377fe 
[    0.000000]   HighMem  0x000377fe -> 0x0003f6f0 
[    0.000000] Movable zone start PFN for each node 
[    0.000000] Early memory PFN ranges 
[    0.000000]     0: 0x00000010 -> 0x0000009f 
[    0.000000]     0: 0x00000100 -> 0x0003f6f0 
[    0.000000] On node 0 totalpages: 259711 
[    0.000000] free_area_init_node: node 0, pgdat c1498a00, node_mem_map f5c3e200 
[    0.000000]   DMA zone: 32 pages used for memmap 
[    0.000000]   DMA zone: 0 pages reserved 
[    0.000000]   DMA zone: 3951 pages, LIFO batch:0 
[    0.000000]   Normal zone: 1744 pages used for memmap 
[    0.000000]   Normal zone: 221486 pages, LIFO batch:31 
[    0.000000]   HighMem zone: 254 pages used for memmap 
[    0.000000]   HighMem zone: 32244 pages, LIFO batch:7 
[    0.000000] Using APIC driver default 
[    0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org 
[    0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs 
[    0.000000] Found and enabled local APIC! 
[    0.000000] nr_irqs_gsi: 16 
[    0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000 
[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000 
[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000 
[    0.000000] Allocating PCI resources starting at 3f700000 (gap: 3f700000:a0900000) 
[    0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1 
[    0.000000] PERCPU: Embedded 17 pages/cpu @f77e6000 s48384 r0 d21248 u69632 
[    0.000000] pcpu-alloc: s48384 r0 d21248 u69632 alloc=17*4096 
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 257681 
[    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.4-9-rtai-686-pae root=UUID=1f1023bd-f1ab-48bb-81b6-bc3dfb6b6506 ro initrd=/install/gtk/initrd.gz lapic quiet rootdelay=5 
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes) 
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) 
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) 
[    0.000000] Initializing CPU#0 
[    0.000000] allocated 2078464 bytes of page_cgroup 
[    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups 
[    0.000000] Initializing HighMem for node 0 (000377fe:0003f6f0) 
[    0.000000] Memory: 1007716k/1039296k available (3495k kernel code, 31128k reserved, 1237k data, 416k init, 129992k highmem) 
[    0.000000] virtual kernel memory layout: 
[    0.000000]     fixmap  : 0xfff17000 - 0xfffff000   ( 928 kB) 
[    0.000000]     pkmap   : 0xff800000 - 0xffc00000   (4096 kB) 
[    0.000000]     vmalloc : 0xf7ffe000 - 0xff7fe000   ( 120 MB) 
[    0.000000]     lowmem  : 0xc0000000 - 0xf77fe000   ( 887 MB) 
[    0.000000]       .init : 0xc14a0000 - 0xc1508000   ( 416 kB) 
[    0.000000]       .data : 0xc1369d0a - 0xc149f480   (1237 kB) 
[    0.000000]       .text : 0xc1000000 - 0xc1369d0a   (3495 kB) 
[    0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. 
[    0.000000] Preemptible hierarchical RCU implementation. 
[    0.000000] 	RCU dyntick-idle grace-period acceleration is enabled. 
[    0.000000] NR_IRQS:2304 nr_irqs:256 16 
[    0.000000] CPU 0 irqstacks, hard=f5806000 soft=f5808000 
[    0.000000] Interrupt pipeline (release #3) 
[    0.000000] Console: colour VGA+ 80x25 
[    0.000000] console [tty0] enabled 
[    0.000000] Fast TSC calibration using PIT 
[    0.000000] Detected 1733.233 MHz processor. 
[    0.004002] Calibrating delay loop (skipped), value calculated using timer frequency.. 3466.46 BogoMIPS (lpj=6932932) 
[    0.004008] pid_max: default: 32768 minimum: 301 
[    0.004070] Security Framework initialized 
[    0.004079] AppArmor: AppArmor disabled by boot time parameter 
[    0.004103] Mount-cache hash table entries: 512 
[    0.004395] Initializing cgroup subsys cpuacct 
[    0.004399] Initializing cgroup subsys memory 
[    0.004411] Initializing cgroup subsys devices 
[    0.004414] Initializing cgroup subsys freezer 
[    0.004418] Initializing cgroup subsys net_cls 
[    0.004421] Initializing cgroup subsys blkio 
[    0.004432] Initializing cgroup subsys perf_event 
[    0.008034] Disabled fast string operations 
[    0.008042] mce: CPU supports 5 MCE banks 
[    0.008052] CPU0: Thermal monitoring enabled (TM1) 
[    0.008122] SMP alternatives: switching to UP code 
[    0.010931] Freeing SMP alternatives: 16k freed 
[    0.010987] weird, boot CPU (#0) not listed by the BIOS. 
[    0.010990] SMP motherboard not detected. 
[    0.010996] Enabling APIC mode:  Flat.  Using 0 I/O APICs 
[    0.116018] SMP disabled 
[    0.116022] Performance Events: p6 PMU driver. 
[    0.116029] ... version:                0 
[    0.116032] ... bit width:              32 
[    0.116034] ... generic registers:      2 
[    0.116037] ... value mask:             00000000ffffffff 
[    0.116040] ... max period:             000000007fffffff 
[    0.116043] ... fixed-purpose events:   0 
[    0.116045] ... event mask:             0000000000000003 
[    0.128034] NMI watchdog: enabled, takes one hw-pmu counter. 
[    0.128075] Brought up 1 CPUs 
[    0.128078] Total of 1 processors activated (3466.46 BogoMIPS). 
[    0.128251] devtmpfs: initialized 
[    0.128729] dummy: 
[    0.128803] NET: Registered protocol family 16 
[    0.130307] PCI: PCI BIOS revision 3.00 entry at 0xfaec0, last bus=4 
[    0.130311] PCI: Using configuration type 1 for base access 
[    0.131166] bio: create slab <bio-0> at 0 
[    0.131267] ACPI: Interpreter disabled. 
[    0.131326] vgaarb: loaded 
[    0.131366] PCI: Probing PCI hardware 
[    0.131369] PCI: Probing PCI hardware (bus 00) 
[    0.131372] PCI: root bus 00: using default resources 
[    0.131412] PCI host bridge to bus 0000:00 
[    0.131417] pci_bus 0000:00: root bus resource [io  0x0000-0xffff] 
[    0.131421] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffff] 
[    0.131437] pci 0000:00:00.0: [8086:2590] type 00 class 0x060000 
[    0.131488] pci 0000:00:02.0: [8086:2592] type 00 class 0x030000 
[    0.131502] pci 0000:00:02.0: reg 10: [mem 0xdff00000-0xdff7ffff] 
[    0.131510] pci 0000:00:02.0: reg 14: [io  0xff00-0xff07] 
[    0.131519] pci 0000:00:02.0: reg 18: [mem 0xc0000000-0xcfffffff pref] 
[    0.131527] pci 0000:00:02.0: reg 1c: [mem 0xdff80000-0xdffbffff] 
[    0.131566] pci 0000:00:02.1: [8086:2792] type 00 class 0x038000 
[    0.131578] pci 0000:00:02.1: reg 10: [mem 0xdfe80000-0xdfefffff] 
[    0.131662] pci 0000:00:1c.0: [8086:2660] type 01 class 0x060400 
[    0.131725] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold 
[    0.131754] pci 0000:00:1c.1: [8086:2662] type 01 class 0x060400 
[    0.131816] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold 
[    0.131845] pci 0000:00:1d.0: [8086:2658] type 00 class 0x0c0300 
[    0.131890] pci 0000:00:1d.0: reg 20: [io  0xfe00-0xfe1f] 
[    0.131926] pci 0000:00:1d.1: [8086:2659] type 00 class 0x0c0300 
[    0.131972] pci 0000:00:1d.1: reg 20: [io  0xfd00-0xfd1f] 
[    0.132021] pci 0000:00:1d.2: [8086:265a] type 00 class 0x0c0300 
[    0.132067] pci 0000:00:1d.2: reg 20: [io  0xfc00-0xfc1f] 
[    0.132102] pci 0000:00:1d.3: [8086:265b] type 00 class 0x0c0300 
[    0.132147] pci 0000:00:1d.3: reg 20: [io  0xfb00-0xfb1f] 
[    0.132189] pci 0000:00:1d.7: [8086:265c] type 00 class 0x0c0320 
[    0.132209] pci 0000:00:1d.7: reg 10: [mem 0xdffff000-0xdffff3ff] 
[    0.132281] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold 
[    0.132303] pci 0000:00:1e.0: [8086:2448] type 01 class 0x060401 
[    0.132363] pci 0000:00:1f.0: [8086:2641] type 00 class 0x060100 
[    0.132451] pci 0000:00:1f.0: Force enabled HPET at 0xfed00000 
[    0.132465] pci 0000:00:1f.0: LPC Generic IO decode 1 PIO at 0800-087f 
[    0.132470] pci 0000:00:1f.0: LPC Generic IO decode 2 PIO at 0290-029f 
[    0.132488] pci 0000:00:1f.1: [8086:266f] type 00 class 0x01018a 
[    0.132504] pci 0000:00:1f.1: reg 10: [io  0x0000-0x0007] 
[    0.132515] pci 0000:00:1f.1: reg 14: [io  0x0000-0x0003] 
[    0.132527] pci 0000:00:1f.1: reg 18: [io  0x0000-0x0007] 
[    0.132538] pci 0000:00:1f.1: reg 1c: [io  0x0000-0x0003] 
[    0.132549] pci 0000:00:1f.1: reg 20: [io  0xf800-0xf80f] 
[    0.132588] pci 0000:00:1f.3: [8086:266a] type 00 class 0x0c0500 
[    0.132644] pci 0000:00:1f.3: reg 20: [io  0x0500-0x051f] 
[    0.132722] pci 0000:00:1c.0: PCI bridge to [bus 01-01] 
[    0.132728] pci 0000:00:1c.0:   bridge window [io  0xc000-0xcfff] 
[    0.132734] pci 0000:00:1c.0:   bridge window [mem 0xdfd00000-0xdfdfffff] 
[    0.132742] pci 0000:00:1c.0:   bridge window [mem 0xdfa00000-0xdfafffff 64bit pref] 
[    0.132817] pci 0000:02:00.0: [10b5:8112] type 01 class 0x060400 
[    0.132938] pci 0000:02:00.0: supports D1 
[    0.132942] pci 0000:02:00.0: PME# supported from D0 D1 D3hot 
[    0.132972] pci 0000:02:00.0: disabling ASPM on pre-1.1 PCIe device.  You can enable it with 'pcie_aspm=force' 
[    0.132987] pci 0000:00:1c.1: PCI bridge to [bus 02-03] 
[    0.132993] pci 0000:00:1c.1:   bridge window [io  0xb000-0xbfff] 
[    0.132999] pci 0000:00:1c.1:   bridge window [mem 0xdf900000-0xdf9fffff] 
[    0.133007] pci 0000:00:1c.1:   bridge window [mem 0xdf800000-0xdf8fffff 64bit pref] 
[    0.133115] pci 0000:03:00.0: [10b5:9030] type 00 class 0x068000 
[    0.133151] pci 0000:03:00.0: reg 10: [mem 0xdf9ff000-0xdf9ff07f] 
[    0.133172] pci 0000:03:00.0: reg 14: [io  0xbf00-0xbf7f] 
[    0.133193] pci 0000:03:00.0: reg 18: [io  0xbc00-0xbcff] 
[    0.133214] pci 0000:03:00.0: reg 1c: [io  0xba00-0xbaff] 
[    0.133235] pci 0000:03:00.0: reg 20: [mem 0xdf9e0000-0xdf9effff] 
[    0.133256] pci 0000:03:00.0: reg 24: [mem 0xdf9d0000-0xdf9dffff] 
[    0.133395] pci 0000:02:00.0: PCI bridge to [bus 03-03] 
[    0.133403] pci 0000:02:00.0:   bridge window [io  0xb000-0xbfff] 
[    0.133412] pci 0000:02:00.0:   bridge window [mem 0xdf900000-0xdf9fffff] 
[    0.133420] pci 0000:02:00.0:   bridge window [mem 0xdf800000-0xdf8fffff pref] 
[    0.133480] pci 0000:04:08.0: [8086:1065] type 00 class 0x020000 
[    0.133500] pci 0000:04:08.0: reg 10: [mem 0xdfcff000-0xdfcfffff] 
[    0.133512] pci 0000:04:08.0: reg 14: [io  0xdf00-0xdf3f] 
[    0.133577] pci 0000:04:08.0: supports D1 D2 
[    0.133580] pci 0000:04:08.0: PME# supported from D0 D1 D2 D3hot D3cold 
[    0.133621] pci 0000:00:1e.0: PCI bridge to [bus 04-04] (subtractive decode) 
[    0.133627] pci 0000:00:1e.0:   bridge window [io  0xd000-0xdfff] 
[    0.133633] pci 0000:00:1e.0:   bridge window [mem 0xdfc00000-0xdfcfffff] 
[    0.133641] pci 0000:00:1e.0:   bridge window [mem 0xdfb00000-0xdfbfffff 64bit pref] 
[    0.133645] pci 0000:00:1e.0:   bridge window [io  0x0000-0xffff] (subtractive decode) 
[    0.133649] pci 0000:00:1e.0:   bridge window [mem 0x00000000-0xffffffff] (subtractive decode) 
[    0.133726] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none 
[    0.134415] PCI: pci_cache_line_size set to 64 bytes 
[    0.134494] reserve RAM buffer: 000000000009f800 - 000000000009ffff 
[    0.134499] reserve RAM buffer: 000000003f6f0000 - 000000003fffffff 
[    0.134817] hpet clockevent registered 
[    0.134824] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 
[    0.134833] hpet0: 3 comparators, 64-bit 14.318180 MHz counter 
[    0.136035] Switching to clocksource hpet 
[    0.136089] pnp: PnP ACPI: disabled 
[    0.136094] PnPBIOS: Scanning system for PnP BIOS support... 
[    0.136102] PnPBIOS: Found PnP BIOS installation structure at 0xc00fba80 
[    0.136107] PnPBIOS: PnP BIOS version 1.0, entry 0xf0000:0xbab0, dseg 0xf0000 
[    0.136144] pnp 00:00: [irq 2] 
[    0.136148] pnp 00:00: [io  0x0020-0x0021] 
[    0.136151] pnp 00:00: [io  0x00a0-0x00a1] 
[    0.136178] pnp 00:00: Plug and Play BIOS device, IDs PNP0000 (active) 
[    0.136188] pnp 00:01: [dma 4] 
[    0.136192] pnp 00:01: [io  0x0000-0x000f] 
[    0.136195] pnp 00:01: [io  0x0081-0x0083] 
[    0.136199] pnp 00:01: [io  0x0087] 
[    0.136202] pnp 00:01: [io  0x0089-0x008b] 
[    0.136205] pnp 00:01: [io  0x008f-0x0091] 
[    0.136209] pnp 00:01: [io  0x00c0-0x00df] 
[    0.136235] pnp 00:01: Plug and Play BIOS device, IDs PNP0200 (active) 
[    0.136246] pnp 00:02: [irq 0] 
[    0.136249] pnp 00:02: [io  0x0040-0x0043] 
[    0.136273] pnp 00:02: Plug and Play BIOS device, IDs PNP0100 (active) 
[    0.136284] pnp 00:03: [irq 8] 
[    0.136288] pnp 00:03: [io  0x0070-0x0071] 
[    0.136311] pnp 00:03: Plug and Play BIOS device, IDs PNP0b00 (active) 
[    0.136321] pnp 00:04: [irq 1] 
[    0.136324] pnp 00:04: [io  0x0060] 
[    0.136327] pnp 00:04: [io  0x0064] 
[    0.136353] pnp 00:04: Plug and Play BIOS device, IDs PNP0303 (active) 
[    0.136362] pnp 00:05: [io  0x0061] 
[    0.136386] pnp 00:05: Plug and Play BIOS device, IDs PNP0800 (active) 
[    0.136399] pnp 00:06: [irq 13] 
[    0.136402] pnp 00:06: [io  0x00f0-0x00ff] 
[    0.136426] pnp 00:06: Plug and Play BIOS device, IDs PNP0c04 (active) 
[    0.136436] pnp 00:07: [mem 0xffb80000-0xffbfffff] 
[    0.136460] pnp 00:07: Plug and Play BIOS device, IDs INT0800 (active) 
[    0.136470] pnp 00:08: [mem 0x00000000-0x0009ffff] 
[    0.136474] pnp 00:08: [mem 0xffb00000-0xffb7ffff] 
[    0.136477] pnp 00:08: [mem 0xfff00000-0xffffffff] 
[    0.136481] pnp 00:08: [mem 0xfec00000-0xfec0ffff] 
[    0.136484] pnp 00:08: [mem 0xfee00000-0xfee0ffff] 
[    0.136488] pnp 00:08: [mem 0x00100000-0x00ffffff] 
[    0.136537] system 00:08: [mem 0x00000000-0x0009ffff] could not be reserved 
[    0.136543] system 00:08: [mem 0xffb00000-0xffb7ffff] has been reserved 
[    0.136547] system 00:08: [mem 0xfff00000-0xffffffff] has been reserved 
[    0.136552] system 00:08: [mem 0xfec00000-0xfec0ffff] could not be reserved 
[    0.136557] system 00:08: [mem 0xfee00000-0xfee0ffff] could not be reserved 
[    0.136562] system 00:08: [mem 0x00100000-0x00ffffff] could not be reserved 
[    0.136567] system 00:08: Plug and Play BIOS device, IDs PNP0c01 (active) 
[    0.136578] pnp 00:09: [mem 0x000e0000-0x000effff] 
[    0.136581] pnp 00:09: [mem 0x000f0000-0x000f3fff] 
[    0.136585] pnp 00:09: [mem 0x000f4000-0x000f7fff] 
[    0.136588] pnp 00:09: [mem 0x000f8000-0x000fffff] 
[    0.136592] pnp 00:09: [mem 0x000cf400-0x000cffff] 
[    0.136637] system 00:09: [mem 0x000e0000-0x000effff] has been reserved 
[    0.136641] system 00:09: [mem 0x000f0000-0x000f3fff] could not be reserved 
[    0.136646] system 00:09: [mem 0x000f4000-0x000f7fff] could not be reserved 
[    0.136651] system 00:09: [mem 0x000f8000-0x000fffff] could not be reserved 
[    0.136656] system 00:09: [mem 0x000cf400-0x000cffff] has been reserved 
[    0.136660] system 00:09: Plug and Play BIOS device, IDs PNP0c02 (active) 
[    0.136672] pnp 00:0a: [io  0x04d0-0x04d1] 
[    0.136676] pnp 00:0a: [io  0x0cf8-0x0cff] 
[    0.136679] pnp 00:0a: [io  0x0400-0x04bf] 
[    0.136703] pnp 00:0a: Plug and Play BIOS device, IDs PNP0a03 (active) 
[    0.136713] pnp 00:0c: [io  0x03f0-0x03f1] 
[    0.136756] system 00:0c: [io  0x03f0-0x03f1] has been reserved 
[    0.136761] system 00:0c: Plug and Play BIOS device, IDs PNP0c02 (active) 
[    0.136768] PnPBIOS: 12 nodes reported by PnP BIOS; 12 recorded by driver 
[    0.139145] pci 0000:00:1c.0: PCI bridge to [bus 01-01] 
[    0.139151] pci 0000:00:1c.0:   bridge window [io  0xc000-0xcfff] 
[    0.139158] pci 0000:00:1c.0:   bridge window [mem 0xdfd00000-0xdfdfffff] 
[    0.139158] pci 0000:00:1c.0:   bridge window [mem 0xdfa00000-0xdfafffff 64bit pref] 
[    0.139158] pci 0000:02:00.0: PCI bridge to [bus 03-03] 
[    0.139163] pci 0000:02:00.0:   bridge window [io  0xb000-0xbfff] 
[    0.139173] pci 0000:02:00.0:   bridge window [mem 0xdf900000-0xdf9fffff] 
[    0.139182] pci 0000:02:00.0:   bridge window [mem 0xdf800000-0xdf8fffff pref] 
[    0.139195] pci 0000:00:1c.1: PCI bridge to [bus 02-03] 
[    0.139199] pci 0000:00:1c.1:   bridge window [io  0xb000-0xbfff] 
[    0.139206] pci 0000:00:1c.1:   bridge window [mem 0xdf900000-0xdf9fffff] 
[    0.139212] pci 0000:00:1c.1:   bridge window [mem 0xdf800000-0xdf8fffff 64bit pref] 
[    0.139220] pci 0000:00:1e.0: PCI bridge to [bus 04-04] 
[    0.139224] pci 0000:00:1e.0:   bridge window [io  0xd000-0xdfff] 
[    0.139231] pci 0000:00:1e.0:   bridge window [mem 0xdfc00000-0xdfcfffff] 
[    0.139237] pci 0000:00:1e.0:   bridge window [mem 0xdfb00000-0xdfbfffff 64bit pref] 
[    0.139275] pci 0000:00:1e.0: setting latency timer to 64 
[    0.139280] pci_bus 0000:00: resource 4 [io  0x0000-0xffff] 
[    0.139284] pci_bus 0000:00: resource 5 [mem 0x00000000-0xffffffff] 
[    0.139288] pci_bus 0000:01: resource 0 [io  0xc000-0xcfff] 
[    0.139292] pci_bus 0000:01: resource 1 [mem 0xdfd00000-0xdfdfffff] 
[    0.139296] pci_bus 0000:01: resource 2 [mem 0xdfa00000-0xdfafffff 64bit pref] 
[    0.139300] pci_bus 0000:02: resource 0 [io  0xb000-0xbfff] 
[    0.139304] pci_bus 0000:02: resource 1 [mem 0xdf900000-0xdf9fffff] 
[    0.139308] pci_bus 0000:02: resource 2 [mem 0xdf800000-0xdf8fffff 64bit pref] 
[    0.139312] pci_bus 0000:03: resource 0 [io  0xb000-0xbfff] 
[    0.139316] pci_bus 0000:03: resource 1 [mem 0xdf900000-0xdf9fffff] 
[    0.139320] pci_bus 0000:03: resource 2 [mem 0xdf800000-0xdf8fffff pref] 
[    0.139324] pci_bus 0000:04: resource 0 [io  0xd000-0xdfff] 
[    0.139328] pci_bus 0000:04: resource 1 [mem 0xdfc00000-0xdfcfffff] 
[    0.139332] pci_bus 0000:04: resource 2 [mem 0xdfb00000-0xdfbfffff 64bit pref] 
[    0.139336] pci_bus 0000:04: resource 4 [io  0x0000-0xffff] 
[    0.139340] pci_bus 0000:04: resource 5 [mem 0x00000000-0xffffffff] 
[    0.139419] NET: Registered protocol family 2 
[    0.139499] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) 
[    0.139720] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) 
[    0.140519] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) 
[    0.140989] TCP: Hash tables configured (established 131072 bind 65536) 
[    0.140993] TCP: reno registered 
[    0.141000] UDP hash table entries: 512 (order: 2, 16384 bytes) 
[    0.141018] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) 
[    0.141173] NET: Registered protocol family 1 
[    0.141200] pci 0000:00:02.0: Boot video device 
[    0.141360] pci 0000:04:08.0: Firmware left e100 interrupts enabled; disabling 
[    0.141367] PCI: CLS 32 bytes, default 64 
[    0.141445] Unpacking initramfs... 
[    0.574169] Freeing initrd memory: 14212k freed 
[    0.587005] audit: initializing netlink socket (disabled) 
[    0.587029] type=2000 audit(1414292137.584:1): initialized 
[    0.603232] highmem bounce pool size: 64 pages 
[    0.603241] HugeTLB registered 4 MB page size, pre-allocated 0 pages 
[    0.603427] VFS: Disk quotas dquot_6.5.2 
[    0.603460] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) 
[    0.603567] msgmni has been set to 1742 
[    0.603788] alg: No test for stdrng (krng) 
[    0.603820] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) 
[    0.603826] io scheduler noop registered 
[    0.603829] io scheduler deadline registered 
[    0.603848] io scheduler cfq registered (default) 
[    0.604146] pcieport 0000:00:1c.0: Signaling PME through PCIe PME interrupt 
[    0.604153] pcie_pme 0000:00:1c.0:pcie01: service driver pcie_pme loaded 
[    0.604169] pcieport 0000:00:1c.1: Signaling PME through PCIe PME interrupt 
[    0.604172] pci 0000:02:00.0: Signaling PME through PCIe PME interrupt 
[    0.604176] pci 0000:03:00.0: Signaling PME through PCIe PME interrupt 
[    0.604181] pcie_pme 0000:00:1c.1:pcie01: service driver pcie_pme loaded 
[    0.604191] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 
[    0.604218] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 
[    0.604221] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 
[    0.604396] isapnp: Scanning for PnP cards... 
[    0.957509] isapnp: No Plug & Play device found 
[    0.957570] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled 
[    0.958094] Linux agpgart interface v0.103 
[    0.958204] agpgart-intel 0000:00:00.0: Intel 915GM Chipset 
[    0.958257] agpgart-intel 0000:00:00.0: detected gtt size: 262144K total, 262144K mappable 
[    0.959101] agpgart-intel 0000:00:00.0: detected 8192K stolen memory 
[    0.959237] agpgart-intel 0000:00:00.0: AGP aperture is 256M @ 0xc0000000 
[    0.959420] i8042: PNP: PS/2 Controller [PNP0303] at 0x60,0x64 irq 1 
[    0.959423] i8042: PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp 
[    0.960115] serio: i8042 KBD port at 0x60,0x64 irq 1 
[    0.960239] mousedev: PS/2 mouse device common for all mice 
[    0.960404] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0 
[    0.960427] rtc0: alarms up to one day, 114 bytes nvram, hpet irqs 
[    0.960610] TCP: cubic registered 
[    0.960666] NET: Registered protocol family 10 
[    0.960966] Mobile IPv6 
[    0.960970] NET: Registered protocol family 17 
[    0.960978] Registering the dns_resolver key type 
[    0.961055] Using IPI No-Shortcut mode 
[    0.961163] PM: Hibernation image not present or could not be loaded. 
[    0.961181] registered taskstats version 1 
[    0.961492] rtc_cmos 00:03: setting system clock to 2014-10-26 02:55:38 UTC (1414292138) 
[    0.961599] Freeing unused kernel memory: 416k freed 
[    0.961847] Write protecting the kernel text: 3496k 
[    0.961875] Write protecting the kernel read-only data: 984k 
[    0.978991] udevd[46]: starting version 175 
[    0.981650] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 
[    1.006923] usbcore: registered new interface driver usbfs 
[    1.006959] usbcore: registered new interface driver hub 
[    1.010926] SCSI subsystem initialized 
[    1.053660] microcode: CPU0 sig=0x6d8, pf=0x20, revision=0x20 
[    1.055094] usbcore: registered new device driver usb 
[    1.056507] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver 
[    1.056584] ehci_hcd 0000:00:1d.7: setting latency timer to 64 
[    1.056590] ehci_hcd 0000:00:1d.7: EHCI Host Controller 
[    1.056624] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1 
[    1.060956] e100: Intel(R) PRO/100 Network Driver, 3.5.24-k2-NAPI 
[    1.060960] e100: Copyright(c) 1999-2006 Intel Corporation 
[    1.064396] uhci_hcd: USB Universal Host Controller Interface driver 
[    1.068229] libata version 3.00 loaded. 
[    1.081106] ehci_hcd 0000:00:1d.7: cache line size of 32 is not supported 
[    1.081125] ehci_hcd 0000:00:1d.7: irq 4, io mem 0xdffff000 
[    1.092120] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00 
[    1.092190] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 
[    1.092194] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 
[    1.092198] usb usb1: Product: EHCI Host Controller 
[    1.092202] usb usb1: Manufacturer: Linux 3.4-9-rtai-686-pae ehci_hcd 
[    1.092205] usb usb1: SerialNumber: 0000:00:1d.7 
[    1.092380] hub 1-0:1.0: USB hub found 
[    1.092388] hub 1-0:1.0: 8 ports detected 
[    1.093039] uhci_hcd 0000:00:1d.0: setting latency timer to 64 
[    1.093044] uhci_hcd 0000:00:1d.0: UHCI Host Controller 
[    1.093057] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 
[    1.093088] uhci_hcd 0000:00:1d.0: irq 4, io base 0x0000fe00 
[    1.093135] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001 
[    1.093139] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 
[    1.093143] usb usb2: Product: UHCI Host Controller 
[    1.093146] usb usb2: Manufacturer: Linux 3.4-9-rtai-686-pae uhci_hcd 
[    1.093149] usb usb2: SerialNumber: 0000:00:1d.0 
[    1.093407] hub 2-0:1.0: USB hub found 
[    1.093414] hub 2-0:1.0: 2 ports detected 
[    1.093527] uhci_hcd 0000:00:1d.1: setting latency timer to 64 
[    1.093532] uhci_hcd 0000:00:1d.1: UHCI Host Controller 
[    1.093544] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 
[    1.093572] uhci_hcd 0000:00:1d.1: irq 11, io base 0x0000fd00 
[    1.093620] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001 
[    1.093624] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 
[    1.093628] usb usb3: Product: UHCI Host Controller 
[    1.093631] usb usb3: Manufacturer: Linux 3.4-9-rtai-686-pae uhci_hcd 
[    1.093635] usb usb3: SerialNumber: 0000:00:1d.1 
[    1.093774] hub 3-0:1.0: USB hub found 
[    1.093781] hub 3-0:1.0: 2 ports detected 
[    1.093886] uhci_hcd 0000:00:1d.2: setting latency timer to 64 
[    1.093891] uhci_hcd 0000:00:1d.2: UHCI Host Controller 
[    1.093901] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 
[    1.093929] uhci_hcd 0000:00:1d.2: irq 3, io base 0x0000fc00 
[    1.093977] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001 
[    1.093982] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 
[    1.093985] usb usb4: Product: UHCI Host Controller 
[    1.093988] usb usb4: Manufacturer: Linux 3.4-9-rtai-686-pae uhci_hcd 
[    1.093992] usb usb4: SerialNumber: 0000:00:1d.2 
[    1.094127] hub 4-0:1.0: USB hub found 
[    1.094134] hub 4-0:1.0: 2 ports detected 
[    1.094233] ata_piix 0000:00:1f.1: version 2.13 
[    1.094283] ata_piix 0000:00:1f.1: setting latency timer to 64 
[    1.097720] scsi0 : ata_piix 
[    1.100021] scsi1 : ata_piix 
[    1.100091] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0xf800 irq 14 
[    1.100096] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xf808 irq 15 
[    1.100287] uhci_hcd 0000:00:1d.3: setting latency timer to 64 
[    1.100292] uhci_hcd 0000:00:1d.3: UHCI Host Controller 
[    1.100305] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5 
[    1.100334] uhci_hcd 0000:00:1d.3: irq 5, io base 0x0000fb00 
[    1.100384] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001 
[    1.100388] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 
[    1.100392] usb usb5: Product: UHCI Host Controller 
[    1.100396] usb usb5: Manufacturer: Linux 3.4-9-rtai-686-pae uhci_hcd 
[    1.100400] usb usb5: SerialNumber: 0000:00:1d.3 
[    1.100545] hub 5-0:1.0: USB hub found 
[    1.100551] hub 5-0:1.0: 2 ports detected 
[    1.120541] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba 
[    1.134277] e100 0000:04:08.0: eth0: addr 0xdfcff000, irq 10, MAC addr 00:03:2d:08:d2:f8 
[    1.267298] ata1.00: ATA-6: TOSHIBA MK4025GAS, KA100A, max UDMA/100 
[    1.267304] ata1.00: 78140160 sectors, multi 16: LBA 
[    1.272277] ata1.00: configured for UDMA/100 
[    1.272430] scsi 0:0:0:0: Direct-Access     ATA      TOSHIBA MK4025GA KA10 PQ: 0 ANSI: 5 
[    1.289931] sd 0:0:0:0: [sda] 78140160 512-byte logical blocks: (40.0 GB/37.2 GiB) 
[    1.290012] sd 0:0:0:0: [sda] Write Protect is off 
[    1.290017] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 
[    1.290051] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA 
[    1.374466]  sda: sda1 sda2 < sda5 > 
[    1.374846] sd 0:0:0:0: [sda] Attached SCSI disk 
[    1.377455] sd 0:0:0:0: Attached scsi generic sg0 type 0 
[    1.588028] usb 2-2: new low-speed USB device number 2 using uhci_hcd 
[    1.596019] Refined TSC clocksource calibration: 1733.136 MHz. 
[    1.596027] Switching to clocksource tsc 
[    1.776227] usb 2-2: New USB device found, idVendor=04d9, idProduct=048e 
[    1.776233] usb 2-2: New USB device strings: Mfr=0, Product=0, SerialNumber=0 
[    1.819501] input: HID 04d9:048e as /devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2:1.0/input/input1 
[    1.819677] generic-usb 0003:04D9:048E.0001: input,hidraw0: USB HID v1.10 Mouse [HID 04d9:048e] on usb-0000:00:1d.0-2/input0 
[    1.819874] usbcore: registered new interface driver usbhid 
[    1.819878] usbhid: USB HID core driver 
[    6.794246] PM: Starting manual resume from disk 
[    6.794252] PM: Hibernation image partition 8:5 present 
[    6.794255] PM: Looking for hibernation image. 
[    6.794470] PM: Image not found (code -22) 
[    6.794473] PM: Hibernation image not present or could not be loaded. 
[    6.887722] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) 
[    9.565507] udevd[284]: starting version 175 
[   10.112552] intel_rng: FWH not detected 
[   10.394911] ACPI Exception: AE_BAD_PARAMETER, Thread 4122341952 could not acquire Mutex [0x1] (20120320/utmutex-276) 
[   10.437960] iTCO_vendor_support: vendor-support=0 
[   10.630145] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 
[   10.630802] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.07 
[   10.630899] iTCO_wdt: Found a ICH6-M TCO device (Version=2, TCOBASE=0x0460) 
[   10.630961] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0) 
[   10.955791] [drm] Initialized drm 1.1.0 20060810 
[   13.326745] Adding 1633276k swap on /dev/sda5.  Priority:-1 extents:1 across:1633276k 
[   13.341961] EXT4-fs (sda1): re-mounted. Opts: (null) 
[   13.576641] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro 
[   13.791465] loop: module loaded 
[   15.519132] RPC: Registered named UNIX socket transport module. 
[   15.519137] RPC: Registered udp transport module. 
[   15.519140] RPC: Registered tcp transport module. 
[   15.519143] RPC: Registered tcp NFSv4.1 backchannel transport module. 
[   15.563777] FS-Cache: Loaded 
[   15.595567] NFS: Registering the id_resolver key type 
[   15.595598] FS-Cache: Netfs 'nfs' registered for caching 
[   15.660648] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). 
[   17.846289] input: ACPI Virtual Keyboard Device as /devices/virtual/input/input2 
[   20.227516] Bluetooth: Core ver 2.16 
[   20.227749] NET: Registered protocol family 31 
[   20.227753] Bluetooth: HCI device and connection manager initialized 
[   20.227756] Bluetooth: HCI socket layer initialized 
[   20.227759] Bluetooth: L2CAP socket layer initialized 
[   20.227766] Bluetooth: SCO socket layer initialized 
[   20.288736] Bluetooth: RFCOMM TTY layer initialized 
[   20.288744] Bluetooth: RFCOMM socket layer initialized 
[   20.288747] Bluetooth: RFCOMM ver 1.11 
[   20.356097] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 
[   20.356102] Bluetooth: BNEP filters: protocol multicast 
[   20.720358] lp: driver loaded but no devices found 
[   20.768590] ppdev: user-space parallel port driver 
[   23.989924] ADDRCONF(NETDEV_UP): eth0: link is not ready 
[   26.100894] mtrr: base(0xc0000000) is not aligned on a size(0x7b0000) boundary 
[   54.971145] I-pipe: head domain RTAI registered. 
[   54.971154] RTAI[hal]: compiled with gcc version 4.7.2 (Debian 4.7.2-5) . 
[   54.971163] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0). 
[   54.971168] SYSINFO: CPUs 1, LINUX APIC IRQ 2312, TIM_FREQ 8332329, CLK_FREQ 1733233000, CPU_FREQ 1733233000 
[   54.971172] RTAI_APIC_TIMER_IPI: RTAI DEFINED 2314, VECTOR 2314; LINUX_APIC_TIMER_IPI: RTAI DEFINED 2312, VECTOR 2312 
[   54.971177] TIMER NAME: lapic; VARIOUSLY FOUND APIC FREQs: 8332329, 8332329, 8297500 
[   55.216692] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>. 
[   55.216728] , <uses LINUX SYSCALLs>, kstacks pool size = 524288 bytes. 
[   55.216734] RTAI[sched]: hard timer type/freq = APIC/8332329(Hz); default timing: oneshot; linear timed lists. 
[   55.216739] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 1733233000 hz. 
[   55.216743] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns. 
[   55.288712] RTAI[math]: loaded. 
[   56.164839] hm2: loading Mesa HostMot2 driver version 0.15 
[   56.281386] hm2_pci: loading Mesa AnyIO HostMot2 driver version 0.7 
[   56.281438] hm2_pci: discovered 4i65 at 0000:03:00.0 
[   56.827332] hm2/hm2_4i65.0: Smart Serial Firmware Version 35 
[   56.885169] Board hm2_4i65.0.7i70.0.0 Hardware Mode 0 = standard 
[   56.888040] Board hm2_4i65.0.7i70.0.0 Software Mode 0 = input_only 
[   56.891388] Board hm2_4i65.0.7i70.0.0 Software Mode 1 = input_analog 
[   56.895718] Board hm2_4i65.0.7i70.0.0 Software Mode 2 = input_fieldvoltage 
[   57.031563] hm2/hm2_4i65.0: 72 I/O Pins used: 
[   57.031570] hm2/hm2_4i65.0:     IO Pin 000 (P1-01): IOPort 
[   57.031574] hm2/hm2_4i65.0:     IO Pin 001 (P1-03): IOPort 
[   57.031577] hm2/hm2_4i65.0:     IO Pin 002 (P1-05): IOPort 
[   57.031580] hm2/hm2_4i65.0:     IO Pin 003 (P1-07): IOPort 
[   57.031584] hm2/hm2_4i65.0:     IO Pin 004 (P1-09): IOPort 
[   57.031587] hm2/hm2_4i65.0:     IO Pin 005 (P1-11): IOPort 
[   57.031590] hm2/hm2_4i65.0:     IO Pin 006 (P1-13): IOPort 
[   57.031594] hm2/hm2_4i65.0:     IO Pin 007 (P1-15): IOPort 
[   57.031597] hm2/hm2_4i65.0:     IO Pin 008 (P1-17): IOPort 
[   57.031600] hm2/hm2_4i65.0:     IO Pin 009 (P1-19): IOPort 
[   57.031603] hm2/hm2_4i65.0:     IO Pin 010 (P1-21): IOPort 
[   57.031607] hm2/hm2_4i65.0:     IO Pin 011 (P1-23): IOPort 
[   57.031610] hm2/hm2_4i65.0:     IO Pin 012 (P1-25): IOPort 
[   57.031613] hm2/hm2_4i65.0:     IO Pin 013 (P1-27): IOPort 
[   57.031617] hm2/hm2_4i65.0:     IO Pin 014 (P1-29): IOPort 
[   57.031620] hm2/hm2_4i65.0:     IO Pin 015 (P1-31): IOPort 
[   57.031623] hm2/hm2_4i65.0:     IO Pin 016 (P1-33): IOPort 
[   57.031627] hm2/hm2_4i65.0:     IO Pin 017 (P1-35): IOPort 
[   57.031630] hm2/hm2_4i65.0:     IO Pin 018 (P1-37): IOPort 
[   57.031633] hm2/hm2_4i65.0:     IO Pin 019 (P1-39): IOPort 
[   57.031637] hm2/hm2_4i65.0:     IO Pin 020 (P1-41): IOPort 
[   57.031640] hm2/hm2_4i65.0:     IO Pin 021 (P1-43): IOPort 
[   57.031643] hm2/hm2_4i65.0:     IO Pin 022 (P1-45): IOPort 
[   57.031646] hm2/hm2_4i65.0:     IO Pin 023 (P1-47): IOPort 
[   57.031650] hm2/hm2_4i65.0:     IO Pin 024 (P3-01): IOPort 
[   57.031653] hm2/hm2_4i65.0:     IO Pin 025 (P3-03): IOPort 
[   57.031656] hm2/hm2_4i65.0:     IO Pin 026 (P3-05): IOPort 
[   57.031660] hm2/hm2_4i65.0:     IO Pin 027 (P3-07): IOPort 
[   57.031663] hm2/hm2_4i65.0:     IO Pin 028 (P3-09): IOPort 
[   57.031666] hm2/hm2_4i65.0:     IO Pin 029 (P3-11): IOPort 
[   57.031670] hm2/hm2_4i65.0:     IO Pin 030 (P3-13): IOPort 
[   57.031673] hm2/hm2_4i65.0:     IO Pin 031 (P3-15): IOPort 
[   57.031676] hm2/hm2_4i65.0:     IO Pin 032 (P3-17): IOPort 
[   57.031680] hm2/hm2_4i65.0:     IO Pin 033 (P3-19): IOPort 
[   57.031683] hm2/hm2_4i65.0:     IO Pin 034 (P3-21): IOPort 
[   57.031686] hm2/hm2_4i65.0:     IO Pin 035 (P3-23): IOPort 
[   57.031689] hm2/hm2_4i65.0:     IO Pin 036 (P3-25): IOPort 
[   57.031693] hm2/hm2_4i65.0:     IO Pin 037 (P3-27): IOPort 
[   57.031696] hm2/hm2_4i65.0:     IO Pin 038 (P3-29): IOPort 
[   57.031699] hm2/hm2_4i65.0:     IO Pin 039 (P3-31): IOPort 
[   57.031703] hm2/hm2_4i65.0:     IO Pin 040 (P3-33): IOPort 
[   57.031706] hm2/hm2_4i65.0:     IO Pin 041 (P3-35): IOPort 
[   57.031709] hm2/hm2_4i65.0:     IO Pin 042 (P3-37): IOPort 
[   57.031712] hm2/hm2_4i65.0:     IO Pin 043 (P3-39): IOPort 
[   57.031716] hm2/hm2_4i65.0:     IO Pin 044 (P3-41): IOPort 
[   57.031719] hm2/hm2_4i65.0:     IO Pin 045 (P3-43): IOPort 
[   57.031722] hm2/hm2_4i65.0:     IO Pin 046 (P3-45): IOPort 
[   57.031726] hm2/hm2_4i65.0:     IO Pin 047 (P3-47): IOPort 
[   57.031730] hm2/hm2_4i65.0:     IO Pin 048 (P4-01): Smart Serial Interface #0, pin RxData0 (Input) 
[   57.031734] hm2/hm2_4i65.0:     IO Pin 049 (P4-03): IOPort 
[   57.031738] hm2/hm2_4i65.0:     IO Pin 050 (P4-05): IOPort 
[   57.031741] hm2/hm2_4i65.0:     IO Pin 051 (P4-07): IOPort 
[   57.031746] hm2/hm2_4i65.0:     IO Pin 052 (P4-09): Smart Serial Interface #0, pin TxData0 (Output) 
[   57.031750] hm2/hm2_4i65.0:     IO Pin 053 (P4-11): Smart Serial Interface #0, pin TxEn0   (Output) 
[   57.031754] hm2/hm2_4i65.0:     IO Pin 054 (P4-13): IOPort 
[   57.031758] hm2/hm2_4i65.0:     IO Pin 055 (P4-15): IOPort 
[   57.031761] hm2/hm2_4i65.0:     IO Pin 056 (P4-17): IOPort 
[   57.031764] hm2/hm2_4i65.0:     IO Pin 057 (P4-19): IOPort 
[   57.031768] hm2/hm2_4i65.0:     IO Pin 058 (P4-21): IOPort 
[   57.031771] hm2/hm2_4i65.0:     IO Pin 059 (P4-23): IOPort 
[   57.031774] hm2/hm2_4i65.0:     IO Pin 060 (P4-25): IOPort 
[   57.031778] hm2/hm2_4i65.0:     IO Pin 061 (P4-27): IOPort 
[   57.031781] hm2/hm2_4i65.0:     IO Pin 062 (P4-29): IOPort 
[   57.031784] hm2/hm2_4i65.0:     IO Pin 063 (P4-31): IOPort 
[   57.031788] hm2/hm2_4i65.0:     IO Pin 064 (P4-33): IOPort 
[   57.031791] hm2/hm2_4i65.0:     IO Pin 065 (P4-35): IOPort 
[   57.031794] hm2/hm2_4i65.0:     IO Pin 066 (P4-37): IOPort 
[   57.031797] hm2/hm2_4i65.0:     IO Pin 067 (P4-39): IOPort 
[   57.031801] hm2/hm2_4i65.0:     IO Pin 068 (P4-41): IOPort 
[   57.031804] hm2/hm2_4i65.0:     IO Pin 069 (P4-43): IOPort 
[   57.031807] hm2/hm2_4i65.0:     IO Pin 070 (P4-45): IOPort 
[   57.031811] hm2/hm2_4i65.0:     IO Pin 071 (P4-47): IOPort 
[   57.031908] hm2/hm2_4i65.0: registered 
[   57.031912] hm2_4i65.0: initialized AnyIO board at 0000:03:00.0 
[   72.721723] 
[   72.721726] In recent history there were 
[   72.721727] 1732960, 1733111, 1733048, 1732999, and 1733152 
[   72.721729] elapsed clocks between calls to the motion controller. 
[   72.721735] This time, there were 26749013 which is so anomalously 
[   72.721737] large that it probably signifies a problem with your 
[   72.721738] realtime configuration.  For the rest of this run of 
[   72.721740] EMC, this message will be suppressed. 
[   72.721741] 
[   72.721745] RTAPI: ERROR: Unexpected realtime delay on task 1 
[   72.721746] This Message will only display once per session. 
[   72.721747] Run the Latency Test and resolve before continuing. 
[   72.721751] hm2/hm2_4i65.0: Watchdog has bit! (set the .has-bit pin to False to resume) 
[   72.723700] hm2/hm2_4i65.0: Smart Serial port 0: DoIt not cleared from previous servo thread. Servo thread rate probably too fast. This message will not be repeated, but the hm2_4i65.0.sserial.0.fault-count pin will indicate if this is happening frequently. 
[   72.741701] hm2/hm2_4i65.0: Smart Serial Comms Error: There have been more than 1 errors in 10 thread executions at least 200 times. See other error messages for details. 
[   72.741707] hm2/hm2_4i65.0: ***Smart Serial Port 0 will be stopped*** 
user@cnc:~$

The error linuxcnc reports is:
RTAPI: ERROR Unexpected Realtime delay on task 1
This message will only display once per session.
Run the latency Test and resolve before continuing

hm2/hm2_4i65.0 : Smart Serial Port 0 : DoIt not cleared from previous servo thread.
Servo thread rate probably too fast.
THis message will not be repeated , but the hm2_4i65.0.sserial.0.fault -count pin will indicate if this is happening frequently

hm2/hm2_4i65.0: Smart Serial Comms Error:
There have been more than 1 errors in 10 thread executions at least 200 times 
See other error messages for details

hm2/hm2_4i65.0: ***Smart Serial Port 0 will be stopped***

maybe someone can help
Last edit: 29 Sep 2014 18:15 by hardware_crash.

Please Log in or Create an account to join the conversation.

More
29 Sep 2014 19:09 #51652 by ArcEye
Hi

I am sure that PCW will be able to advise once the sun rises in his neck of the woods.

In the meanwhile, as the error suggests that the servo thread is too fast,

hm2/hm2_4i65.0 : Smart Serial Port 0 : DoIt not cleared from previous servo thread.
Servo thread rate probably too fast.


can you attach your ini and hal files, so we can see how things are set up

regards

Please Log in or Create an account to join the conversation.

More
29 Sep 2014 21:49 - 30 Sep 2014 01:07 #51656 by PCW

In recent history there were
[ 72.721727] 1732960, 1733111, 1733048, 1732999, and 1733152
[ 72.721729] elapsed clocks between calls to the motion controller.
[ 72.721735] This time, there were 26749013 which is so anomalously
[ 72.721737] large that it probably signifies a problem with your
[ 72.721738] realtime configuration. For the rest of this run of
[ 72.721740] EMC, this message will be suppressed.

Assuming the servo threads period is 1Khz, this indicates that the CPU had a ~15 ms latency spike!

The sserial port errors are just collateral damage, because the latency spike caused the (10 ms) watchdog to bite, disabling all serial I/O:

[ 72.721751] hm2/hm2_4i65.0: Watchdog has bit! (set the .has-bit pin to False to resume)
[ 72.723700] hm2/hm2_4i65.0: Smart Serial port 0: DoIt not cleared from previous servo thread. Servo thread rate probably too fast. This message will not be repeated, but the hm2_4i65.0.sserial.0.fault-count pin will indicate if this is happening frequently.

I would check that all power management and SMI are disabled
Last edit: 30 Sep 2014 01:07 by PCW.

Please Log in or Create an account to join the conversation.

More
30 Sep 2014 16:29 #51680 by hardware_crash
Dear PCW ,
a very strange thing is that it realy seems that the cpu stops for a moment as the mouse often get stuck while moving on the desktop :blink: (Mainboard : MB896IL )
I also noticed that when I set the servo thread rate in the ini file to 10000 and start linuxcnc the system freezes :/

I tried to disable all power management and smi settings but that didnt change anything.

I also tried with a few other mainboards as an Compaq an asus p4b800 and a intel d525mw all with disabled hyperthread, disabled power management, disabled apic and acpi.

The results didnt change : after about 60 sec the 4i65 stops with the known errors :(

Please Log in or Create an account to join the conversation.

More
30 Sep 2014 17:30 #51683 by ArcEye

I also noticed that when I set the servo thread rate in the ini file to 10000 and start linuxcnc the system freezes


10000ns would be very fast for a base thread.

The servo thread is normally set by default at 1000000ns.

If you set a thread too fast, it is constantly polling with no time for anything else to get a look in.

Try setting it to 1000000 and see if that improves things

regards

Please Log in or Create an account to join the conversation.

More
30 Sep 2014 21:11 - 01 Oct 2014 05:04 #51688 by PCW
So if multiple MBs dont fix the problem, its got to be a common hardware of software issue with the remaining parts...

Possibilities that come to mind:

Bad 4I65

Bad adapter (how does the 4I65 connect to the PCI slot?)

Bad bitfile (test by trying one of the standard distribution bitfiles and hm2-servo example hal file)

Bad harddrive

Bad video monitor (Ive seen latency problems with a bad DDC channel)

Software issues (what Linuxcnc version and OS version are you using?)


EDIT BTW dosen't seem to be a bitfile issue, ran that bitfile on my test machine for a couple hours without incident
Last edit: 01 Oct 2014 05:04 by PCW.

Please Log in or Create an account to join the conversation.

More
02 Oct 2014 15:45 - 02 Oct 2014 15:49 #51724 by hardware_crash
Hey guys ,

I tried to set the servo thread rate to the value ArcEye said but it didnt change the time linuxcnc takes to notice the realtime delay....

I think that it wont be a harddrive or video monitor problem as i checked with two other boards and configurations.

I also think that its not a problem with the adapter as i tried with 5i71 (PCI) and a 6i71 (PCIex1)

I Tried with the new Debian Image and with the Ubuntu 10.04 Image..

EDIT: Today I got my new board a Gigabyte GA-J1800N-D2H I will try with this board and a 6i71 to get a stable system, we will see ....
Does anybody have experience with this board ?
Last edit: 02 Oct 2014 15:49 by hardware_crash.

Please Log in or Create an account to join the conversation.

More
02 Oct 2014 16:14 #51725 by ArcEye

EDIT: Today I got my new board a Gigabyte GA-J1800N-D2H I will try with this board and a 6i71 to get a stable system, we will see ....
Does anybody have experience with this board ?


Unfortunately yes, albeit vicariously.

I put a big fat warning on the latency test page about this and the J1900
wiki.linuxcnc.org/cgi-bin/wiki.pl?Latency-Test

2 different users were unable to get it to recognise anything other than Windows 8 and even after a BIOS upgrade, USB did not work with rtai kernels

Hope you have better luck or can return

regards

Please Log in or Create an account to join the conversation.

More
02 Oct 2014 16:58 - 02 Oct 2014 18:18 #51727 by hardware_crash
dear ArcExe,

Okay that are bad news :/

I will give it a try and if that does not work i will return it ;)

EDIT: So I also ordered an ASRock E350M1 board for testing maybe I will start a little linuxcnc mainboard check :lol:
Last edit: 02 Oct 2014 18:18 by hardware_crash.

Please Log in or Create an account to join the conversation.

More
02 Oct 2014 18:36 #51728 by ArcEye

EDIT: So I also ordered an ASRock E350M1 board for testing maybe I will start a little linuxcnc mainboard check :lol:


2 entries for that board, both good results, especially if you are only using a servo thread, so hopefully that will be fine

regards

Please Log in or Create an account to join the conversation.

Time to create page: 0.215 seconds
Powered by Kunena Forum