RTAPI: ERROR: Unexpected realtime delay on task 1

I'm running LinuxCNC 2.5.4 on Ubuntu 10.04 LTS. The computer is a late 2003 Velocity Micro with specs as follows:

Motherboard Intel D875PBZLK 875 Chipset Motherboard w. Dual Channel DDR, 8x AGP

Processor Intel Pentium 4 3.2 GHz, 512 Cache, 800MHz FSB, with HyperThreading (disabled)

Video Adapter 256MB Visiontek Etasy ATI Radeon 9800 XT, Dual Heads, 8, AGP

(none of which means much to me).

I started out controlling a single Emco Compact 5 PC lathe with this configuration last May (2014) as a rank beginner. At that time the latency results, untortured, settled at about 5,500 ns servo and 6,000 ns base. The worst results I was able to generate were under 11,500 ns for both. Since then I've added another three Compact 5 PCs, which I control with the same computer and LinuxCNC installation, using four separate configurations and a 4-way parallel switch.

Several weeks ago I started getting "RTAP: ERROR: Unexpected realtime delay on task 1 errors" with what seemed to be increasing frequency. Now they generally occur within a few minutes of starting Linux CNC, whether or not I run a CNC program or anything else.

I haven't noticed any problem in running programs on any of the lathes. Nevertheless, I'll like to fix whatever is causing the error message.

I cut-and-pasted together the results of several dmesg commands. I can see the recurring pattern leading up to the error message, but I have no clue as to what it might mean.

Any help would be greatly appreciated. FWIW, I am using wireless via USB to connect both the keyboard and mouse. But that goes all the way back to May of last year.

[ 0.208169] ACPI: No dock devices found.
[ 0.208386] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.208464] pci 0000:00:00.0: Enabling MCH 'Overflow' Device
[ 0.208479] pci 0000:00:00.0: reg 10 32bit mmio pref: [0xf8000000-0xfbffffff]
[ 0.208629] pci 0000:00:06.0: reg 10 32bit mmio: [0xfecf0000-0xfecf0fff]
[ 0.208757] pci 0000:00:1d.0: reg 20 io port: [0xcc00-0xcc1f]
[ 0.208826] pci 0000:00:1d.1: reg 20 io port: [0xd000-0xd01f]
[ 0.208895] pci 0000:00:1d.2: reg 20 io port: [0xd400-0xd41f]
[ 0.208963] pci 0000:00:1d.3: reg 20 io port: [0xd800-0xd81f]
[ 0.209040] pci 0000:00:1d.7: reg 10 32bit mmio: [0xffaffc00-0xffafffff]
[ 0.209113] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[ 0.209122] pci 0000:00:1d.7: PME# disabled
[ 0.209234] pci 0000:00:1f.0: quirk: region 0400-047f claimed by ICH4 ACPI/GPIO/TCO
[ 0.209242] pci 0000:00:1f.0: quirk: region 0500-053f claimed by ICH4 GPIO
[ 0.209285] pci 0000:00:1f.1: reg 10 io port: [0x00-0x07]
[ 0.209297] pci 0000:00:1f.1: reg 14 io port: [0x00-0x03]
[ 0.209308] pci 0000:00:1f.1: reg 18 io port: [0x00-0x07]
[ 0.209319] pci 0000:00:1f.1: reg 1c io port: [0x00-0x03]
[ 0.209330] pci 0000:00:1f.1: reg 20 io port: [0xffa0-0xffaf]
[ 0.209341] pci 0000:00:1f.1: reg 24 32bit mmio: [0x000000-0x0003ff]
[ 0.209383] pci 0000:00:1f.2: reg 10 io port: [0xec00-0xec07]
[ 0.209393] pci 0000:00:1f.2: reg 14 io port: [0xe800-0xe803]
[ 0.209404] pci 0000:00:1f.2: reg 18 io port: [0xe400-0xe407]
[ 0.209415] pci 0000:00:1f.2: reg 1c io port: [0xe000-0xe003]
[ 0.209425] pci 0000:00:1f.2: reg 20 io port: [0xdc00-0xdc0f]
[ 0.209492] pci 0000:00:1f.3: reg 20 io port: [0xc800-0xc81f]
[ 0.209566] pci 0000:01:00.0: reg 10 32bit mmio pref: [0xe8000000-0xefffffff]
[ 0.209576] pci 0000:01:00.0: reg 14 io port: [0x9800-0x98ff]
[ 0.209586] pci 0000:01:00.0: reg 18 32bit mmio: [0xff7f0000-0xff7fffff]
[ 0.209609] pci 0000:01:00.0: reg 30 32bit mmio pref: [0xff7c0000-0xff7dffff]
[ 0.209638] pci 0000:01:00.0: supports D1 D2
[ 0.209676] pci 0000:01:00.1: reg 10 32bit mmio pref: [0xe0000000-0xe7ffffff]
[ 0.209687] pci 0000:01:00.1: reg 14 32bit mmio: [0xff7e0000-0xff7effff]
[ 0.209730] pci 0000:01:00.1: supports D1 D2
[ 0.209789] pci 0000:00:01.0: bridge io port: [0x9000-0x9fff]
[ 0.209797] pci 0000:00:01.0: bridge 32bit mmio: [0xff700000-0xff7fffff]
[ 0.209805] pci 0000:00:01.0: bridge 32bit mmio pref: [0xd6b00000-0xf6afffff]
[ 0.209862] pci 0000:02:01.0: reg 10 32bit mmio: [0xff8e0000-0xff8fffff]
[ 0.209878] pci 0000:02:01.0: reg 18 io port: [0xac00-0xac1f]
[ 0.209920] pci 0000:02:01.0: PME# supported from D0 D3hot D3cold
[ 0.209928] pci 0000:02:01.0: PME# disabled
[ 0.209979] pci 0000:00:03.0: bridge io port: [0xa000-0xafff]
[ 0.209986] pci 0000:00:03.0: bridge 32bit mmio: [0xff800000-0xff8fffff]
[ 0.210037] pci 0000:03:03.0: reg 10 io port: [0xb800-0xb83f]
[ 0.210092] pci 0000:03:03.0: supports D1 D2
[ 0.210132] pci 0000:03:03.1: reg 10 io port: [0xbc00-0xbc07]
[ 0.210187] pci 0000:03:03.1: supports D1 D2
[ 0.210231] pci 0000:03:03.2: reg 10 32bit mmio: [0xff9ff800-0xff9fffff]
[ 0.210243] pci 0000:03:03.2: reg 14 32bit mmio: [0xff9f8000-0xff9fbfff]
[ 0.210295] pci 0000:03:03.2: supports D1 D2
[ 0.210300] pci 0000:03:03.2: PME# supported from D0 D1 D2 D3hot
[ 0.210307] pci 0000:03:03.2: PME# disabled
[ 0.210366] pci 0000:00:1e.0: transparent bridge
[ 0.210375] pci 0000:00:1e.0: bridge io port: [0xb000-0xbfff]
[ 0.210385] pci 0000:00:1e.0: bridge 32bit mmio: [0xff900000-0xff9fffff]
[ 0.210414] pci_bus 0000:00: on NUMA node 0
[ 0.210428] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.210589] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P1._PRT]
[ 0.210670] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P2._PRT]
[ 0.210756] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P3._PRT]
[ 0.217328] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11 12 14 15)
[ 0.217586] ACPI: PCI Interrupt Link [LNKB] (IRQs *3 4 5 6 7 9 10 11 12 14 15)
[ 0.217835] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 9 *10 11 12 14 15)
[ 0.218063] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 *5 6 7 9 10 11 12 14 15)
[ 0.218308] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.218540] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.218796] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.219023] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 *9 10 11 12 14 15)
[ 0.219313] vgaarb: device added: PCI:0000:01:00.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.219327] vgaarb: loaded
[ 0.219563] SCSI subsystem initialized
[ 0.219783] libata version 3.00 loaded.
[ 0.219932] usbcore: registered new interface driver usbfs
[ 0.219958] usbcore: registered new interface driver hub
[ 0.220055] usbcore: registered new device driver usb
[ 0.220402] ACPI: WMI: Mapper loaded
[ 0.220408] PCI: Using ACPI for IRQ routing
[ 0.220742] NetLabel: Initializing
[ 0.220748] NetLabel: domain hash size = 128
[ 0.220751] NetLabel: protocols = UNLABELED CIPSOv4
[ 0.220777] NetLabel: unlabeled traffic allowed by default
[ 0.220848] Switching to clocksource tsc
[ 0.224222] AppArmor: AppArmor Filesystem Enabled
[ 0.224247] pnp: PnP ACPI init
[ 0.224275] ACPI: bus type pnp registered
[ 0.230572] pnp: PnP ACPI: found 12 devices
[ 0.230578] ACPI: ACPI bus type pnp unregistered
[ 0.230587] PnPBIOS: Disabled by ACPI PNP
[ 0.230616] system 00:08: ioport range 0x4d0-0x4d1 has been reserved
[ 0.230629] system 00:0a: ioport range 0x400-0x47f has been reserved
[ 0.230636] system 00:0a: ioport range 0x680-0x6ff has been reserved
[ 0.230643] system 00:0a: ioport range 0x500-0x53f has been reserved
[ 0.230651] system 00:0a: iomem range 0xfec00000-0xfec00fff could not be reserved
[ 0.230658] system 00:0a: iomem range 0xfee00000-0xfee00fff has been reserved
[ 0.230664] system 00:0a: iomem range 0xfed20000-0xfed9ffff has been reserved
[ 0.230677] system 00:0b: iomem range 0x0-0x9ffff could not be reserved
[ 0.230684] system 00:0b: iomem range 0xc0000-0xdffff could not be reserved
[ 0.230691] system 00:0b: iomem range 0xe0000-0xfffff could not be reserved
[ 0.230698] system 00:0b: iomem range 0x100000-0x3fffffff could not be reserved
[ 0.265698] pci 0000:00:01.0: PCI bridge, secondary bus 0000:01
[ 0.265707] pci 0000:00:01.0: IO window: 0x9000-0x9fff
[ 0.265715] pci 0000:00:01.0: MEM window: 0xff700000-0xff7fffff
[ 0.265723] pci 0000:00:01.0: PREFETCH window: 0xd6b00000-0xf6afffff
[ 0.265733] pci 0000:00:03.0: PCI bridge, secondary bus 0000:02
[ 0.265739] pci 0000:00:03.0: IO window: 0xa000-0xafff
[ 0.265748] pci 0000:00:03.0: MEM window: 0xff800000-0xff8fffff
[ 0.265755] pci 0000:00:03.0: PREFETCH window: disabled
[ 0.265765] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:03
[ 0.265771] pci 0000:00:1e.0: IO window: 0xb000-0xbfff
[ 0.265780] pci 0000:00:1e.0: MEM window: 0xff900000-0xff9fffff
[ 0.265787] pci 0000:00:1e.0: PREFETCH window: disabled
[ 0.265818] pci 0000:00:1e.0: setting latency timer to 64
[ 0.265827] pci_bus 0000:00: resource 0 io: [0x00-0xffff]
[ 0.265832] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffff]
[ 0.265838] pci_bus 0000:01: resource 0 io: [0x9000-0x9fff]
[ 0.265844] pci_bus 0000:01: resource 1 mem: [0xff700000-0xff7fffff]
[ 0.265849] pci_bus 0000:01: resource 2 pref mem [0xd6b00000-0xf6afffff]
[ 0.265855] pci_bus 0000:02: resource 0 io: [0xa000-0xafff]
[ 0.265861] pci_bus 0000:02: resource 1 mem: [0xff800000-0xff8fffff]
[ 0.265866] pci_bus 0000:03: resource 0 io: [0xb000-0xbfff]
[ 0.265872] pci_bus 0000:03: resource 1 mem: [0xff900000-0xff9fffff]
[ 0.265878] pci_bus 0000:03: resource 3 io: [0x00-0xffff]
[ 0.265883] pci_bus 0000:03: resource 4 mem: [0x000000-0xffffffff]
[ 0.265956] NET: Registered protocol family 2
[ 0.266142] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.266851] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[ 0.268245] TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.269062] TCP: Hash tables configured (established 131072 bind 65536)
[ 0.269071] TCP reno registered
[ 0.269291] NET: Registered protocol family 1
[ 0.269441] pci 0000:01:00.0: Boot video device
[ 0.269745] Scanning for low memory corruption every 60 seconds
[ 0.269942] audit: initializing netlink socket (disabled)
[ 0.269968] type=2000 audit(1432475946.266:1): initialized
[ 0.279224] highmem bounce pool size: 64 pages
[ 0.279235] HugeTLB registered 4 MB page size, pre-allocated 0 pages
[ 0.282431] VFS: Disk quotas dquot_6.5.2
[ 0.282563] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.283799] fuse init (API version 7.13)
[ 0.284003] msgmni has been set to 1706
[ 0.284483] alg: No test for stdrng (krng)
[ 0.284609] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 0.284617] io scheduler noop registered
[ 0.284621] io scheduler anticipatory registered
[ 0.284625] io scheduler deadline registered
[ 0.284715] io scheduler cfq registered (default)
[ 0.285006] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 0.285055] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 0.285238] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input0
[ 0.285255] ACPI: Sleep Button [SLPB]
[ 0.285351] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1
[ 0.285359] ACPI: Power Button [PWRF]
[ 0.288353] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.288468] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 0.289014] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 0.291341] brd: module loaded
[ 0.292369] loop: module loaded
[ 0.292632] input: Macintosh mouse button emulation as /devices/virtual/input/input2
[ 0.292828] ata_piix 0000:00:1f.1: version 2.13
[ 0.292848] ata_piix 0000:00:1f.1: enabling device (0005 -> 0007)
[ 0.292863] alloc irq_desc for 18 on node -1
[ 0.292869] alloc kstat_irqs on node -1
[ 0.292884] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[ 0.292981] ata_piix 0000:00:1f.1: setting latency timer to 64
[ 0.293178] scsi0 : ata_piix
[ 0.293339] scsi1 : ata_piix
[ 0.296492] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14
[ 0.296499] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15
[ 0.296563] ata_piix 0000:00:1f.2: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[ 0.296573] ata_piix 0000:00:1f.2: MAP [ P0 -- P1 -- ]
[ 0.296654] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 0.296745] isapnp: Scanning for PnP cards...
[ 0.351277] scsi2 : ata_piix
[ 0.389631] scsi3 : ata_piix
[ 0.391647] ata3: SATA max UDMA/133 cmd 0xec00 ctl 0xe800 bmdma 0xdc00 irq 18
[ 0.391652] ata4: SATA max UDMA/133 cmd 0xe400 ctl 0xe000 bmdma 0xdc08 irq 18
[ 0.392357] Fixed MDIO Bus: probed
[ 0.392420] PPP generic driver version 2.4.2
[ 0.392534] tun: Universal TUN/TAP device driver, 1.6
[ 0.392538] tun: (C) 1999-2004 Max Krasnyansky <This email address is being protected from spambots. You need JavaScript enabled to view it.>
[ 0.392685] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 0.392723] alloc irq_desc for 23 on node -1
[ 0.392727] alloc kstat_irqs on node -1
[ 0.392739] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 23 (level, low) -> IRQ 23
[ 0.392763] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[ 0.392769] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 0.392823] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1
[ 0.392863] ehci_hcd 0000:00:1d.7: debug port 1
[ 0.396751] ehci_hcd 0000:00:1d.7: cache line size of 128 is not supported
[ 0.403307] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xffaffc00
[ 0.419225] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[ 0.419434] usb usb1: configuration #1 chosen from 1 choice
[ 0.419491] hub 1-0:1.0: USB hub found
[ 0.419509] hub 1-0:1.0: 8 ports detected
[ 0.419627] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 0.419659] uhci_hcd: USB Universal Host Controller Interface driver
[ 0.419731] alloc irq_desc for 16 on node -1
[ 0.419736] alloc kstat_irqs on node -1
[ 0.419747] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.419761] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[ 0.419767] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 0.419830] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 0.419871] uhci_hcd 0000:00:1d.0: irq 16, io base 0x0000cc00
[ 0.420039] usb usb2: configuration #1 chosen from 1 choice
[ 0.420084] hub 2-0:1.0: USB hub found
[ 0.420098] hub 2-0:1.0: 2 ports detected
[ 0.420173] alloc irq_desc for 19 on node -1
[ 0.420177] alloc kstat_irqs on node -1
[ 0.420185] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[ 0.420195] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[ 0.420200] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 0.420257] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
[ 0.420292] uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d000
[ 0.420443] usb usb3: configuration #1 chosen from 1 choice
[ 0.420487] hub 3-0:1.0: USB hub found
[ 0.420502] hub 3-0:1.0: 2 ports detected
[ 0.420571] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 0.420580] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[ 0.420585] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 0.420643] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
[ 0.420670] uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d400
[ 0.420832] usb usb4: configuration #1 chosen from 1 choice
[ 0.420876] hub 4-0:1.0: USB hub found
[ 0.420890] hub 4-0:1.0: 2 ports detected
[ 0.420960] uhci_hcd 0000:00:1d.3: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.420970] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[ 0.420976] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 0.421032] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
[ 0.421058] uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d800
[ 0.421213] usb usb5: configuration #1 chosen from 1 choice
[ 0.421258] hub 5-0:1.0: USB hub found
[ 0.421272] hub 5-0:1.0: 2 ports detected
[ 0.421439] PNP: No PS/2 controller found. Probing ports directly.
[ 0.432260] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.432282] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 0.432545] mice: PS/2 mouse device common for all mice
[ 0.432751] rtc_cmos 00:02: RTC can wake from S4
[ 0.432840] rtc_cmos 00:02: rtc core: registered rtc_cmos as rtc0
[ 0.432868] rtc0: alarms up to one month, 114 bytes nvram
[ 0.433076] device-mapper: uevent: version 1.0.3
[ 0.433377] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: This email address is being protected from spambots. You need JavaScript enabled to view it.
[ 0.507450] device-mapper: multipath: version 1.1.0 loaded
[ 0.507457] device-mapper: multipath round-robin: version 1.0.0 loaded
[ 0.520873] EISA: Probing bus 0 at eisa.0
[ 0.520917] EISA: Detected 0 cards.
[ 0.520923] cpuidle: using governor ladder
[ 0.520927] cpuidle: using governor menu
[ 0.521656] TCP cubic registered
[ 0.521869] NET: Registered protocol family 10
[ 0.522610] lo: Disabled Privacy Extensions
[ 0.523254] NET: Registered protocol family 17
[ 0.523410] Using IPI No-Shortcut mode
[ 0.523573] registered taskstats version 1
[ 0.523953] rtc_cmos 00:02: setting system clock to 2015-05-24 13:59:07 UTC (1432475947)
[ 0.523958] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[ 0.523962] EDD information not available.
[ 0.631122] Freeing initrd memory: 12839k freed
[ 0.654423] isapnp: No Plug & Play device found
[ 0.654827] ata4.00: ATA-9: WDC WD10EZEX-00BN5A0, 01.01A01, max UDMA/133
[ 0.654831] ata4.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 0/32)
[ 0.663414] ata4.00: configured for UDMA/133
[ 0.683597] ata2.00: ATAPI: SONY DVD RW DW-U14A, 1.0d, max UDMA/33
[ 0.683637] ata2.01: ATAPI: JLMS XJ-HD166S, DS18, max UDMA/33
[ 0.699577] ata2.00: configured for UDMA/33
[ 0.699979] ata2.01: configured for UDMA/33
[ 0.702112] scsi 1:0:0:0: CD-ROM SONY DVD RW DW-U14A 1.0d PQ: 0 ANSI: 5
[ 0.705920] sr0: scsi3-mmc drive: 32x/32x writer cd/rw xa/form2 cdda tray
[ 0.705926] Uniform CD-ROM driver Revision: 3.20
[ 0.706078] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 0.706174] sr 1:0:0:0: Attached scsi generic sg0 type 5
[ 0.706526] scsi 1:0:1:0: CD-ROM JLMS XJ-HD166S DS18 PQ: 0 ANSI: 5
[ 0.708184] sr1: scsi3-mmc drive: 48x/48x cd/rw xa/form2 cdda tray
[ 0.708307] sr 1:0:1:0: Attached scsi CD-ROM sr1
[ 0.708378] sr 1:0:1:0: Attached scsi generic sg1 type 5
[ 0.708552] scsi 3:0:0:0: Direct-Access ATA WDC WD10EZEX-00B 01.0 PQ: 0 ANSI: 5
[ 0.708758] sd 3:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/931 GiB)
[ 0.708762] sd 3:0:0:0: Attached scsi generic sg2 type 0
[ 0.708769] sd 3:0:0:0: [sda] 4096-byte physical blocks
[ 0.708882] sd 3:0:0:0: [sda] Write Protect is off
[ 0.708887] sd 3:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 0.708928] sd 3:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 0.709161] sda: sda1 sda2 < sda5 >
[ 0.754721] sd 3:0:0:0: [sda] Attached SCSI disk
[ 0.754751] Freeing unused kernel memory: 620k freed
[ 0.755610] Write protecting the kernel text: 4540k
[ 0.755671] Write protecting the kernel read-only data: 1668k
[ 0.789151] udev: starting version 151
[ 0.957598] Linux agpgart interface v0.103
[ 0.963600] agpgart-intel 0000:00:00.0: Intel i875 Chipset
[ 0.966756] agpgart-intel 0000:00:00.0: AGP aperture is 64M @ 0xf8000000
[ 1.062961] Intel(R) PRO/1000 Network Driver - version 7.3.21-k5-NAPI
[ 1.062975] Copyright (c) 1999-2006 Intel Corporation.
[ 1.063129] e1000 0000:02:01.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[ 1.063144] e1000 0000:02:01.0: setting latency timer to 64
[ 1.085555] Floppy drive(s): fd0 is 1.44M
[ 1.112316] FDC 0 is a National Semiconductor PC87306
[ 1.117662] [drm] Initialized drm 1.1.0 20060810
[ 1.118150] ohci1394 0000:03:03.2: PCI INT B -> GSI 18 (level, low) -> IRQ 18
[ 1.135319] usb 3-1: new full speed USB device using uhci_hcd and address 2
[ 1.163379] [drm] radeon defaulting to kernel modesetting.
[ 1.163390] [drm] radeon kernel modesetting enabled.
[ 1.163472] radeon 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.166726] [drm] radeon: Initializing kernel modesetting.
[ 1.166924] [drm] register mmio base: 0xFF7F0000
[ 1.166927] [drm] register mmio size: 65536
[ 1.169161] [drm] GPU reset succeed (RBBM_STATUS=0x00000140)
[ 1.169194] [drm] Generation 1 PCI interface in multifunction mode
[ 1.169198] [drm] Limiting VRAM to one aperture
[ 1.169209] agpgart-intel 0000:00:00.0: AGP 3.0 bridge
[ 1.169232] agpgart-intel 0000:00:00.0: putting AGP V3 device into 8x mode
[ 1.169280] radeon 0000:01:00.0: putting AGP V3 device into 8x mode
[ 1.169315] [drm] radeon: VRAM 128M
[ 1.169318] [drm] radeon: VRAM from 0x00000000 to 0x07FFFFFF
[ 1.169321] [drm] radeon: GTT 64M
[ 1.169324] [drm] radeon: GTT from 0xF8000000 to 0xFBFFFFFF
[ 1.169348] [drm] radeon: irq initialized.
[ 1.169554] [drm] Detected VRAM RAM=128M, BAR=128M
[ 1.169559] [drm] RAM width 256bits DDR
[ 1.169700] [TTM] Zone kernel: Available graphics memory: 443646 kiB.
[ 1.169704] [TTM] Zone highmem: Available graphics memory: 512830 kiB.
[ 1.169727] [drm] radeon: 128M of VRAM memory ready
[ 1.169731] [drm] radeon: 64M of GTT memory ready.
[ 1.169970] [drm] radeon: 2 quad pipes, 1 Z pipes initialized.
[ 1.169986] [drm] radeon: cp idle (0x10000C00)
[ 1.170035] [drm] Loading R300 Microcode
[ 1.170400] platform radeon_cp.0: firmware: requesting radeon/R300_cp.bin
[ 1.171215] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[18] MMIO=[ff9ff800-ff9fffff] Max Packet=[2048] IR/IT contexts=[4/8]
[ 1.181971] [drm] radeon: ring at 0x00000000F8000000
[ 1.181993] [drm] ring test succeeded in 0 usecs
[ 1.188106] [drm] radeon: ib pool ready.
[ 1.188263] [drm] ib test succeeded in 0 usecs
[ 1.189413] [drm] Default TV standard: NTSC
[ 1.189419] [drm] 27.000000000 MHz TV ref clk
[ 1.189426] [drm] DFP table revision: 4
[ 1.189757] [drm] Default TV standard: NTSC
[ 1.189761] [drm] 27.000000000 MHz TV ref clk
[ 1.189834] [drm] Radeon Display Connectors
[ 1.189837] [drm] Connector 0:
[ 1.189840] [drm] VGA
[ 1.189844] [drm] DDC: 0x60 0x60 0x60 0x60 0x60 0x60 0x60 0x60
[ 1.189846] [drm] Encoders:
[ 1.189849] [drm] CRT1: INTERNAL_DAC1
[ 1.189852] [drm] Connector 1:
[ 1.189854] [drm] DVI-I
[ 1.189857] [drm] HPD1
[ 1.189860] [drm] DDC: 0x64 0x64 0x64 0x64 0x64 0x64 0x64 0x64
[ 1.189863] [drm] Encoders:
[ 1.189865] [drm] CRT2: INTERNAL_DAC2
[ 1.189868] [drm] DFP1: INTERNAL_TMDS1
[ 1.189871] [drm] Connector 2:
[ 1.189873] [drm] S-video
[ 1.189875] [drm] Encoders:
[ 1.189878] [drm] TV1: INTERNAL_DAC2
[ 1.223388] e1000: 0000:02:01.0: e1000_probe: (PCI:33MHz:32-bit) 00:07:e9:6d:2b:2c
[ 1.329912] usb 3-1: configuration #1 chosen from 1 choice
[ 1.346908] [drm] fb mappable at 0xE8040000
[ 1.346915] [drm] vram apper at 0xE8000000
[ 1.346919] [drm] size 5760000
[ 1.346922] [drm] fb depth is 24
[ 1.346926] [drm] pitch is 6400
[ 1.364766] fb0: radeondrmfb frame buffer device
[ 1.364771] registered panic notifier
[ 1.364783] [drm] Initialized radeon 2.0.0 20080528 for 0000:01:00.0 on minor 0
[ 1.366234] usbcore: registered new interface driver hiddev
[ 1.370169] input: Logitech USB Receiver as /devices/pci0000:00/0000:00:1d.1/usb3/3-1/3-1:1.0/input/input3
[ 1.370470] generic-usb 0003:046D:C52B.0001: input,hidraw0: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-0000:00:1d.1-1/input0
[ 1.370800] vga16fb: initializing
[ 1.370808] vga16fb: mapped to 0xc00a0000
[ 1.370818] vga16fb: not registering due to another framebuffer present
[ 1.376969] input: Logitech USB Receiver as /devices/pci0000:00/0000:00:1d.1/usb3/3-1/3-1:1.1/input/input4
[ 1.377398] generic-usb 0003:046D:C52B.0002: input,hiddev96,hidraw1: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-0000:00:1d.1-1/input1
[ 1.383619] generic-usb 0003:046D:C52B.0003: hiddev97,hidraw2: USB HID v1.11 Device [Logitech USB Receiver] on usb-0000:00:1d.1-1/input2
[ 1.383701] usbcore: registered new interface driver usbhid
[ 1.383708] usbhid: v2.6:USB HID core driver
[ 1.467607] Console: switching to colour frame buffer device 200x56
[ 1.503037] e1000: eth0: e1000_probe: Intel(R) PRO/1000 Network Connection
[ 1.573081] usb 3-2: new full speed USB device using uhci_hcd and address 3
[ 1.758485] usb 3-2: configuration #1 chosen from 1 choice
[ 1.766736] input: Logitech USB Receiver as /devices/pci0000:00/0000:00:1d.1/usb3/3-2/3-2:1.0/input/input5
[ 1.767044] generic-usb 0003:046D:C52B.0004: input,hidraw3: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-0000:00:1d.1-2/input0
[ 1.771457] input: Logitech USB Receiver as /devices/pci0000:00/0000:00:1d.1/usb3/3-2/3-2:1.1/input/input6
[ 1.771852] generic-usb 0003:046D:C52B.0005: input,hiddev98,hidraw4: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-0000:00:1d.1-2/input1
[ 1.778496] generic-usb 0003:046D:C52B.0006: hiddev99,hidraw5: USB HID v1.11 Device [Logitech USB Receiver] on usb-0000:00:1d.1-2/input2
[ 1.982492] xor: automatically using best checksumming function: pIII_sse
[ 2.000025] pIII_sse : 4165.000 MB/sec
[ 2.000036] xor: using function: pIII_sse (4165.000 MB/sec)
[ 2.007623] device-mapper: dm-raid45: initialized v0.2594b
[ 2.288770] EXT4-fs (sda1): mounted filesystem with ordered data mode
[ 2.448382] ieee1394: Host added: ID:BUS[0-00:1023] GUID[00023c0151027505]
[ 6.911789] udev: starting version 151
[ 6.956359] Adding 3002360k swap on /dev/sda5. Priority:-1 extents:1 across:3002360k
[ 7.153509] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 7.171935] lp: driver loaded but no devices found
[ 7.224311] parport_pc 00:07: reported by Plug and Play ACPI
[ 7.224366] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[ 7.283218] Intel 82802 RNG detected
[ 7.316489] lp0: using parport0 (interrupt-driven).
[ 7.585192] ppdev: user-space parallel port driver
[ 7.587855] gameport: EMU10K1 is pci0000:03:03.1/gameport0, io 0xbc00, speed 1242kHz
[ 7.704065] type=1505 audit(1432475954.676:2): operation="profile_load" pid=646 name="/sbin/dhclient3"
[ 7.704980] type=1505 audit(1432475954.680:3): operation="profile_load" pid=646 name="/usr/lib/NetworkManager/nm-dhcp-client.action"
[ 7.705371] type=1505 audit(1432475954.680:4): operation="profile_load" pid=646 name="/usr/lib/connman/scripts/dhclient-script"
[ 7.865701] EMU10K1_Audigy 0000:03:03.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
[ 7.869610] Installing spdif_bug patch: SB Audigy 2 ZS [SB0350]
[ 8.155050] type=1505 audit(1432475955.128:5): operation="profile_replace" pid=792 name="/sbin/dhclient3"
[ 8.155158] type=1505 audit(1432475955.128:6): operation="profile_load" pid=791 name="/usr/share/gdm/guest-session/Xsession"
[ 8.155763] type=1505 audit(1432475955.128:7): operation="profile_replace" pid=792 name="/usr/lib/NetworkManager/nm-dhcp-client.action"
[ 8.156317] type=1505 audit(1432475955.132:8): operation="profile_replace" pid=792 name="/usr/lib/connman/scripts/dhclient-script"
[ 8.167801] type=1505 audit(1432475955.140:9): operation="profile_load" pid=795 name="/usr/lib/cups/backend/cups-pdf"
[ 8.168695] type=1505 audit(1432475955.144:10): operation="profile_load" pid=795 name="/usr/sbin/cupsd"
[ 8.189592] type=1505 audit(1432475955.164:11): operation="profile_load" pid=793 name="/usr/bin/evince"
[ 8.232220] ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 9.064490] CPU0 attaching NULL sched-domain.
[ 9.064503] CPU1 attaching NULL sched-domain.
[ 9.084149] CPU0 attaching sched-domain:
[ 9.084160] domain 0: span 0-1 level SIBLING
[ 9.084167] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 9.084182] domain 1: span 0-1 level MC
[ 9.084189] groups: 0-1 (cpu_power = 1178)
[ 9.084204] CPU1 attaching sched-domain:
[ 9.084209] domain 0: span 0-1 level SIBLING
[ 9.084216] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 9.084232] domain 1: span 0-1 level MC
[ 9.084238] groups: 0-1 (cpu_power = 1178)
[ 10.901979] CPU0 attaching NULL sched-domain.
[ 10.901993] CPU1 attaching NULL sched-domain.
[ 10.920200] CPU0 attaching sched-domain:
[ 10.920209] domain 0: span 0-1 level SIBLING
[ 10.920215] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 10.920230] domain 1: span 0-1 level MC
[ 10.920237] groups: 0-1 (cpu_power = 1178)
[ 10.920253] CPU1 attaching sched-domain:
[ 10.920259] domain 0: span 0-1 level SIBLING
[ 10.920266] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 10.920281] domain 1: span 0-1 level MC
[ 10.920287] groups: 0-1 (cpu_power = 1178)
[ 24.372690] I-pipe: Domain RTAI registered.
[ 24.372705] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[ 24.372711] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[ 24.372773] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[ 24.372778] PIPELINE layers:
[ 24.372783] f8849e20 9ac15d93 RTAI 200
[ 24.372788] c085cb20 0 Linux 100
[ 24.400176] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[ 24.400436] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[ 24.400445] RTAI[sched]: hard timer type/freq = APIC/12468620(Hz); default timing: periodic; linear timed lists.
[ 24.400450] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 3191647000 hz.
[ 24.400453] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[ 24.400721] RTAI[usi]: enabled.
[ 24.510510] RTAI[math]: loaded.
[ 24.647795] config string '0x378 out '
[ 1102.987209] RTAPI: ERROR: Unexpected realtime delay on task 1
[ 1102.987214] This Message will only display once per session.
[ 1102.987216] Run the Latency Test and resolve before continuing.
[18750.202893] RTAI[math]: unloaded.
[18750.260779] SCHED releases registered named ALIEN RTGLBH
[18750.292426] RTAI[malloc]: unloaded.
[18750.392031] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0).
[18750.396924] I-pipe: Domain RTAI unregistered.
[18750.397001] RTAI[hal]: unmounted.
[18756.188585] I-pipe: Domain RTAI registered.
[18756.188602] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[18756.188608] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[18756.188669] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[18756.188673] PIPELINE layers:
[18756.188679] f8849e20 9ac15d93 RTAI 200
[18756.188683] c085cb20 0 Linux 100
[18756.213968] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[18756.214385] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[18756.214394] RTAI[sched]: hard timer type/freq = APIC/12468620(Hz); default timing: periodic; linear timed lists.
[18756.214399] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 3191647000 hz.
[18756.214403] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[18756.214537] RTAI[usi]: enabled.
[18756.305554] RTAI[math]: loaded.
[18756.398204] config string '0x378 out '
[20434.499009] RTAPI: ERROR: Unexpected realtime delay on task 1
[20434.499012] This Message will only display once per session.
[20434.499014] Run the Latency Test and resolve before continuing.
[21391.815481] RTAI[math]: unloaded.
[21391.873878] SCHED releases registered named ALIEN RTGLBH
[21391.907148] RTAI[malloc]: unloaded.
[21392.004039] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0).
[21392.008909] I-pipe: Domain RTAI unregistered.
[21392.008986] RTAI[hal]: unmounted.
[21396.997627] I-pipe: Domain RTAI registered.
[21396.997641] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[21396.997646] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[21396.997714] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[21396.997720] PIPELINE layers:
[21396.997726] f8849e20 9ac15d93 RTAI 200
[21396.997730] c085cb20 0 Linux 100
[21397.024042] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[21397.024469] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[21397.024478] RTAI[sched]: hard timer type/freq = APIC/12468620(Hz); default timing: periodic; linear timed lists.
[21397.024483] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 3191647000 hz.
[21397.024487] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[21397.024618] RTAI[usi]: enabled.
[21397.112550] RTAI[math]: loaded.
[21397.209629] config string '0x378 out '
[21408.397386] RTAI[math]: unloaded.
[21408.452695] SCHED releases registered named ALIEN RTGLBH
[21408.481426] RTAI[malloc]: unloaded.
[21408.581046] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0).
[21408.586957] I-pipe: Domain RTAI unregistered.
[21408.587029] RTAI[hal]: unmounted.
[21412.911453] I-pipe: Domain RTAI registered.
[21412.911468] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[21412.911473] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[21412.911540] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[21412.911544] PIPELINE layers:
[21412.911550] f8849e20 9ac15d93 RTAI 200
[21412.911556] c085cb20 0 Linux 100
[21412.941361] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[21412.941698] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[21412.941706] RTAI[sched]: hard timer type/freq = APIC/12468620(Hz); default timing: periodic; linear timed lists.
[21412.941711] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 3191647000 hz.
[21412.941714] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[21412.941845] RTAI[usi]: enabled.
[21413.023733] RTAI[math]: loaded.
[21413.125411] config string '0x378 out '
[22060.879285] RTAPI: ERROR: Unexpected realtime delay on task 1
[22060.879301] This Message will only display once per session.
[22060.879303] Run the Latency Test and resolve before continuing.
[22656.357275] RTAI[math]: unloaded.
[22656.421476] SCHED releases registered named ALIEN RTGLBH
[22656.453421] RTAI[malloc]: unloaded.
[22656.553023] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0).
[22656.557492] I-pipe: Domain RTAI unregistered.
[22656.557567] RTAI[hal]: unmounted.
[22659.831625] I-pipe: Domain RTAI registered.
[22659.831634] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[22659.831638] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[22659.831703] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[22659.831707] PIPELINE layers:
[22659.831711] f8849e20 9ac15d93 RTAI 200
[22659.831714] c085cb20 0 Linux 100
[22659.856887] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[22659.857597] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[22659.857606] RTAI[sched]: hard timer type/freq = APIC/12468620(Hz); default timing: periodic; linear timed lists.
[22659.857611] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 3191647000 hz.
[22659.857615] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[22659.857746] RTAI[usi]: enabled.
[22659.946628] RTAI[math]: loaded.
[22660.043418] config string '0x378 out '
[22888.318832] RTAPI: ERROR: Unexpected realtime delay on task 1
[22888.318837] This Message will only display once per session.
[22888.318838] Run the Latency Test and resolve before continuing.
[34270.041277] usb 1-8: new high speed USB device using ehci_hcd and address 4
[34270.174533] usb 1-8: configuration #1 chosen from 1 choice
[34270.235706] Initializing USB Mass Storage driver...
[34270.236007] scsi4 : SCSI emulation for USB Mass Storage devices
[34270.238093] usbcore: registered new interface driver usb-storage
[34270.238103] USB Mass Storage support registered.
[34270.250667] usb-storage: device found at 4
[34270.250674] usb-storage: waiting for device to settle before scanning
[34275.248345] usb-storage: device scan complete
[34275.248930] scsi 4:0:0:0: Direct-Access USB Flash Memory 1.00 PQ: 0 ANSI: 2
[34275.252351] sd 4:0:0:0: Attached scsi generic sg3 type 0
[34275.258319] sd 4:0:0:0: [sdb] 3911616 512-byte logical blocks: (2.00 GB/1.86 GiB)
[34275.258951] sd 4:0:0:0: [sdb] Write Protect is off
[34275.258959] sd 4:0:0:0: [sdb] Mode Sense: 65 44 09 30
[34275.258965] sd 4:0:0:0: [sdb] Assuming drive cache: write through
[34275.263596] sd 4:0:0:0: [sdb] Assuming drive cache: write through
[34275.263628] sdb: unknown partition table
[34275.273424] sd 4:0:0:0: [sdb] Assuming drive cache: write through
[34275.273442] sd 4:0:0:0: [sdb] Attached SCSI removable disk
[34350.153164] usb 1-8: USB disconnect, address 4
[34523.070594] RTAI[math]: unloaded.
[34523.145598] SCHED releases registered named ALIEN RTGLBH
[34523.177467] RTAI[malloc]: unloaded.
[34523.276025] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0).
[34523.281463] I-pipe: Domain RTAI unregistered.
[34523.281545] RTAI[hal]: unmounted.
[34526.582039] I-pipe: Domain RTAI registered.
[34526.582056] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[34526.582061] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[34526.582125] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[34526.582130] PIPELINE layers:
[34526.582135] f8849e20 9ac15d93 RTAI 200
[34526.582139] c085cb20 0 Linux 100
[34526.608154] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[34526.608438] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[34526.608446] RTAI[sched]: hard timer type/freq = APIC/12468620(Hz); default timing: periodic; linear timed lists.
[34526.608451] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 3191647000 hz.
[34526.608455] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[34526.610063] RTAI[usi]: enabled.
[34526.697303] RTAI[math]: loaded.
[34526.797272] config string '0x378 out '
[34769.161424] RTAPI: ERROR: Unexpected realtime delay on task 1
[34769.161429] This Message will only display once per session.
[34769.161431] Run the Latency Test and resolve before continuing.
[35020.014397] RTAI[math]: unloaded.
[35020.087112] SCHED releases registered named ALIEN RTGLBH
[35020.117418] RTAI[malloc]: unloaded.
[35020.217023] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0).
[35020.221623] I-pipe: Domain RTAI unregistered.
[35020.221701] RTAI[hal]: unmounted.
[35021.742485] I-pipe: Domain RTAI registered.
[35021.742500] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[35021.742505] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[35021.742569] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[35021.742573] PIPELINE layers:
[35021.742579] f9587e20 9ac15d93 RTAI 200
[35021.742584] c085cb20 0 Linux 100
[35021.768957] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[35021.769524] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[35021.769533] RTAI[sched]: hard timer type/freq = APIC/12468620(Hz); default timing: periodic; linear timed lists.
[35021.769539] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 3191647000 hz.
[35021.769542] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[35021.769676] RTAI[usi]: enabled.
[35021.848487] RTAI[math]: loaded.
[35021.942733] config string'0x378 out '
[35388.215398] RTAPI: ERROR: Unexpected realtime delay on task 1[/color][35388.215404] This Message will only display once per session.
[35388.215406] Run the Latency Test and resolve before continuing.
[35586.780431] RTAI[math]: unloaded.
[35586.845491] SCHED releases registered named ALIEN RTGLBH
[35586.877458] RTAI[malloc]: unloaded.
[35586.976040] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0).
[35586.980663] I-pipe: Domain RTAI unregistered.
[35586.980740] RTAI[hal]: unmounted.
krlynn@Raptor:~$

What is your base thread period?

I don't have any understanding of what it means, but it's 49885. I took the configuration from here .

FWIW, I checked each of the four identical configurations I have set up, and Time and Max-time appear to be running in ranges of about 25000-29750 and 80000-115000, respectively. Don't really know what that means either.

Thanks!

P.S.

I took the values above from Show Hal Configuration under Machine in Axis. Was just looking at the ini file and noticed Base Period is set at 50000 there.

If these real time errors just started happening and you did not make any changes in the HAL or INI files,
it could be that something has failed on the motherboard or perhaps the hard drive is getting flakey
(not unlikely with a 12 year old system)

Might be worth running the latency test again

They started within the past couple months. I haven't made any configuration changes since starting out a year ago. I did put in a new hard drive back then, and also replace the video card (which has a bad fan) with one that was identical to the original.

I have run the latency test, and should have included those result in the OP. Still probably tolerable at around 25,000 max jitter, but way up from what it was.

I've studied the hardware list and started looking for a replacement computer, but don't want to buy five to find one that's mediocre. I need to search here to see if there are any recommendations for easily found, off-the-shelf machines that generally serve well for this purpose.

If you want very good latency for software stepgen and good general performance
but dont mind a fan I would suggest a Asrock h97m pro4 and a G3250/G3258/G3240 CPU

Heres an example of Servo thread latency with this combo:

freeby.mesanet.com/h97-g3258.png

Note that this MB has a header for the parallel port, not a DB 25

For a fanless system, the J1800,J1900 systems are OK but not a whole lot better than
your current system latency wise (though about twice as fast)

Thanks! I don't mind a fan. Would love to figure out how to engineer better cooling for the Emco lathes.

So now stupid question: is the combination you suggest something I can find in a pre-build computer (and if so, what would it be), or would I need to build it (or find someone to build it)? Depending on cost, I'd probably end up getting two.

PCW wrote:

If you want very good latency for software stepgen and good general performance
but dont mind a fan I would suggest a Asrock h97m pro4 and a G3250/G3258/G3240 CPU

Heres an example of Servo thread latency with this combo:

freeby.mesanet.com/h97-g3258.png

Note that this MB has a header for the parallel port, not a DB 25

For a fanless system, the J1800,J1900 systems are OK but not a whole lot better than
your current system latency wise (though about twice as fast)

PCW wrote:

Note that this MB has a header for the parallel port, not a DB 25

But a card can be installed, right? Or is there a way to directly convert to DB25? That's critical for me.

Thanks very, very much!

andypugh wrote:

krlynn wrote:

PCW wrote:

Note that this MB has a header for the parallel port, not a DB 25

But a card can be installed, right? Or is there a way to directly convert to DB25? That's critical for me.

You just need www.amazon.com/StarTech-Profile-16-Inch-...ords=parallel+header or similar.

I prefer to put the motherboard in the box with the other (more expensive) electronics and run it with a Pico PSU and 12V from the main 12V feed.

You can probably find room in your Emco PC to put a motherboard, and make it not look like the PC variant any more.

If there is any hint that the software stepgen is holding you back it might be better to upgrade to hardware step generation and keep the same PC. A 5i25 can act like a souped-up parallel port card and will mean you don;t need to worry so much about base-thread timing any more.
Having said that, a 2003 PC is probably not the most reliable thing to be using (though, actually, my lathe is controlled by a 2001 1U server)