Print file information: RUN_IN_PLACE=no EMC2_DIR= EMC2_BIN_DIR=/usr/bin EMC2_TCL_DIR=/usr/share/emc/tcl EMC2_SCRIPT_DIR= EMC2_RTLIB_DIR=/usr/realtime-2.6.24-16-rtai/modules/emc2 EMC2_CONFIG_DIR= EMC2_LANG_DIR=/usr/share/emc/tcl/msgs INIVAR=inivar HALCMD=halcmd EMC2_EMCSH=emcsh EMC2_IOSH=iosh EMC2 - 2.3.0 Machine configuration directory is '/home/colin/emc2/configs/Colin_Mill' Machine configuration file is 'Colin_Mill.ini' INIFILE=/home/colin/emc2/configs/Colin_Mill/Colin_Mill.ini PARAMETER_FILE=emc.var EMCMOT=motmod EMCIO=io TASK=milltask HALUI= DISPLAY=axis NML_FILE=emc.nml Starting EMC2... Starting EMC2 server program: emcsvr Loading Real Time OS, RTAPI, and HAL_LIB modules Realtime system did not load Shutting down and cleaning up EMC2... Killing task emcsvr, PID=5406 Removing HAL_LIB, RTAPI, and Real Time OS modules Removing NML shared memory segments Cleanup done Kernel message information: [ 0.000000] Linux version 2.6.24-16-rtai (root@hardy) (gcc version 4.2.3 (Ubuntu 4.2.3-2ubuntu7)) #1 Tue Sep 30 22:54:33 EEST 2008 (Ubuntu 2.6.24-12.22-generic) [ 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 - 000000001bff0000 (usable) [ 0.000000] BIOS-e820: 000000001bff0000 - 000000001bff3000 (ACPI NVS) [ 0.000000] BIOS-e820: 000000001bff3000 - 000000001c000000 (ACPI data) [ 0.000000] BIOS-e820: 00000000ffff0000 - 0000000100000000 (reserved) [ 0.000000] 0MB HIGHMEM available. [ 0.000000] 447MB LOWMEM available. [ 0.000000] Entering add_active_range(0, 0, 114672) 0 entries of 256 used [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0 -> 4096 [ 0.000000] Normal 4096 -> 114672 [ 0.000000] HighMem 114672 -> 114672 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[1] active PFN ranges [ 0.000000] 0: 0 -> 114672 [ 0.000000] On node 0 totalpages: 114672 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 4064 pages, LIFO batch:0 [ 0.000000] Normal zone: 863 pages used for memmap [ 0.000000] Normal zone: 109713 pages, LIFO batch:31 [ 0.000000] HighMem zone: 0 pages used for memmap [ 0.000000] Movable zone: 0 pages used for memmap [ 0.000000] DMI 2.3 present. [ 0.000000] Allocating PCI resources starting at 20000000 (gap: 1c000000:e3ff0000) [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 113777 [ 0.000000] Kernel command line: root=UUID=8ad47a77-c8d0-4ad7-ac19-b5cf1ed90a35 ro quiet splash [ 0.000000] Enabling fast FPU save and restore... done. [ 0.000000] Enabling unmasked SIMD FPU exception support... done. [ 0.000000] Initializing CPU#0 [ 0.000000] PID hash table entries: 2048 (order: 11, 8192 bytes) [ 0.000000] Detected 798.041 MHz processor. [ 27.286948] I-pipe 2.0-04: pipeline enabled. [ 27.288350] Console: colour VGA+ 80x25 [ 27.288361] console [tty0] enabled [ 27.288800] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes) [ 27.289632] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes) [ 27.326160] Memory: 444528k/458688k available (1440k kernel code, 13560k reserved, 573k data, 228k init, 0k highmem) [ 27.326198] virtual kernel memory layout: [ 27.326203] fixmap : 0xfffed000 - 0xfffff000 ( 72 kB) [ 27.326210] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 27.326217] vmalloc : 0xdc800000 - 0xff7fe000 ( 559 MB) [ 27.326224] lowmem : 0xc0000000 - 0xdbff0000 ( 447 MB) [ 27.326231] .init : 0xc02fa000 - 0xc0333000 ( 228 kB) [ 27.326238] .data : 0xc026836d - 0xc02f77ec ( 573 kB) [ 27.326245] .text : 0xc0100000 - 0xc026836d (1440 kB) [ 27.326259] Checking if this processor honours the WP bit even in supervisor mode... Ok. [ 27.326364] SLUB: Genslabs=11, HWalign=64, Order=0-1, MinObjects=4, CPUs=1, Nodes=1 [ 27.406391] Calibrating delay using timer specific routine.. 1597.31 BogoMIPS (lpj=3194625) [ 27.406457] Security Framework initialized [ 27.406472] SELinux: Disabled at boot. [ 27.406521] AppArmor: AppArmor initialized [ 27.406535] Failure registering capabilities with primary security module. [ 27.406557] Mount-cache hash table entries: 512 [ 27.406796] CPU: After generic identify, caps: a7c9b8ff 00000000 00000000 00000000 00000181 00000000 00000000 00000000 [ 27.406826] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) [ 27.406838] CPU: L2 Cache: 128K (64 bytes/line) [ 27.406847] CPU: After all inits, caps: 27c9b8ff 00000000 00000000 00000000 00000181 00003fcc 00000000 00000000 [ 27.406877] Compat vDSO mapped to ffffe000. [ 27.406904] CPU: Centaur VIA Esther processor 1000MHz stepping 09 [ 27.406922] Checking 'hlt' instruction... OK. [ 27.422741] Freeing SMP alternatives: 0k freed [ 27.423159] net_namespace: 64 bytes [ 27.424624] NET: Registered protocol family 16 [ 27.425103] EISA bus registered [ 27.433514] PCI: PCI BIOS revision 2.10 entry at 0xfa9b0, last bus=1 [ 27.433525] PCI: Using configuration type 1 [ 27.433533] Setting up standard PCI resources [ 27.443316] Linux Plug and Play Support v0.97 (c) Adam Belay [ 27.443903] PCI: Probing PCI hardware [ 27.443919] PCI: Probing PCI hardware (bus 00) [ 27.466475] AppArmor: AppArmor Filesystem Enabled [ 27.467429] PCI: Bridge: 0000:00:01.0 [ 27.467440] IO window: b000-bfff [ 27.467453] MEM window: fb000000-fcffffff [ 27.467465] PREFETCH window: f4000000-f7ffffff [ 27.467499] PCI: Setting latency timer of device 0000:00:01.0 to 64 [ 27.467535] NET: Registered protocol family 2 [ 27.470389] Time: tsc clocksource has been installed. [ 27.502555] IP route cache hash table entries: 4096 (order: 2, 16384 bytes) [ 27.503238] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [ 27.503619] TCP bind hash table entries: 16384 (order: 4, 65536 bytes) [ 27.503866] TCP: Hash tables configured (established 16384 bind 16384) [ 27.503877] TCP reno registered [ 27.514811] checking if image is initramfs... it is [ 29.883311] Freeing initrd memory: 6871k freed [ 29.884162] audit: initializing netlink socket (disabled) [ 29.884194] audit(1146519574.560:1): initialized [ 29.889296] VFS: Disk quotas dquot_6.5.1 [ 29.889382] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 29.889699] io scheduler noop registered [ 29.889707] io scheduler anticipatory registered [ 29.889717] io scheduler deadline registered [ 29.889752] io scheduler cfq registered (default) [ 29.889787] PCI: VIA PCI bridge detected. Disabling DAC. [ 29.889893] Boot video device is 0000:01:00.0 [ 29.890502] isapnp: Scanning for PnP cards... [ 30.244924] isapnp: No Plug & Play device found [ 30.330129] Real Time Clock Driver v1.12ac [ 30.330142] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled [ 30.330334] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 30.333013] RAMDISK driver initialized: 16 RAM disks of 65536K size 1024 blocksize [ 30.333256] input: Macintosh mouse button emulation as /devices/virtual/input/input0 [ 30.333577] PNP: No PS/2 controller found. Probing ports directly. [ 30.334044] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 30.334059] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 30.346236] mice: PS/2 mouse device common for all mice [ 30.346526] EISA: Probing bus 0 at eisa.0 [ 30.346591] EISA: Detected 0 cards. [ 30.346959] NET: Registered protocol family 1 [ 30.346992] Using IPI Shortcut mode [ 30.347321] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 30.347330] EDD information not available. [ 30.347717] Freeing unused kernel memory: 228k freed [ 30.368459] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 32.156307] fuse init (API version 7.9) [ 33.446386] usbcore: registered new interface driver usbfs [ 33.446449] usbcore: registered new interface driver hub [ 33.486846] usbcore: registered new device driver usb [ 33.502416] SCSI subsystem initialized [ 33.682871] USB Universal Host Controller Interface driver v3.0 [ 33.683031] uhci_hcd 0000:00:10.0: UHCI Host Controller [ 33.683802] uhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 1 [ 33.683853] uhci_hcd 0000:00:10.0: irq 11, io base 0x0000e400 [ 33.684228] usb usb1: configuration #1 chosen from 1 choice [ 33.684299] hub 1-0:1.0: USB hub found [ 33.684319] hub 1-0:1.0: 2 ports detected [ 33.696207] via-rhine.c:v1.10-LK1.4.3 2007-03-06 Written by Donald Becker [ 33.696225] via-rhine: Broken BIOS detected, avoid_D3 enabled. [ 33.730056] libata version 3.00 loaded. [ 33.785979] uhci_hcd 0000:00:10.1: UHCI Host Controller [ 33.786046] uhci_hcd 0000:00:10.1: new USB bus registered, assigned bus number 2 [ 33.786090] uhci_hcd 0000:00:10.1: irq 11, io base 0x0000e000 [ 33.786404] usb usb2: configuration #1 chosen from 1 choice [ 33.786474] hub 2-0:1.0: USB hub found [ 33.786490] hub 2-0:1.0: 2 ports detected [ 33.890009] uhci_hcd 0000:00:10.2: UHCI Host Controller [ 33.890077] uhci_hcd 0000:00:10.2: new USB bus registered, assigned bus number 3 [ 33.890124] uhci_hcd 0000:00:10.2: irq 15, io base 0x0000dc00 [ 33.890442] usb usb3: configuration #1 chosen from 1 choice [ 33.890528] hub 3-0:1.0: USB hub found [ 33.890545] hub 3-0:1.0: 2 ports detected [ 33.993986] uhci_hcd 0000:00:10.3: UHCI Host Controller [ 33.994055] uhci_hcd 0000:00:10.3: new USB bus registered, assigned bus number 4 [ 33.994100] uhci_hcd 0000:00:10.3: irq 15, io base 0x0000d800 [ 33.994414] usb usb4: configuration #1 chosen from 1 choice [ 33.994483] hub 4-0:1.0: USB hub found [ 33.994499] hub 4-0:1.0: 2 ports detected [ 34.098239] ehci_hcd 0000:00:10.4: EHCI Host Controller [ 34.098317] ehci_hcd 0000:00:10.4: new USB bus registered, assigned bus number 5 [ 34.098416] ehci_hcd 0000:00:10.4: irq 10, io mem 0xfdfff000 [ 34.109804] ehci_hcd 0000:00:10.4: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 [ 34.110130] usb usb5: configuration #1 chosen from 1 choice [ 34.110200] hub 5-0:1.0: USB hub found [ 34.110220] hub 5-0:1.0: 8 ports detected [ 34.218863] eth0: VIA Rhine II at 0xfdffe000, 00:40:63:ef:5f:23, IRQ 11. [ 34.219590] eth0: MII PHY found at address 1, status 0x7849 advertising 05e1 Link 0000. [ 34.231225] sata_via 0000:00:0f.0: version 2.3 [ 34.231347] sata_via 0000:00:0f.0: routed to hard irq line 15 [ 34.233846] scsi0 : sata_via [ 34.236011] scsi1 : sata_via [ 34.236143] ata1: SATA max UDMA/133 cmd 0xfc00 ctl 0xf800 bmdma 0xec00 irq 15 [ 34.236156] ata2: SATA max UDMA/133 cmd 0xf400 ctl 0xf000 bmdma 0xec08 irq 15 [ 34.437755] ata1: SATA link down 1.5 Gbps (SStatus 0 SControl 300) [ 34.653718] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 34.833927] ata2.00: ATA-8: OCZ-VERTEX2, 1.28, max UDMA/133 [ 34.833944] ata2.00: 107463888 sectors, multi 16: LBA48 NCQ (depth 0/32) [ 34.849954] ata2.00: configured for UDMA/133 [ 34.850232] scsi 1:0:0:0: Direct-Access ATA OCZ-VERTEX2 1.28 PQ: 0 ANSI: 5 [ 35.406075] Driver 'sd' needs updating - please use bus_type methods [ 35.407799] sd 1:0:0:0: [sda] 107463888 512-byte hardware sectors (55022 MB) [ 35.407839] sd 1:0:0:0: [sda] Write Protect is off [ 35.407852] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 35.407897] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 35.408042] sd 1:0:0:0: [sda] 107463888 512-byte hardware sectors (55022 MB) [ 35.408071] sd 1:0:0:0: [sda] Write Protect is off [ 35.408082] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 35.408124] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 35.408141] sda: sda1 sda2 < sda5 > [ 35.409823] sd 1:0:0:0: [sda] Attached SCSI disk [ 35.423341] sd 1:0:0:0: Attached scsi generic sg0 type 0 [ 35.718981] kjournald starting. Commit interval 5 seconds [ 35.719022] EXT3-fs: mounted filesystem with ordered data mode. [ 39.797352] Linux agpgart interface v0.102 [ 39.861119] agpgart: Detected VIA VT3314 chipset [ 40.011159] agpgart: AGP aperture is 128M @ 0xe8000000 [ 41.919306] input: PC Speaker as /devices/platform/pcspkr/input/input2 [ 44.522853] input: ImPS/2 Generic Wheel Mouse as /devices/platform/i8042/serio1/input/input3 [ 45.308956] PCI: Setting latency timer of device 0000:00:11.5 to 64 [ 48.973895] lp: driver loaded but no devices found [ 49.183523] Adding 2241028k swap on /dev/sda5. Priority:-1 extents:1 across:2241028k [ 49.780351] EXT3 FS on sda1, internal journal [ 51.781448] ip_tables: (C) 2000-2006 Netfilter Core Team [ 54.528967] ppdev: user-space parallel port driver [ 54.572516] audit(1146490799.846:2): type=1503 operation="inode_permission" requested_mask="a::" denied_mask="a::" name="/dev/tty" pid=4148 profile="/usr/sbin/cupsd" namespace="default" [ 56.932108] eth0: link down [ 56.973664] Bluetooth: Core ver 2.11 [ 56.982848] NET: Registered protocol family 31 [ 56.982863] Bluetooth: HCI device and connection manager initialized [ 56.982876] Bluetooth: HCI socket layer initialized [ 57.075542] Bluetooth: L2CAP ver 2.9 [ 57.075555] Bluetooth: L2CAP socket layer initialized [ 57.130380] Bluetooth: RFCOMM socket layer initialized [ 57.131593] Bluetooth: RFCOMM TTY layer initialized [ 57.131607] Bluetooth: RFCOMM ver 1.8 [ 59.524366] [drm] Initialized drm 1.1.0 20060810 [ 59.534767] [drm] Initialized via 2.11.1 20070202 on minor 0 [ 59.549028] agpgart: Found an AGP 3.5 compliant device at 0000:00:00.0. [ 59.549075] agpgart: Putting AGP V3 device at 0000:00:00.0 into 8x mode [ 59.549165] agpgart: Putting AGP V3 device at 0000:01:00.0 into 8x mode [ 80.094867] NET: Registered protocol family 10 [ 80.096605] lo: Disabled Privacy Extensions [ 80.098729] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 174.836748] I-pipe: Domain RTAI registered. [ 174.836777] RTAI[hal]: <3.6.1> mounted over IPIPE-NOTHREADS 2.0-04. [ 174.836788] RTAI[hal]: compiled with gcc version 4.2.4 (Ubuntu 4.2.4-1ubuntu3). [ 174.836807] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0). [ 174.836820] PIPELINE layers: [ 174.836829] dcbfa000 9ac15d93 RTAI 200 [ 174.836838] c0383180 0 Linux 100 [ 174.885809] RTAI[malloc]: global heap size = 2097152 bytes, . [ 174.886667] RTAI[sched]: loaded (IMMEDIATE, UP, USER/KERNEL SPACE: , kstacks pool size = 524288 bytes. [ 174.886693] RTAI[sched]: hard timer type/freq = 8254-PIT/1193180(Hz); default timing: periodic; linear timed lists. [ 174.886710] RTAI[sched]: Linux timer freq = 250 (Hz), CPU freq = 798041000 hz. [ 174.886723] RTAI[sched]: timer setup = 2009 ns, resched latency = 2689 ns. [ 175.054381] RTAI[math]: loaded. [ 175.098708] rtapi: no version for "nano2count" found: kernel tainted. [ 177.033094] RTAPI: ERROR: Unexpected realtime delay on task 1 [ 177.033109] This Message will only display once per session. [ 177.033116] Run the Latency Test and resolve before continuing. [ 713.633859] RTAI[math]: unloaded. [ 713.735517] SCHED releases registered named ALIEN RTGLBH [ 713.800760] RTAI[malloc]: unloaded. [ 713.904102] RTAI[sched]: unloaded (forced hard/soft/hard transitions: traps 0, syscalls 0). [ 713.916524] I-pipe: Domain RTAI unregistered. [ 713.916555] RTAI[hal]: unmounted. Debug file information: insmod: error inserting '/usr/realtime-2.6.24-16-rtai/modules/rtai_hal.ko': -1 File exists 5406 PID TTY STAT TIME COMMAND Stopping realtime threads Unloading hal components ERROR: Module hal_lib does not exist in /proc/modules ERROR: Module rtapi does not exist in /proc/modules ERROR: Module rtai_math does not exist in /proc/modules ERROR: Module rtai_sem does not exist in /proc/modules ERROR: Module rtai_fifos does not exist in /proc/modules ERROR: Module rtai_sched does not exist in /proc/modules ERROR: Module rtai_hal does not exist in /proc/modules