latency test question

More
13 Jan 2013 11:20 #28638 by revo
Replied by revo on topic latency test question
now when i start linux cnc its say that :


Print file information:
RUN_IN_PLACE=no
LINUXCNC_DIR=
LINUXCNC_BIN_DIR=/usr/bin
LINUXCNC_TCL_DIR=/usr/lib/tcltk/linuxcnc
LINUXCNC_SCRIPT_DIR=
LINUXCNC_RTLIB_DIR=/usr/realtime-2.6.32-122-rtai/modules/linuxcnc
LINUXCNC_CONFIG_DIR=
LINUXCNC_LANG_DIR=/usr/share/linuxcnc/tcl/msgs
INIVAR=inivar
HALCMD=halcmd
LINUXCNC_EMCSH=/usr/bin/wish8.5
LINUXCNC - 2.5.0
Machine configuration directory is '/home/louis/linuxcnc/configs/new_revo'
Machine configuration file is 'new_revo.ini'
INIFILE=/home/louis/linuxcnc/configs/new_revo/new_revo.ini
PARAMETER_FILE=linuxcnc.var
TASK=milltask
HALUI=
DISPLAY=axis
Starting LinuxCNC...
Starting LinuxCNC server program: linuxcncsvr
Loading Real Time OS, RTAPI, and HAL_LIB modules
Realtime system did not load
Shutting down and cleaning up LinuxCNC...
Killing task linuxcncsvr, PID=5951
Removing HAL_LIB, RTAPI, and Real Time OS modules
Removing NML shared memory segments
Cleanup done

Debug file information:
Can not find -sec MOT -var MOT -num 1
Can not find -sec IO -var IO -num 1
Can not find -sec LINUXCNC -var NML_FILE -num 1
Can not find -sec EMC -var NML_FILE -num 1
insmod: error inserting '/usr/realtime-2.6.32-122-rtai/modules/rtai_hal.ko': -1 File exists
5951
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 is in use by latency_rt
ERROR: Module rtai_sched is in use by latency_rt,rtai_fifos
ERROR: Module rtai_hal is in use by latency_rt,rtai_fifos,rtai_sched

Kernel message information:
[ 114.622380] I-pipe: Domain RTAI registered.
[ 114.622388] RTAI[hal]: <3.8.1> mounted over IPIPE-NOTHREADS 2.6-03.
[ 114.622391] RTAI[hal]: compiled with gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) .
[ 114.622397] RTAI[hal]: mounted (IPIPE-NOTHREADS, IMMEDIATE (INTERNAL IRQs DISPATCHED), ISOL_CPUS_MASK: 0).
[ 114.622400] PIPELINE layers:
[ 114.622403] fc9f0e20 9ac15d93 RTAI 200
[ 114.622405] c085cb20 0 Linux 100
[ 114.705234] RTAI[malloc]: global heap size = 2097152 bytes, <BSD>.
[ 114.705378] RTAI[sched]: IMMEDIATE, MP, USER/KERNEL SPACE: <with RTAI OWN KTASKs>, kstacks pool size = 524288 bytes.
[ 114.705383] RTAI[sched]: hard timer type/freq = APIC/12499578(Hz); default timing: periodic; linear timed lists.
[ 114.705387] RTAI[sched]: Linux timer freq = 250 (Hz), TimeBase freq = 1800028000 hz.
[ 114.705389] RTAI[sched]: timer setup = 999 ns, resched latency = 2943 ns.
[ 114.705470] RTAI[usi]: enabled.
[ 259.518896]
[ cut here ]
[ 259.518907] WARNING: at /home/moses/Projects/emc2/ubuntu-lucid/kernel/softirq.c:143 local_bh_enable_ip+0x78/0xb0()
[ 259.518910] Hardware name: G41MT-S2PT
[ 259.518912] Modules linked in: latency_rt rtai_fifos rtai_sched rtai_hal aes_i586 aes_generic binfmt_misc dm_crypt snd_hda_codec_realtek arc4 snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq ath9k snd_timer snd_seq_device ppdev mac80211 ath parport_pc psmouse cfg80211 snd serio_raw led_class soundcore snd_page_alloc lp parport usbhid hid dm_raid45 xor fbcon tileblit font bitblit softcursor vga16fb vgastate i915 drm_kms_helper drm intel_agp i2c_algo_bit video agpgart output
[ 259.518966] Pid: 909, comm: wpa_supplicant Not tainted 2.6.32-122-rtai #rtai
[ 259.518968] Call Trace:
[ 259.518979] [<c0143112>] warn_slowpath_common+0x72/0xa0
[ 259.518983] [<c014a6e8>] ? local_bh_enable_ip+0x78/0xb0
[ 259.518988] [<c014a6e8>] ? local_bh_enable_ip+0x78/0xb0
[ 259.518991] [<c014315a>] warn_slowpath_null+0x1a/0x20
[ 259.518995] [<c014a6e8>] local_bh_enable_ip+0x78/0xb0
[ 259.519000] [<c0569c13>] _spin_unlock_bh+0x13/0x20
[ 259.519011] [<f912718f>] ath_tx_node_cleanup+0x14f/0x170 [ath9k]
[ 259.519020] [<f9121eee>] ath9k_sta_notify+0x4e/0xb0 [ath9k]
[ 259.519030] [<f907e647>] __sta_info_unlink+0x127/0x1b0 [mac80211]
[ 259.519039] [<f9121ea0>] ? ath9k_sta_notify+0x0/0xb0 [ath9k]
[ 259.519048] [<f907e703>] sta_info_unlink+0x33/0x50 [mac80211]
[ 259.519058] [<f9085eca>] ieee80211_set_disassoc+0x17a/0x1d0 [mac80211]
[ 259.519068] [<f90861c7>] ieee80211_mgd_deauth+0x107/0x110 [mac80211]
[ 259.519077] [<c0139f60>] ? default_wake_function+0x0/0x20
[ 259.519088] [<f908b369>] ieee80211_deauth+0x19/0x20 [mac80211]
[ 259.519099] [<f80b2ce8>] __cfg80211_mlme_deauth+0xd8/0x100 [cfg80211]
[ 259.519108] [<f80b5dfd>] __cfg80211_disconnect+0x14d/0x1b0 [cfg80211]
[ 259.519112] [<c01648e5>] ? sched_clock_local+0xa5/0x180
[ 259.519120] [<f80b8f21>] cfg80211_wext_siwmlme+0x81/0xa0 [cfg80211]
[ 259.519126] [<c054edbb>] ioctl_standard_iw_point+0x18b/0x300
[ 259.519134] [<f80b8ea0>] ? cfg80211_wext_siwmlme+0x0/0xa0 [cfg80211]
[ 259.519139] [<c054efd5>] ioctl_standard_call+0xa5/0x100
[ 259.519147] [<f80b8ea0>] ? cfg80211_wext_siwmlme+0x0/0xa0 [cfg80211]
[ 259.519152] [<c04a3e0d>] ? __dev_get_by_name+0x8d/0xb0
[ 259.519156] [<c054f372>] T.703+0xc2/0x150
[ 259.519164] [<f80b8ea0>] ? cfg80211_wext_siwmlme+0x0/0xa0 [cfg80211]
[ 259.519169] [<c054f460>] wext_handle_ioctl+0x60/0xc0
[ 259.519178] [<c04a4f54>] dev_ioctl+0x614/0x720
[ 259.519182] [<c01fba54>] ? do_sync_read+0xc4/0x100
[ 259.519187] [<c04920f3>] sock_ioctl+0x1d3/0x270
[ 259.519190] [<c0491f20>] ? sock_ioctl+0x0/0x270
[ 259.519195] [<c020a081>] vfs_ioctl+0x21/0x90
[ 259.519199] [<c020a369>] do_vfs_ioctl+0x79/0x310
[ 259.519202] [<c020a667>] sys_ioctl+0x67/0x80
[ 259.519206] [<c010340d>] syscall_call+0x7/0xb
[ 259.519209] ---[ end trace ec0f7f550df16b7f ]---
[ 259.519266] wlan0: deauthenticating from 00:1e:52:7b:79:76 by local choice (reason=3)
[ 330.106300] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 685.168261] ath9k: Two wiphys trying to scan at the same time
[ 685.188736] wlan0: deauthenticating from 00:1f:f3:02:e8:21 by local choice (reason=3)
[ 685.369751] wlan0: direct probe to AP 00:1e:52:7b:79:76 (try 1)
[ 685.374013] wlan0: direct probe responded
[ 685.374018] wlan0: authenticate with AP 00:1e:52:7b:79:76 (try 1)
[ 685.379274] wlan0: authenticated
[ 685.379293] wlan0: associate with AP 00:1e:52:7b:79:76 (try 1)
[ 685.387170] wlan0: RX AssocResp from 00:1e:52:7b:79:76 (capab=0x431 status=0 aid=4)
[ 685.387173] wlan0: associated
[ 685.397044] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 689.440938] wlan0: deauthenticated from 00:1e:52:7b:79:76 (Reason: 2)
[ 690.401288] wlan0: direct probe to AP 00:1e:52:7b:79:76 (try 1)
[ 690.405061] wlan0: direct probe responded
[ 690.405066] wlan0: authenticate with AP 00:1e:52:7b:79:76 (try 1)
[ 690.415714] wlan0: authenticated
[ 690.415736] wlan0: associate with AP 00:1e:52:7b:79:76 (try 1)
[ 690.425341] wlan0: RX AssocResp from 00:1e:52:7b:79:76 (capab=0x431 status=0 aid=4)
[ 690.425346] wlan0: associated
[ 695.972017] wlan0: no IPv6 routers present
[ 705.444110] wlan0: deauthenticating from 00:1e:52:7b:79:76 by local choice (reason=3)
[ 705.656261] ath9k: Two wiphys trying to scan at the same time
[ 705.656288] wlan0: deauthenticating from 00:1f:f3:02:e8:21 by local choice (reason=3)
[ 705.857445] wlan0: direct probe to AP 00:1e:52:7b:79:76 (try 1)
[ 706.056022] wlan0: direct probe to AP 00:1e:52:7b:79:76 (try 2)
[ 706.059787] wlan0: direct probe responded
[ 706.059790] wlan0: authenticate with AP 00:1e:52:7b:79:76 (try 1)
[ 706.065114] wlan0: authenticated
[ 706.065143] wlan0: associate with AP 00:1e:52:7b:79:76 (try 1)
[ 706.069055] wlan0: RX AssocResp from 00:1e:52:7b:79:76 (capab=0x431 status=0 aid=4)
[ 706.069059] wlan0: associated
[ 1157.860299] lo: Disabled Privacy Extensions
[ 7479.677879] lo: Disabled Privacy Extensions

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

More
13 Jan 2013 11:32 #28639 by revo
Replied by revo on topic latency test question
After rebooting, i can start linux cnc but i get two error messages.

Rtapi error: excpect realtime delay on task1
and

unexpected realtime dealy check desmg for details



how can i look which video driver is loaded? i try loading the vesa driver but not sure if it was succesful.

i hope someone understand my problem, i really want this machine running on linux cnc.


thanks again for your input.

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

More
13 Jan 2013 12:11 #28640 by revo
Replied by revo on topic latency test question
when i do halrun -U

i get those error.


RTAPI: ERROR: could not open shared memory (errno=2)
ERROR: rtapi init failed
HALCMD: Release Mutex failed!
RTAPI: ERROR: could not open shared memory (errno=2)
/usr/bin/halrun: line 10: 2637 Segmentation fault halcmd stop
RTAPI: ERROR: could not open shared memory (errno=2)
/usr/bin/halrun: line 10: 2638 Segmentation fault halcmd unload all
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
louis@louis-desktop:~$

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

More
13 Jan 2013 12:52 #28643 by revo
Replied by revo on topic latency test question
Also i am running a core duo,
i stop multithreading in the bios and tried to The Isolcpus Boot Parameter And GRUB2 wiki but i get the error when i tired to follow the instruction.

louis@louis-desktop:~$ sudo cp 07_rtai /etc/grub.d
[sudo] password for louis:
louis@louis-desktop:~$ sudo chmod +x /etc/grub.d/07_rtai
louis@louis-desktop:~$ sudo update-grub
Generating grub.cfg ...
/etc/grub.d/07_rtai: 195: Syntax error: end of file unexpected (expecting "done")


maybe the core duo is causing all my problem?

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

More
13 Jan 2013 18:48 #28645 by ArcEye
Replied by ArcEye on topic latency test question
Hi

Lots of queries, I'll try to cover the main ones.

... get this message when i try to make a xorg.conf file.
Fatal server error:
Server is already active for display 0
If this server is no longer running, remove /tmp/.X0-lock
and start again.


You need to read the link I posted (wiki.linuxcnc.org/cgi-bin/wiki.pl?Troubl...g#Using_Vesa_Drivers)
You cannot create a xorg.conf file whilst there is a running xserver session

i think i got it, installed the vesa driver.....
how can i look which video driver is loaded? i try loading the vesa driver but not sure if it was succesful.


From the commandline run cat /var/log/Xorg.0.log then look through the output for the line starting Loading /usr/lib/xorg/modules...
That will show what driver is installed.

when i do halrun -U
i get those error.
RTAPI: ERROR: could not open shared memory (errno=2)
ERROR: rtapi init failed

and previously

insmod: error inserting '/usr/realtime-2.6.32-122-rtai/modules/rtai_hal.ko': -1 File exists


I think all your errors when trying to load Linuxcnc (and using halrun -U) are from the previous session having closed down improperly and modules not being unloaded.
The answer for now is just to reboot and you should be able to start Linuxcnc again.

my number seem better when i run the latency test in terminal thant the linuxcnc one.
is there a big diffrenec between the 2?


The only difference is that the dialog based one is cumulative and just shows the worst figure whereas the command line one shows second by second so you can see when exactly a spike occurred.

Also i am running a core duo,
i stop multithreading in the bios and tried to The Isolcpus Boot Parameter And GRUB2 wiki but i get the error when i tired to follow the instruction.
Generating grub.cfg ...
/etc/grub.d/07_rtai: 195: Syntax error: end of file unexpected (expecting "done")

maybe the core duo is causing all my problem?


No it is not, it might have higher latency but it will not of itself create the spikes

The problem is in the error message;
/etc/grub.d/07_rtai: 195: Syntax error: end of file unexpected (expecting "done")
Line 195 has an unexpected EOF, looks like there was no closing done to a conditional statement.



Your lspci output shows you have an Intel board with a Giga-byte graphics chip, check to see if the vesa driver is loaded.

Your lspci also suggests that you have the ICH7_1 Intel chipset. This is strange because it is one known to have SMI issues, but the symptoms you report are not those of SMI.

I would try reinstating your edits as per wiki.linuxcnc.org/cgi-bin/wiki.pl?FixingSMIIssues, ensure that the driver in use by the xserver is vesa and then run another long test.

Don't bother trying to add the isolcpus parameter for now.

Then come back with the results

regards

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

More
14 Jan 2013 12:48 #28673 by revo
Replied by revo on topic latency test question
Ok,

Vesa driver is going.

ran the latency test and i dont get over run and number stay very low like 2200 range with lots of -500. it did spike to 32 000 but i wasnt doing anything, i tried to abuse to see if i could get it again but the big numbers came when i was doing nothing.
i can abuse and stays pretty low and will randomly spike.

i have a wifi card on the pci. should i remove that?
would it be better if i run to future shop and buy a cheap Ati card to test and return ot if its not the problem?

Linux cnc start ok but after about 30 sec i get an error message Rtapi error: unexpected delay on task 1
unexpected realtime delay: check dmesg for details. how to i check the dmesg?

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

More
14 Jan 2013 13:37 - 14 Jan 2013 15:00 #28674 by revo
Replied by revo on topic latency test question
I removed the dLink pci card and the number stop going high but still minus.

rebooted and open linux cnc and the warning about delay on real time hasnt come.

can i still run linux cnc properly even if my latency goes in minus?

been running latency and never went over 5122.
even if it goes negative, is my work done?
Last edit: 14 Jan 2013 15:00 by revo.

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

More
14 Jan 2013 17:46 #28677 by ArcEye
Replied by ArcEye on topic latency test question

how to i check the dmesg?

Look at /var/log/dmesg

been running latency and never went over 5122.
even if it goes negative, is my work done?


5122 is a good figure if it is constant.
No idea, you will have to run Linuxcnc and see if you get problems. That is the only test that means anything at the end of the day.

Removing the WiFi card looks to have solved the spikes, I missed that in the lspci print, it was right at the end.
I don't like them at the best of times, ethernet is the only really reliable connection.

I have no idea why you are getting negative values, albeit I don't know what column they appeared in.
Theoretically it can't occur, how can a command be executed before it is given?

regards

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

More
15 Jan 2013 02:04 #28691 by revo
Replied by revo on topic latency test question
will plug the computer on the machine.
will let you know.

about the dmesg, i tried to check but permission denied, did as root and still denied.

just curious what i am doing wrong,

anyway ill post progress later, maybe all that will help someone else eventually.

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

More
15 Jan 2013 02:38 #28693 by BigJohnT

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

Time to create page: 0.301 seconds
Powered by Kunena Forum