Print file information: RUN_IN_PLACE=yes LINUXCNC_DIR= LINUXCNC_BIN_DIR=/home/tom/linuxcnc-rtos/bin LINUXCNC_TCL_DIR=/home/tom/linuxcnc-rtos/tcl LINUXCNC_SCRIPT_DIR= LINUXCNC_RTLIB_DIR=/home/tom/linuxcnc-rtos/rtlib LINUXCNC_CONFIG_DIR= LINUXCNC_LANG_DIR=/home/tom/linuxcnc-rtos/src/objects INIVAR=inivar HALCMD=halcmd LINUXCNC_EMCSH=/usr/bin/wish8.5 LINUXCNC - 2.5.1 Machine configuration directory is '/home/tom/linuxcnc-rtos/tests/linuxcncrsh' Machine configuration file is 'linuxcncrsh-test.ini' INIFILE=/home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini PARAMETER_FILE=sim.var TASK=milltask HALUI= DISPLAY=linuxcncrsh Starting LinuxCNC... Starting LinuxCNC server program: linuxcncsvr Loading Real Time OS, RTAPI, and HAL_LIB modules Starting LinuxCNC IO program: io Shutting down and cleaning up LinuxCNC... Killing task linuxcncsvr, PID=25455 Removing HAL_LIB, RTAPI, and Real Time OS modules Removing NML shared memory segments Cleanup done Debug file information: + exec + trap ErrorCheck EXIT + '[' '!' -z linuxcncrsh-test.ini ']' + case "$1" in ++ pwd + INIFILE=/home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini + shift + EXTRA_ARGS= + RUN_IN_PLACE=yes + echo RUN_IN_PLACE=yes + LINUXCNCVERSION=2.5.1 + export LINUXCNCVERSION + INIVAR=inivar + HALCMD='halcmd ' + PICKCONFIG='/usr/bin/wish8.5 /home/tom/linuxcnc-rtos/tcl/bin/pickconfig.tcl' + LINUXCNC_EMCSH=/usr/bin/wish8.5 + echo LINUXCNC_DIR= + echo LINUXCNC_BIN_DIR=/home/tom/linuxcnc-rtos/bin + echo LINUXCNC_TCL_DIR=/home/tom/linuxcnc-rtos/tcl + echo LINUXCNC_SCRIPT_DIR= + echo LINUXCNC_RTLIB_DIR=/home/tom/linuxcnc-rtos/rtlib + echo LINUXCNC_CONFIG_DIR= + echo LINUXCNC_LANG_DIR=/home/tom/linuxcnc-rtos/src/objects + echo INIVAR=inivar + echo HALCMD=halcmd + echo LINUXCNC_EMCSH=/usr/bin/wish8.5 + export LINUXCNC_TCL_DIR + export LINUXCNC_EMCSH + export LINUXCNC_HELP_DIR + export LINUXCNC_LANG_DIR + export REALTIME + export HALCMD + echo 'LINUXCNC - 2.5.1' + '[' '!' -z '' ']' + '[' '!' -n /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini ']' + '[' '!' -n /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini ']' + INI_NAME=linuxcncrsh-test.ini + INI_DIR=/home/tom/linuxcnc-rtos/tests/linuxcncrsh + echo 'Machine configuration directory is '\''/home/tom/linuxcnc-rtos/tests/linuxcncrsh'\''' + echo 'Machine configuration file is '\''linuxcncrsh-test.ini'\''' + '[' '!' -f /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini ']' + echo INIFILE=/home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini + retval= + GetFromIni PARAMETER_FILE RS274NGC + name=PARAMETER_FILE ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var PARAMETER_FILE -sec RS274NGC + retval=sim.var + '[' '!' -n PARAMETER_FILE ']' + echo PARAMETER_FILE=sim.var + RS274NGC_PARAMFILE=sim.var + GetFromIniEx MOT MOT EMCMOT EMCMOT motmod + original_var='[MOT]MOT' + '[' 5 -ge 2 ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var MOT -sec MOT Can not find -sec MOT -var MOT -num 1 + retval= + shift 2 + '[' 3 -ge 2 ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var EMCMOT -sec EMCMOT + retval=motmod + return + EMCMOT=motmod.so + GetFromIniEx IO IO EMCIO EMCIO io + original_var='[IO]IO' + '[' 5 -ge 2 ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var IO -sec IO Can not find -sec IO -var IO -num 1 + retval= + shift 2 + '[' 3 -ge 2 ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var EMCIO -sec EMCIO + retval=io + return + EMCIO=io + GetFromIni TASK TASK + name=TASK ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var TASK -sec TASK + retval=milltask + '[' '!' -n TASK ']' + echo TASK=milltask + EMCTASK=milltask + '[' milltask = emctask ']' + EMCSERVER=linuxcncsvr + GetFromIniQuiet HALUI HAL + name=HALUI ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var HALUI -sec HAL + retval= + '[' '!' -n HALUI ']' + echo HALUI= + HALUI= + GetFromIni DISPLAY DISPLAY + name=DISPLAY ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var DISPLAY -sec DISPLAY + retval=linuxcncrsh + '[' '!' -n DISPLAY ']' + echo DISPLAY=linuxcncrsh ++ set -- linuxcncrsh ++ echo linuxcncrsh + EMCDISPLAY=linuxcncrsh ++ set -- linuxcncrsh ++ shift ++ echo + EMCDISPLAYARGS= + case $EMCDISPLAY in + GetFromIniEx NML_FILE LINUXCNC NML_FILE EMC /home/tom/linuxcnc-rtos/configs/common/linuxcnc.nml + original_var='[LINUXCNC]NML_FILE' + '[' 5 -ge 2 ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var NML_FILE -sec LINUXCNC Can not find -sec LINUXCNC -var NML_FILE -num 1 + retval= + shift 2 + '[' 3 -ge 2 ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var NML_FILE -sec EMC Can not find -sec EMC -var NML_FILE -num 1 + retval= + shift 2 + '[' 1 -ge 2 ']' + '[' 1 -eq 0 ']' + retval=/home/tom/linuxcnc-rtos/configs/common/linuxcnc.nml + NMLFILE=/home/tom/linuxcnc-rtos/configs/common/linuxcnc.nml + export NMLFILE + KILL_TASK= + KILL_TIMEOUT=20 + LOCKFILE=/tmp/linuxcnc.lock + '[' -f /tmp/linuxcnc.lock ']' + echo Starting LinuxCNC... + trap 'Cleanup ; exit 0' SIGINT SIGTERM + cd /home/tom/linuxcnc-rtos/tests/linuxcncrsh + touch /tmp/linuxcnc.lock ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var INTRO_GRAPHIC -sec DISPLAY Can not find -sec DISPLAY -var INTRO_GRAPHIC -num 1 + img= ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var INTRO_TIME -sec DISPLAY Can not find -sec DISPLAY -var INTRO_TIME -num 1 + imgtime= + '[' '' = '' ']' + imgtime=5 + '[' '' '!=' '' ']' + '[' '' '!=' '' ']' + echo 'Starting LinuxCNC server program: linuxcncsvr' + program_available linuxcncsvr + type -path linuxcncsvr + export INI_FILE_NAME=/home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini + INI_FILE_NAME=/home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini + sleep 1 + linuxcncsvr -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini (time=1360646398.816405,pid=25455): Registering server on TCP port 5005. (time=1360646398.816650,pid=25455): running server for TCP port 5005 (connection_socket = 3). + echo 'Loading Real Time OS, RTAPI, and HAL_LIB modules' + /home/tom/linuxcnc-rtos/scripts/realtime start + export HAL_RTMOD_DIR=/home/tom/linuxcnc-rtos/rtlib + HAL_RTMOD_DIR=/home/tom/linuxcnc-rtos/rtlib + echo 'Starting LinuxCNC IO program: io' + program_available io + type -path io + halcmd loadusr -Wn iocontrol io -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini Xenomai: binding failed: Operation not permitted. + '[' -n '' ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var TWOPASS -sec HAL -num 1 + TWOPASS= + '[' -n '' ']' + NUM=1 ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var HALFILE -sec HAL -num 1 + CFGFILE=core_sim.hal + '[' -n core_sim.hal ']' + case $CFGFILE in + halcmd -i /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -f core_sim.hal Xenomai: binding failed: Operation not permitted. + '[' '' = '' ']' + Cleanup + echo 'Shutting down and cleaning up LinuxCNC...' + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x xlinuxcnc + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x ylinuxcnc + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x linuxcncpanel + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x keystick + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x iosh + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x linuxcncsh + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x linuxcncrsh + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x linuxcnctop + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x mdi + for KILL_TASK in xlinuxcnc ylinuxcnc linuxcncpanel keystick iosh linuxcncsh linuxcncrsh linuxcnctop mdi debuglevel + /bin/pidof -x debuglevel + program_available axis-remote + type -path axis-remote + '[' '!' -z :0 ']' + axis-remote --ping + '[' '' = other ']' ++ inivar -ini /home/tom/linuxcnc-rtos/tests/linuxcncrsh/linuxcncrsh-test.ini -var SHUTDOWN -sec HAL + SHUTDOWN= + '[' -n '' ']' + for KILL_TASK in linuxcncsvr milltask + /bin/pidof -x linuxcncsvr 25455 + KillTaskWithTimeout + '[' '!' -n '' ']' ++ /bin/pidof -x linuxcncsvr + KILL_PIDS=25455 + '[' '!' -n 25455 ']' + for KILL_PID in '$KILL_PIDS' + echo 'Killing task linuxcncsvr, PID=25455' + /bin/kill 25455 (time=1360646400.173648,pid=25455): Deleting 5 channels from the NML_Main_Channel_List. (time=1360646400.173773,pid=25455): Deleting emcCommand NML channel from NML_Main_Channel_List. (time=1360646400.173819,pid=25455): deleting NML (1) + WAIT=20 (time=1360646400.173861,pid=25455): delete (CMS *) 0x82481e8; (time=1360646400.173915,pid=25455): + '[' 20 -gt 1 ']' rcs_shm_close(shm->key=1001(0x3E9),shm->size=8192(0x2000),shm->addr=0xb7773000) + /bin/ps 25455 (time=1360646400.174036,pid=25455): deleting CMS (emcCommand) (time=1360646400.174082,pid=25455): free( data = 0x8248bd0); (time=1360646400.174123,pid=25455): Leaving ~CMS() (time=1360646400.174159,pid=25455): CMS::delete(0x82481e8) (time=1360646400.174196,pid=25455): CMS::delete successful. (time=1360646400.174234,pid=25455): Leaving ~NML() (time=1360646400.174274,pid=25455): NML channel deleted from NML_Main_Channel_List (time=1360646400.174311,pid=25455): Deleting emcStatus NML channel from NML_Main_Channel_List. (time=1360646400.174351,pid=25455): deleting NML (2) (time=1360646400.174393,pid=25455): delete (CMS *) 0x824dab8; (time=1360646400.174436,pid=25455): rcs_shm_close(shm->key=1002(0x3EA),shm->size=16384(0x4000),shm->addr=0xb776f000) (time=1360646400.174512,pid=25455): deleting CMS (emcStatus) (time=1360646400.174543,pid=25455): free( data = 0x824e4a0); (time=1360646400.174572,pid=25455): Leaving ~CMS() (time=1360646400.174599,pid=25455): CMS::delete(0x824dab8) (time=1360646400.174625,pid=25455): CMS::delete successful. (time=1360646400.174653,pid=25455): Leaving ~NML() (time=1360646400.174679,pid=25455): NML channel deleted from NML_Main_Channel_List (time=1360646400.174745,pid=25455): Deleting emcError NML channel from NML_Main_Channel_List. (time=1360646400.174773,pid=25455): deleting NML (3) (time=1360646400.174800,pid=25455): delete (CMS *) 0x82528d0; (time=1360646400.174837,pid=25455): rcs_shm_close(shm->key=1003(0x3EB),shm->size=8192(0x2000),shm->addr=0xb776d000) (time=1360646400.174895,pid=25455): deleting CMS (emcError) (time=1360646400.174926,pid=25455): free( data = 0x82532b8); (time=1360646400.174954,pid=25455): Leaving ~CMS() (time=1360646400.174980,pid=25455): CMS::delete(0x82528d0) (time=1360646400.175006,pid=25455): CMS::delete successful. (time=1360646400.175033,pid=25455): Leaving ~NML() (time=1360646400.175059,pid=25455): NML channel deleted from NML_Main_Channel_List (time=1360646400.175084,pid=25455): Deleting toolCmd NML channel from NML_Main_Channel_List. (time=1360646400.175111,pid=25455): deleting NML (4) (time=1360646400.175137,pid=25455): delete (CMS *) 0x8255638; (time=1360646400.175166,pid=25455): rcs_shm_close(shm->key=1004(0x3EC),shm->size=1024(0x400),shm->addr=0xb776c000) (time=1360646400.175225,pid=25455): deleting CMS (toolCmd) (time=1360646400.175262,pid=25455): free( data = 0x8256020); (time=1360646400.175290,pid=25455): Leaving ~CMS() (time=1360646400.175317,pid=25455): CMS::delete(0x8255638) (time=1360646400.175344,pid=25455): CMS::delete successful. (time=1360646400.175371,pid=25455): Leaving ~NML() (time=1360646400.175397,pid=25455): NML channel deleted from NML_Main_Channel_List (time=1360646400.175423,pid=25455): Deleting toolSts NML channel from NML_Main_Channel_List. (time=1360646400.175450,pid=25455): deleting NML (5) (time=1360646400.175476,pid=25455): delete (CMS *) 0x82567d0; (time=1360646400.175505,pid=25455): rcs_shm_close(shm->key=1005(0x3ED),shm->size=8192(0x2000),shm->addr=0xb776a000) (time=1360646400.175560,pid=25455): deleting CMS (toolSts) (time=1360646400.175590,pid=25455): free( data = 0x82571b8); (time=1360646400.175630,pid=25455): Leaving ~CMS() (time=1360646400.175656,pid=25455): CMS::delete(0x82567d0) (time=1360646400.175683,pid=25455): CMS::delete successful. (time=1360646400.175736,pid=25455): Leaving ~NML() (time=1360646400.175763,pid=25455): NML channel deleted from NML_Main_Channel_List (time=1360646400.175796,pid=25455): deleting NML (1) (time=1360646400.175824,pid=25455): Leaving ~NML() (time=1360646400.175851,pid=25455): NML::operater delete(0x8248008) (time=1360646400.175903,pid=25455): NML channel deleted from Dynamically_Allocated_NML_Objects (time=1360646400.175932,pid=25455): deleting NML (2) (time=1360646400.175960,pid=25455): Leaving ~NML() (time=1360646400.175985,pid=25455): NML::operater delete(0x824d938) (time=1360646400.176012,pid=25455): NML channel deleted from Dynamically_Allocated_NML_Objects (time=1360646400.176040,pid=25455): deleting NML (3) (time=1360646400.176067,pid=25455): Leaving ~NML() (time=1360646400.176093,pid=25455): NML::operater delete(0x82526d0) (time=1360646400.176120,pid=25455): NML channel deleted from Dynamically_Allocated_NML_Objects (time=1360646400.176146,pid=25455): deleting NML (4) (time=1360646400.176172,pid=25455): Leaving ~NML() (time=1360646400.176198,pid=25455): NML::operater delete(0x82554b8) (time=1360646400.176225,pid=25455): NML channel deleted from Dynamically_Allocated_NML_Objects (time=1360646400.176251,pid=25455): deleting NML (5) (time=1360646400.176277,pid=25455): Leaving ~NML() (time=1360646400.176303,pid=25455): NML::operater delete(0x8256650) (time=1360646400.176337,pid=25455): NML channel deleted from Dynamically_Allocated_NML_Objects PID TTY STAT TIME COMMAND + WAIT=0 + '[' 0 -gt 1 ']' + '[' 0 -gt 0 ']' + '[' 0 -gt 0 ']' + KILL_PIDS= + KILL_TASK= + for KILL_TASK in linuxcncsvr milltask + /bin/pidof -x milltask + echo 'Stopping realtime threads' Stopping realtime threads + halcmd stop Xenomai: binding failed: Operation not permitted. + echo 'Unloading hal components' Unloading hal components + halcmd unload all Xenomai: binding failed: Operation not permitted. ++ seq 10 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + for i in '`seq 10`' ++ halcmd list comp ++ wc -w Xenomai: binding failed: Operation not permitted. + '[' 0 = 1 ']' + sleep .2 + echo 'Removing HAL_LIB, RTAPI, and Real Time OS modules' + /home/tom/linuxcnc-rtos/scripts/realtime stop rtapi_app_main: this user is not member of group xenomai please 'sudo adduser xenomai', logout and login again + echo 'Removing NML shared memory segments' + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + ipcrm -M 1001 + read b x t x x x x x x m x + case $b$t in + ipcrm -M 1002 + read b x t x x x x x x m x + case $b$t in + ipcrm -M 1003 + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + ipcrm -M 1004 + read b x t x x x x x x m x + case $b$t in + ipcrm -M 1005 + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + case $b$t in + read b x t x x x x x x m x + '[' -f /tmp/linuxcnc.lock ']' + rm /tmp/linuxcnc.lock + echo 'Cleanup done' + exit -1 + ErrorCheck + result=255 + '[' '!' -z :0 ']' + echo 'catch {send -async popimage destroy .}; destroy .' + /usr/bin/wish8.5 + '[' 255 -ne 0 ']' + tty -s + '[' -z :0 ']' + /usr/bin/wish8.5 /home/tom/linuxcnc-rtos/tcl/show_errors.tcl /tmp/linuxcnc.debug.Qhuw1f /tmp/linuxcnc.print.5KbffZ Kernel message information: [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.2.21-xenomai+ (root@sil1) (gcc version 4.7.2 (Debian 4.7.2-4) ) #3 SMP PREEMPT Tue Dec 25 23:33:36 UTC 2012 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] NSC Geode by NSC [ 0.000000] Cyrix CyrixInstead [ 0.000000] Transmeta GenuineTMx86 [ 0.000000] Transmeta TransmetaCPU [ 0.000000] UMC UMC UMC UMC [ 0.000000] Disabled fast string operations [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 000000000008f000 (usable) [ 0.000000] BIOS-e820: 000000000008f000 - 0000000000090000 (reserved) [ 0.000000] BIOS-e820: 0000000000090000 - 000000000009e800 (usable) [ 0.000000] BIOS-e820: 000000000009e800 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 000000007f488000 (usable) [ 0.000000] BIOS-e820: 000000007f488000 - 000000007f4af000 (reserved) [ 0.000000] BIOS-e820: 000000007f4af000 - 000000007f4ef000 (usable) [ 0.000000] BIOS-e820: 000000007f4ef000 - 000000007f5af000 (ACPI NVS) [ 0.000000] BIOS-e820: 000000007f5af000 - 000000007f5e2000 (usable) [ 0.000000] BIOS-e820: 000000007f5e2000 - 000000007f5ef000 (ACPI data) [ 0.000000] BIOS-e820: 000000007f5ef000 - 000000007f5f0000 (usable) [ 0.000000] BIOS-e820: 000000007f5f0000 - 0000000080000000 (reserved) [ 0.000000] BIOS-e820: 00000000e0000000 - 00000000e4000000 (reserved) [ 0.000000] BIOS-e820: 00000000ffe00000 - 0000000100000000 (reserved) [ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel! [ 0.000000] DMI 2.7 present. [ 0.000000] DMI: /D2700MUD, BIOS MUCDT10N.86A.0067.2011.1227.1232 12/27/2011 [ 0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved) [ 0.000000] e820 remove range: 00000000000a0000 - 0000000000100000 (usable) [ 0.000000] last_pfn = 0x7f5f0 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-BFFFF uncachable [ 0.000000] C0000-DFFFF write-protect [ 0.000000] E0000-FFFFF uncachable [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 000000000 mask F80000000 write-back [ 0.000000] 1 base 07F5F0000 mask FFFFF0000 uncachable [ 0.000000] 2 base 07F600000 mask FFFE00000 uncachable [ 0.000000] 3 base 07F800000 mask FFF800000 uncachable [ 0.000000] 4 base 0FFE00000 mask FFFE00000 write-protect [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106 [ 0.000000] found SMP MP-table at [c00fbe50] fbe50 [ 0.000000] initial memory mapped : 0 - 01c00000 [ 0.000000] Base memory trampoline at [c009a000] 9a000 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 377fe000 @ 1bfb000-1c00000 [ 0.000000] RAMDISK: 36fb4000 - 377d2000 [ 0.000000] ACPI: RSDP 000f2240 00024 (v02 INTEL ) [ 0.000000] ACPI: XSDT 7f5ee120 0004C (v01 INTEL D2700MUD 00000043 01000013) [ 0.000000] ACPI: FACP 7f5e6000 000F4 (v03 INTEL D2700MUD 00000043 MSFT 0100000D) [ 0.000000] ACPI: DSDT 7f5e8000 05BBF (v02 INTEL D2700MUD 00000043 MSFT 0100000D) [ 0.000000] ACPI: FACS 7f575000 00040 [ 0.000000] ACPI: SSDT 7f5e7000 0043E (v01 INTEL D2700MUD 00000043 MSFT 0100000D) [ 0.000000] ACPI: APIC 7f5e5000 00084 (v02 INTEL D2700MUD 00000043 MSFT 0100000D) [ 0.000000] ACPI: MCFG 7f5e4000 0003C (v01 INTEL D2700MUD 00000043 MSFT 0100000D) [ 0.000000] ACPI: HPET 7f5e3000 00038 (v01 INTEL D2700MUD 00000043 MSFT 0100000D) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] 1149MB 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 -> 0x0007f5f0 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[6] active PFN ranges [ 0.000000] 0: 0x00000010 -> 0x0000008f [ 0.000000] 0: 0x00000090 -> 0x0000009e [ 0.000000] 0: 0x00000100 -> 0x0007f488 [ 0.000000] 0: 0x0007f4af -> 0x0007f4ef [ 0.000000] 0: 0x0007f5af -> 0x0007f5e2 [ 0.000000] 0: 0x0007f5ef -> 0x0007f5f0 [ 0.000000] On node 0 totalpages: 521353 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3949 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: 2300 pages used for memmap [ 0.000000] HighMem zone: 291842 pages, LIFO batch:31 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0x408 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x02] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x04] lapic_id[0x03] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high level lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x02] high level lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x03] high level lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x04] high level lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x08] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 8, version 32, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] ACPI: IRQ2 used by override. [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] SMP: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] Allocating PCI resources starting at 80000000 (gap: 80000000:60000000) [ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 18 pages/cpu @f5f6c000 s50976 r0 d22752 u73728 [ 0.000000] pcpu-alloc: s50976 r0 d22752 u73728 alloc=18*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 517277 [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.2.21-xenomai+ root=UUID=b763a08d-684f-451c-8995-48d6f7e54221 ro quiet splash [ 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] Initializing HighMem for node 0 (000377fe:0007f5f0) [ 0.000000] Memory: 2050444k/2086848k available (5063k kernel code, 34968k reserved, 2245k data, 512k init, 1176568k 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 : 0xc1724000 - 0xc17a4000 ( 512 kB) [ 0.000000] .data : 0xc14f1d8f - 0xc17234e0 (2245 kB) [ 0.000000] .text : 0xc1000000 - 0xc14f1d8f (5063 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] NR_IRQS:2304 nr_irqs:712 16 [ 0.000000] CPU 0 irqstacks, hard=f5806000 soft=f5808000 [ 0.000000] Extended CMOS year: 2000 [ 0.000000] Interrupt pipeline (release #1) [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] allocated 8388608 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] hpet clockevent registered [ 0.000000] Fast TSC calibration using PIT [ 0.001000] Detected 2128.165 MHz processor. [ 0.000004] Calibrating delay loop (skipped), value calculated using timer frequency.. 4256.33 BogoMIPS (lpj=2128165) [ 0.000015] pid_max: default: 32768 minimum: 301 [ 0.000144] Security Framework initialized [ 0.000163] AppArmor: AppArmor initialized [ 0.000218] Mount-cache hash table entries: 512 [ 0.000467] Initializing cgroup subsys cpuacct [ 0.000478] Initializing cgroup subsys memory [ 0.000495] Initializing cgroup subsys devices [ 0.000500] Initializing cgroup subsys freezer [ 0.000505] Initializing cgroup subsys blkio [ 0.000519] Initializing cgroup subsys perf_event [ 0.000572] Disabled fast string operations [ 0.000579] CPU: Physical Processor ID: 0 [ 0.000583] CPU: Processor Core ID: 0 [ 0.000588] mce: CPU supports 5 MCE banks [ 0.000599] CPU0: Thermal monitoring enabled (TM1) [ 0.000919] ACPI: Core revision 20110623 [ 0.011005] ftrace: allocating 20850 entries in 41 pages [ 0.018602] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.019048] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.029061] CPU0: Intel(R) Atom(TM) CPU D2700 @ 2.13GHz stepping 01 [ 0.130878] Performance Events: PEBS fmt0+, generic architected perfmon, Intel PMU driver. [ 0.130892] ... version: 3 [ 0.130896] ... bit width: 40 [ 0.130900] ... generic registers: 2 [ 0.130903] ... value mask: 000000ffffffffff [ 0.130908] ... max period: 000000007fffffff [ 0.130911] ... fixed-purpose events: 3 [ 0.130915] ... event mask: 0000000700000003 [ 0.137213] NMI watchdog enabled, takes one hw-pmu counter. [ 0.144921] CPU 1 irqstacks, hard=f4d1a000 soft=f4d1c000 [ 0.144926] Booting Node 0, Processors #1 [ 0.144932] smpboot cpu 1: start_ip = 9a000 [ 0.155029] Initializing CPU#1 [ 0.216845] Disabled fast string operations [ 0.236997] NMI watchdog enabled, takes one hw-pmu counter. [ 0.242889] CPU 2 irqstacks, hard=f4d30000 soft=f4d32000 [ 0.242894] #2 [ 0.242898] smpboot cpu 2: start_ip = 9a000 [ 0.252928] Initializing CPU#2 [ 0.313796] Disabled fast string operations [ 0.333904] NMI watchdog enabled, takes one hw-pmu counter. [ 0.340835] CPU 3 irqstacks, hard=f4d64000 soft=f4d66000 [ 0.340840] #3 Ok. [ 0.340844] smpboot cpu 3: start_ip = 9a000 [ 0.350878] Initializing CPU#3 [ 0.411749] Disabled fast string operations [ 0.431921] NMI watchdog enabled, takes one hw-pmu counter. [ 0.433745] Brought up 4 CPUs [ 0.433752] Total of 4 processors activated (17080.31 BogoMIPS). [ 0.434704] devtmpfs: initialized [ 0.435032] EVM: security.selinux [ 0.435036] EVM: security.SMACK64 [ 0.435040] EVM: security.capability [ 0.437487] print_constraints: dummy: [ 0.437628] NET: Registered protocol family 16 [ 0.437830] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it [ 0.437836] ACPI: bus type pci registered [ 0.437990] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000) [ 0.437998] PCI: MMCONFIG at [mem 0xe0000000-0xe3ffffff] reserved in E820 [ 0.438003] PCI: Using MMCONFIG for extended config space [ 0.438007] PCI: Using configuration type 1 for base access [ 0.440754] bio: create slab at 0 [ 0.441025] ACPI: Added _OSI(Module Device) [ 0.441032] ACPI: Added _OSI(Processor Device) [ 0.441037] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.441043] ACPI: Added _OSI(Processor Aggregator Device) [ 0.444688] ACPI: EC: Look up EC in DSDT [ 0.448588] ACPI: Executed 1 blocks of module-level executable AML code [ 0.459776] [Firmware Bug]: ACPI: BIOS _OSI(Linux) query ignored [ 0.460702] ACPI: Interpreter enabled [ 0.460714] ACPI: (supports S0 S3 S5) [ 0.460774] ACPI: Using IOAPIC for interrupt routing [ 0.475369] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.475974] \_SB_.PCI0:_OSC invalid UUID [ 0.475979] _OSC request data:1 8 1f [ 0.475992] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.476750] pci_root PNP0A08:00: host bridge window [io 0x0000-0x0cf7] [ 0.476758] pci_root PNP0A08:00: host bridge window [io 0x0d00-0xffff] [ 0.476764] pci_root PNP0A08:00: host bridge window [mem 0x000a0000-0x000bffff] [ 0.476770] pci_root PNP0A08:00: host bridge window [mem 0x000c0000-0x000dffff] [ 0.476775] pci_root PNP0A08:00: host bridge window [mem 0x000e0000-0x000effff] [ 0.476781] pci_root PNP0A08:00: host bridge window [mem 0x000f0000-0x000fffff] [ 0.476787] pci_root PNP0A08:00: host bridge window [mem 0x7f800000-0x7fffffff] [ 0.476793] pci_root PNP0A08:00: host bridge window [mem 0x80000000-0xfebfffff] [ 0.476799] pci_root PNP0A08:00: host bridge window [mem 0xfed40000-0xfed44fff] [ 0.476831] pci 0000:00:00.0: [8086:0bf3] type 0 class 0x000600 [ 0.476902] pci 0000:00:02.0: [8086:0be2] type 0 class 0x000300 [ 0.476923] pci 0000:00:02.0: reg 10: [mem 0x80100000-0x801fffff] [ 0.476934] pci 0000:00:02.0: reg 14: [io 0x20d0-0x20d7] [ 0.477049] pci 0000:00:1b.0: [8086:27d8] type 0 class 0x000403 [ 0.477075] pci 0000:00:1b.0: reg 10: [mem 0x80300000-0x80303fff 64bit] [ 0.477164] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold [ 0.477174] pci 0000:00:1b.0: PME# disabled [ 0.477210] pci 0000:00:1c.0: [8086:27d0] type 1 class 0x000604 [ 0.477301] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold [ 0.477308] pci 0000:00:1c.0: PME# disabled [ 0.477354] pci 0000:00:1d.0: [8086:27c8] type 0 class 0x000c03 [ 0.477423] pci 0000:00:1d.0: reg 20: [io 0x20a0-0x20bf] [ 0.477476] pci 0000:00:1d.1: [8086:27c9] type 0 class 0x000c03 [ 0.477546] pci 0000:00:1d.1: reg 20: [io 0x2080-0x209f] [ 0.477602] pci 0000:00:1d.2: [8086:27ca] type 0 class 0x000c03 [ 0.477671] pci 0000:00:1d.2: reg 20: [io 0x2060-0x207f] [ 0.477733] pci 0000:00:1d.3: [8086:27cb] type 0 class 0x000c03 [ 0.477800] pci 0000:00:1d.3: reg 20: [io 0x2040-0x205f] [ 0.477870] pci 0000:00:1d.7: [8086:27cc] type 0 class 0x000c03 [ 0.477899] pci 0000:00:1d.7: reg 10: [mem 0x80204400-0x802047ff] [ 0.478000] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold [ 0.478008] pci 0000:00:1d.7: PME# disabled [ 0.478039] pci 0000:00:1e.0: [8086:2448] type 1 class 0x000604 [ 0.478132] pci 0000:00:1f.0: [8086:27bc] type 0 class 0x000601 [ 0.478236] pci 0000:00:1f.0: [Firmware Bug]: TigerPoint LPC.BM_STS cleared [ 0.478292] pci 0000:00:1f.2: [8086:27c1] type 0 class 0x000106 [ 0.478319] pci 0000:00:1f.2: reg 10: [io 0x20c8-0x20cf] [ 0.478333] pci 0000:00:1f.2: reg 14: [io 0x20dc-0x20df] [ 0.478349] pci 0000:00:1f.2: reg 18: [io 0x20c0-0x20c7] [ 0.478364] pci 0000:00:1f.2: reg 1c: [io 0x20d8-0x20db] [ 0.478379] pci 0000:00:1f.2: reg 20: [io 0x2020-0x202f] [ 0.478394] pci 0000:00:1f.2: reg 24: [mem 0x80204000-0x802043ff] [ 0.478439] pci 0000:00:1f.2: PME# supported from D3hot [ 0.478447] pci 0000:00:1f.2: PME# disabled [ 0.478475] pci 0000:00:1f.3: [8086:27da] type 0 class 0x000c05 [ 0.478546] pci 0000:00:1f.3: reg 20: [io 0x2000-0x201f] [ 0.478689] pci 0000:01:00.0: [8086:10d3] type 0 class 0x000200 [ 0.478733] pci 0000:01:00.0: reg 10: [mem 0x80020000-0x8003ffff] [ 0.478758] pci 0000:01:00.0: reg 14: [mem 0x80000000-0x8001ffff] [ 0.478782] pci 0000:01:00.0: reg 18: [io 0x1000-0x101f] [ 0.478808] pci 0000:01:00.0: reg 1c: [mem 0x80040000-0x80043fff] [ 0.478936] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold [ 0.478947] pci 0000:01:00.0: PME# disabled [ 0.480744] pci 0000:00:1c.0: PCI bridge to [bus 01-01] [ 0.480753] pci 0000:00:1c.0: bridge window [io 0x1000-0x1fff] [ 0.480761] pci 0000:00:1c.0: bridge window [mem 0x80000000-0x800fffff] [ 0.480860] pci 0000:00:1e.0: PCI bridge to [bus 02-02] (subtractive decode) [ 0.480877] pci 0000:00:1e.0: bridge window [io 0x0000-0x0cf7] (subtractive decode) [ 0.480883] pci 0000:00:1e.0: bridge window [io 0x0d00-0xffff] (subtractive decode) [ 0.480889] pci 0000:00:1e.0: bridge window [mem 0x000a0000-0x000bffff] (subtractive decode) [ 0.480896] pci 0000:00:1e.0: bridge window [mem 0x000c0000-0x000dffff] (subtractive decode) [ 0.480902] pci 0000:00:1e.0: bridge window [mem 0x000e0000-0x000effff] (subtractive decode) [ 0.480908] pci 0000:00:1e.0: bridge window [mem 0x000f0000-0x000fffff] (subtractive decode) [ 0.480915] pci 0000:00:1e.0: bridge window [mem 0x7f800000-0x7fffffff] (subtractive decode) [ 0.480921] pci 0000:00:1e.0: bridge window [mem 0x80000000-0xfebfffff] (subtractive decode) [ 0.480927] pci 0000:00:1e.0: bridge window [mem 0xfed40000-0xfed44fff] (subtractive decode) [ 0.480948] pci_bus 0000:00: on NUMA node 0 [ 0.480956] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 0.481166] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P1._PRT] [ 0.481566] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT] [ 0.481867] \_SB_.PCI0:_OSC invalid UUID [ 0.481871] _OSC request data:1 f 1f [ 0.481883] pci0000:00: Unable to request _OSC control (_OSC support mask: 0x0f) [ 0.491718] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 5 6 7 10 12 14 15) *11 [ 0.491881] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 5 6 7 11 12 14 15) *0, disabled. [ 0.492035] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 7 10 12 14 15) *9 [ 0.492186] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 *11 12 14 15) [ 0.492336] ACPI: PCI Interrupt Link [LNKE] (IRQs 1 3 4 5 6 7 10 12 14 15) *0, disabled. [ 0.492489] ACPI: PCI Interrupt Link [LNKF] (IRQs 1 3 4 5 6 7 11 12 14 15) *0, disabled. [ 0.492642] ACPI: PCI Interrupt Link [LNKG] (IRQs 1 3 4 5 6 7 10 12 14 15) *9 [ 0.492807] ACPI: PCI Interrupt Link [LNKH] (IRQs 1 3 4 5 6 7 11 12 14 15) *10 [ 0.493031] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.493053] vgaarb: loaded [ 0.493057] vgaarb: bridge control possible 0000:00:02.0 [ 0.493363] SCSI subsystem initialized [ 0.493492] libata version 3.00 loaded. [ 0.493624] usbcore: registered new interface driver usbfs [ 0.493660] usbcore: registered new interface driver hub [ 0.493748] usbcore: registered new device driver usb [ 0.493872] PCI: Using ACPI for IRQ routing [ 0.495954] PCI: pci_cache_line_size set to 64 bytes [ 0.496057] reserve RAM buffer: 000000000008f000 - 000000000008ffff [ 0.496063] reserve RAM buffer: 000000000009e800 - 000000000009ffff [ 0.496069] reserve RAM buffer: 000000007f488000 - 000000007fffffff [ 0.496077] reserve RAM buffer: 000000007f4ef000 - 000000007fffffff [ 0.496084] reserve RAM buffer: 000000007f5e2000 - 000000007fffffff [ 0.496090] reserve RAM buffer: 000000007f5f0000 - 000000007fffffff [ 0.496312] NetLabel: Initializing [ 0.496317] NetLabel: domain hash size = 128 [ 0.496321] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.496344] NetLabel: unlabeled traffic allowed by default [ 0.496354] Switching to clocksource hpet [ 0.515851] AppArmor: AppArmor Filesystem Enabled [ 0.515907] pnp: PnP ACPI init [ 0.515927] ACPI: bus type pnp registered [ 0.516347] pnp 00:00: [bus 00-ff] [ 0.516354] pnp 00:00: [io 0x0000-0x0cf7 window] [ 0.516360] pnp 00:00: [io 0x0cf8-0x0cff] [ 0.516365] pnp 00:00: [io 0x0d00-0xffff window] [ 0.516371] pnp 00:00: [mem 0x000a0000-0x000bffff window] [ 0.516376] pnp 00:00: [mem 0x000c0000-0x000dffff window] [ 0.516382] pnp 00:00: [mem 0x000e0000-0x000effff window] [ 0.516387] pnp 00:00: [mem 0x000f0000-0x000fffff window] [ 0.516397] pnp 00:00: [mem 0x7f800000-0x7fffffff window] [ 0.516403] pnp 00:00: [mem 0x80000000-0xfebfffff window] [ 0.516408] pnp 00:00: [mem 0xfed40000-0xfed44fff window] [ 0.516555] pnp 00:00: Plug and Play ACPI device, IDs PNP0a08 PNP0a03 (active) [ 0.516610] pnp 00:01: [io 0x0000-0x001f] [ 0.516616] pnp 00:01: [io 0x0081-0x0091] [ 0.516621] pnp 00:01: [io 0x0093-0x009f] [ 0.516626] pnp 00:01: [io 0x00c0-0x00df] [ 0.516631] pnp 00:01: [dma 4] [ 0.516687] pnp 00:01: Plug and Play ACPI device, IDs PNP0200 (active) [ 0.516713] pnp 00:02: [mem 0xff000000-0xffffffff] [ 0.516763] pnp 00:02: Plug and Play ACPI device, IDs INT0800 (active) [ 0.516950] pnp 00:03: [mem 0xfed00000-0xfed003ff] [ 0.517037] system 00:03: [mem 0xfed00000-0xfed003ff] has been reserved [ 0.517046] system 00:03: Plug and Play ACPI device, IDs PNP0103 PNP0c01 (active) [ 0.517080] pnp 00:04: [io 0x00f0] [ 0.517099] pnp 00:04: [irq 13] [ 0.517152] pnp 00:04: Plug and Play ACPI device, IDs PNP0c04 (active) [ 0.517184] pnp 00:05: [io 0x002e-0x002f] [ 0.517189] pnp 00:05: [io 0x004e-0x004f] [ 0.517194] pnp 00:05: [io 0x0061] [ 0.517199] pnp 00:05: [io 0x0063] [ 0.517203] pnp 00:05: [io 0x0065] [ 0.517208] pnp 00:05: [io 0x0067] [ 0.517212] pnp 00:05: [io 0x0070] [ 0.517217] pnp 00:05: [io 0x0080] [ 0.517221] pnp 00:05: [io 0x0092] [ 0.517226] pnp 00:05: [io 0x00b2-0x00b3] [ 0.517231] pnp 00:05: [io 0x0680-0x069f] [ 0.517236] pnp 00:05: [io 0xffff] [ 0.517240] pnp 00:05: [io 0xffff] [ 0.517245] pnp 00:05: [io 0xffff] [ 0.517250] pnp 00:05: [io 0x0400-0x047f] [ 0.517255] pnp 00:05: [io 0x0500-0x057f] [ 0.517260] pnp 00:05: [io 0x0600-0x061f] [ 0.517356] system 00:05: [io 0x0680-0x069f] has been reserved [ 0.517364] system 00:05: [io 0xffff] has been reserved [ 0.517370] system 00:05: [io 0xffff] has been reserved [ 0.517376] system 00:05: [io 0xffff] has been reserved [ 0.517382] system 00:05: [io 0x0400-0x047f] has been reserved [ 0.517389] system 00:05: [io 0x0500-0x057f] has been reserved [ 0.517395] system 00:05: [io 0x0600-0x061f] has been reserved [ 0.517402] system 00:05: Plug and Play ACPI device, IDs PNP0c02 (active) [ 0.517494] pnp 00:06: [io 0x06a0-0x06af] [ 0.517499] pnp 00:06: [io 0x06b0-0x06ff] [ 0.517582] system 00:06: [io 0x06a0-0x06af] has been reserved [ 0.517589] system 00:06: [io 0x06b0-0x06ff] has been reserved [ 0.517596] system 00:06: Plug and Play ACPI device, IDs PNP0c02 (active) [ 0.517623] pnp 00:07: [io 0x0070-0x0077] [ 0.517636] pnp 00:07: [irq 8] [ 0.517690] pnp 00:07: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.518113] pnp 00:08: [io 0x0378-0x037f] [ 0.518126] pnp 00:08: [irq 7] [ 0.518259] pnp 00:08: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.518700] pnp 00:09: [io 0x03f8-0x03ff] [ 0.518707] pnp 00:09: IRQ 4 override to edge, high [ 0.518718] pnp 00:09: [irq 4] [ 0.518864] pnp 00:09: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.519191] pnp 00:0a: [io 0x02f8-0x02ff] [ 0.519197] pnp 00:0a: IRQ 3 override to edge, high [ 0.519208] pnp 00:0a: [irq 3] [ 0.519350] pnp 00:0a: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.519761] pnp 00:0b: [mem 0xfed1c000-0xfed1ffff] [ 0.519767] pnp 00:0b: [mem 0x00000000-0x00003fff] [ 0.519773] pnp 00:0b: [mem 0x00000000-0x00000fff] [ 0.519778] pnp 00:0b: [mem 0x00000000-0x00000fff] [ 0.519783] pnp 00:0b: [mem 0x00000000-0xffffffff disabled] [ 0.519789] pnp 00:0b: [mem 0xfed45000-0xfed8ffff] [ 0.519912] system 00:0b: [mem 0xfed1c000-0xfed1ffff] has been reserved [ 0.519920] system 00:0b: [mem 0x00000000-0x00003fff] could not be reserved [ 0.519927] system 00:0b: [mem 0x00000000-0x00000fff] could not be reserved [ 0.519934] system 00:0b: [mem 0x00000000-0x00000fff] could not be reserved [ 0.519940] system 00:0b: [mem 0xfed45000-0xfed8ffff] has been reserved [ 0.519948] system 00:0b: Plug and Play ACPI device, IDs PNP0c02 (active) [ 0.520331] pnp: PnP ACPI: found 12 devices [ 0.520335] ACPI: ACPI bus type pnp unregistered [ 0.560228] PCI: max bus depth: 1 pci_try_num: 2 [ 0.560271] pci 0000:00:1c.0: BAR 15: assigned [mem 0x80400000-0x805fffff 64bit pref] [ 0.560278] pci 0000:00:1c.0: PCI bridge to [bus 01-01] [ 0.560285] pci 0000:00:1c.0: bridge window [io 0x1000-0x1fff] [ 0.560295] pci 0000:00:1c.0: bridge window [mem 0x80000000-0x800fffff] [ 0.560304] pci 0000:00:1c.0: bridge window [mem 0x80400000-0x805fffff 64bit pref] [ 0.560315] pci 0000:00:1e.0: PCI bridge to [bus 02-02] [ 0.560359] pci 0000:00:1c.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 0.560369] pci 0000:00:1c.0: setting latency timer to 64 [ 0.560384] pci 0000:00:1e.0: setting latency timer to 64 [ 0.560393] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] [ 0.560413] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff] [ 0.560419] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff] [ 0.560425] pci_bus 0000:00: resource 7 [mem 0x000c0000-0x000dffff] [ 0.560430] pci_bus 0000:00: resource 8 [mem 0x000e0000-0x000effff] [ 0.560436] pci_bus 0000:00: resource 9 [mem 0x000f0000-0x000fffff] [ 0.560442] pci_bus 0000:00: resource 10 [mem 0x7f800000-0x7fffffff] [ 0.560447] pci_bus 0000:00: resource 11 [mem 0x80000000-0xfebfffff] [ 0.560453] pci_bus 0000:00: resource 12 [mem 0xfed40000-0xfed44fff] [ 0.560459] pci_bus 0000:01: resource 0 [io 0x1000-0x1fff] [ 0.560464] pci_bus 0000:01: resource 1 [mem 0x80000000-0x800fffff] [ 0.560470] pci_bus 0000:01: resource 2 [mem 0x80400000-0x805fffff 64bit pref] [ 0.560477] pci_bus 0000:02: resource 4 [io 0x0000-0x0cf7] [ 0.560482] pci_bus 0000:02: resource 5 [io 0x0d00-0xffff] [ 0.560488] pci_bus 0000:02: resource 6 [mem 0x000a0000-0x000bffff] [ 0.560493] pci_bus 0000:02: resource 7 [mem 0x000c0000-0x000dffff] [ 0.560499] pci_bus 0000:02: resource 8 [mem 0x000e0000-0x000effff] [ 0.560504] pci_bus 0000:02: resource 9 [mem 0x000f0000-0x000fffff] [ 0.560510] pci_bus 0000:02: resource 10 [mem 0x7f800000-0x7fffffff] [ 0.560516] pci_bus 0000:02: resource 11 [mem 0x80000000-0xfebfffff] [ 0.560522] pci_bus 0000:02: resource 12 [mem 0xfed40000-0xfed44fff] [ 0.560704] NET: Registered protocol family 2 [ 0.560874] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.561528] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.562223] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) [ 0.562619] TCP: Hash tables configured (established 131072 bind 65536) [ 0.562626] TCP reno registered [ 0.562637] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 0.562654] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 0.562933] NET: Registered protocol family 1 [ 0.562969] pci 0000:00:02.0: Boot video device [ 0.563015] pci 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 0.563041] pci 0000:00:1d.0: PCI INT A disabled [ 0.563064] pci 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 0.563087] pci 0000:00:1d.1: PCI INT B disabled [ 0.563114] pci 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 0.563137] pci 0000:00:1d.2: PCI INT C disabled [ 0.563152] pci 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16 [ 0.563177] pci 0000:00:1d.3: PCI INT D disabled [ 0.563193] pci 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 0.575432] pci 0000:00:1d.7: PCI INT A disabled [ 0.575463] PCI: CLS 64 bytes, default 64 [ 0.575599] Unpacking initramfs... [ 0.847400] Freeing initrd memory: 8312k freed [ 0.855027] audit: initializing netlink socket (disabled) [ 0.855056] type=2000 audit(1360643547.687:1): initialized [ 0.855468] I-pipe: head domain Xenomai registered. [ 0.855575] Xenomai: hal/i386 started. [ 0.855607] Xenomai: scheduling class idle registered. [ 0.855611] Xenomai: scheduling class rt registered. [ 0.858292] Xenomai: real-time nucleus v2.6.1 (Light Years Away) loaded. [ 0.858298] Xenomai: debug mode enabled. [ 0.858568] Xenomai: starting native API services. [ 0.858575] Xenomai: starting POSIX services. [ 0.858626] Xenomai: starting RTDM services. [ 0.864054] highmem bounce pool size: 64 pages [ 0.864066] HugeTLB registered 4 MB page size, pre-allocated 0 pages [ 0.875185] VFS: Disk quotas dquot_6.5.2 [ 0.875294] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.876457] fuse init (API version 7.17) [ 0.876605] msgmni has been set to 1723 [ 0.877496] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 0.877569] io scheduler noop registered [ 0.877576] io scheduler deadline registered [ 0.877642] io scheduler cfq registered (default) [ 0.877838] pcieport 0000:00:1c.0: setting latency timer to 64 [ 0.878213] input: Power Button as /devices/LNXSYSTM:00/device:00/PNP0C0C:00/input/input0 [ 0.878224] ACPI: Power Button [PWRB] [ 0.878348] input: Sleep Button as /devices/LNXSYSTM:00/device:00/PNP0C0E:00/input/input1 [ 0.878357] ACPI: Sleep Button [SLPB] [ 0.878461] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 [ 0.878468] ACPI: Power Button [PWRF] [ 0.878710] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled [ 0.899241] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 0.936709] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A [ 1.453758] 00:09: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 1.482606] 00:0a: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A [ 1.492249] Linux agpgart interface v0.103 [ 1.493414] Fixed MDIO Bus: probed [ 1.493635] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 1.493673] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 1.493709] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 1.493716] ehci_hcd 0000:00:1d.7: EHCI Host Controller [ 1.493818] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1 [ 1.493855] ehci_hcd 0000:00:1d.7: using broken periodic workaround [ 1.493873] ehci_hcd 0000:00:1d.7: debug port 1 [ 1.497778] ehci_hcd 0000:00:1d.7: cache line size of 64 is not supported [ 1.497817] ehci_hcd 0000:00:1d.7: irq 23, io mem 0x80204400 [ 1.507021] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00 [ 1.507334] hub 1-0:1.0: USB hub found [ 1.507346] hub 1-0:1.0: 8 ports detected [ 1.507500] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 1.507534] uhci_hcd: USB Universal Host Controller Interface driver [ 1.507603] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 1.507619] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 1.507626] uhci_hcd 0000:00:1d.0: UHCI Host Controller [ 1.507740] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 [ 1.507779] uhci_hcd 0000:00:1d.0: irq 23, io base 0x000020a0 [ 1.508108] hub 2-0:1.0: USB hub found [ 1.508123] hub 2-0:1.0: 2 ports detected [ 1.508232] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 1.508253] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 1.508260] uhci_hcd 0000:00:1d.1: UHCI Host Controller [ 1.508366] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 [ 1.508428] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00002080 [ 1.508715] hub 3-0:1.0: USB hub found [ 1.508726] hub 3-0:1.0: 2 ports detected [ 1.508831] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 1.508846] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [ 1.508852] uhci_hcd 0000:00:1d.2: UHCI Host Controller [ 1.508953] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 [ 1.509036] uhci_hcd 0000:00:1d.2: irq 18, io base 0x00002060 [ 1.509325] hub 4-0:1.0: USB hub found [ 1.509337] hub 4-0:1.0: 2 ports detected [ 1.509442] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16 [ 1.509460] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [ 1.509467] uhci_hcd 0000:00:1d.3: UHCI Host Controller [ 1.509577] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5 [ 1.509632] uhci_hcd 0000:00:1d.3: irq 16, io base 0x00002040 [ 1.509909] hub 5-0:1.0: USB hub found [ 1.509921] hub 5-0:1.0: 2 ports detected [ 1.510183] usbcore: registered new interface driver libusual [ 1.510295] i8042: PNP: No PS/2 controller found. Probing ports directly. [ 1.513029] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 1.513102] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 1.513346] mousedev: PS/2 mouse device common for all mice [ 1.513736] rtc_cmos 00:07: RTC can wake from S4 [ 1.513927] rtc_cmos 00:07: rtc core: registered rtc_cmos as rtc0 [ 1.513968] rtc0: alarms up to one month, y3k, 242 bytes nvram, hpet irqs [ 1.514579] TCP cubic registered [ 1.514757] NET: Registered protocol family 10 [ 1.516057] NET: Registered protocol family 17 [ 1.516104] Registering the dns_resolver key type [ 1.516150] Using IPI No-Shortcut mode [ 1.516395] registered taskstats version 1 [ 1.536295] rtc_cmos 00:07: setting system clock to 2013-02-12 04:32:29 UTC (1360643549) [ 1.536303] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 1.536308] EDD information not available. [ 1.536558] Freeing unused kernel memory: 512k freed [ 1.536819] Write protecting the kernel text: 5064k [ 1.536893] Write protecting the kernel read-only data: 1876k [ 1.572255] udevd[93]: starting version 175 [ 1.655381] e1000e: Intel(R) PRO/1000 Network Driver - 1.5.1-k [ 1.655388] e1000e: Copyright(c) 1999 - 2011 Intel Corporation. [ 1.655434] e1000e 0000:01:00.0: Disabling ASPM L0s [ 1.655460] e1000e 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 1.655490] e1000e 0000:01:00.0: setting latency timer to 64 [ 1.655701] e1000e 0000:01:00.0: (unregistered net_device): Failed to initialize MSI-X interrupts. Falling back to MSI interrupts. [ 1.655758] e1000e 0000:01:00.0: (unregistered net_device): Failed to initialize MSI interrupts. Falling back to legacy interrupts. [ 1.676876] ahci 0000:00:1f.2: version 3.0 [ 1.676906] ahci 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 1.677158] ahci: SSS flag set, parallel bus scan disabled [ 1.677212] ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 4 ports 3 Gbps 0x3 impl SATA mode [ 1.677225] ahci 0000:00:1f.2: flags: 64bit ncq stag pm led clo pio slum part [ 1.677240] ahci 0000:00:1f.2: setting latency timer to 64 [ 1.678975] scsi0 : ahci [ 1.679358] scsi1 : ahci [ 1.679607] scsi2 : ahci [ 1.680072] scsi3 : ahci [ 1.680251] ata1: SATA max UDMA/133 abar m1024@0x80204000 port 0x80204100 irq 19 [ 1.680262] ata2: SATA max UDMA/133 abar m1024@0x80204000 port 0x80204180 irq 19 [ 1.680271] ata3: DUMMY [ 1.680275] ata4: DUMMY [ 1.756186] e1000e 0000:01:00.0: eth0: (PCI Express:2.5GT/s:Width x1) 00:22:4d:7f:3f:83 [ 1.756196] e1000e 0000:01:00.0: eth0: Intel(R) PRO/1000 Network Connection [ 1.756217] e1000e 0000:01:00.0: eth0: MAC: 3, PHY: 8, PBA No: FFFFFF-0FF [ 1.853905] Refined TSC clocksource calibration: 2127.999 MHz. [ 1.853917] Switching to clocksource tsc [ 1.963838] usb 1-4: new high-speed USB device number 4 using ehci_hcd [ 1.984824] ata1: SATA link down (SStatus 0 SControl 300) [ 2.087124] hub 1-4:1.0: USB hub found [ 2.087278] hub 1-4:1.0: 3 ports detected [ 2.289701] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 2.290035] ata2.00: ATA-9: SanDisk SDSSDRC032G, 2.0.0, max UDMA/133 [ 2.290042] ata2.00: 62533296 sectors, multi 1: LBA48 NCQ (depth 31/32) [ 2.290306] ata2.00: configured for UDMA/133 [ 2.290563] scsi 1:0:0:0: Direct-Access ATA SanDisk SDSSDRC0 2.0. PQ: 0 ANSI: 5 [ 2.290903] sd 1:0:0:0: [sda] 62533296 512-byte logical blocks: (32.0 GB/29.8 GiB) [ 2.290978] sd 1:0:0:0: Attached scsi generic sg0 type 0 [ 2.291223] sd 1:0:0:0: [sda] Write Protect is off [ 2.291234] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 2.291340] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 2.292900] sda: sda1 sda2 < sda5 > [ 2.293712] usb 2-2: new full-speed USB device number 2 using uhci_hcd [ 2.293813] sd 1:0:0:0: [sda] Attached SCSI disk [ 2.377747] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) [ 2.459540] hub 2-2:1.0: USB hub found [ 2.461476] hub 2-2:1.0: 3 ports detected [ 2.668773] init: ureadahead main process (218) terminated with status 5 [ 2.671553] usb 3-1: new low-speed USB device number 2 using uhci_hcd [ 2.817338] Adding 2082812k swap on /dev/sda5. Priority:-1 extents:1 across:2082812k SS [ 2.910562] usb 1-4.2: new low-speed USB device number 5 using ehci_hcd [ 2.913750] udevd[292]: starting version 175 [ 2.940062] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro [ 3.003012] lp: driver loaded but no devices found [ 3.076222] usb 2-2.1: new full-speed USB device number 3 using uhci_hcd [ 3.222768] [drm] Initialized drm 1.1.0 20060810 [ 3.257160] usb 2-2.2: new full-speed USB device number 4 using uhci_hcd [ 3.314859] pvrsrvkm 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 3.314875] pvrsrvkm 0000:00:02.0: setting latency timer to 64 [ 3.319708] parport_pc 00:08: reported by Plug and Play ACPI [ 3.319777] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE] [ 3.347269] [TTM] Zone kernel: Available graphics memory: 441350 kiB. [ 3.347279] [TTM] Zone highmem: Available graphics memory: 1029634 kiB. [ 3.347287] [TTM] Initializing pool allocator. [ 3.426835] lp0: using parport0 (interrupt-driven). [ 3.434085] usb 2-2.3: new full-speed USB device number 5 using uhci_hcd [ 3.444776] ppdev: user-space parallel port driver [ 3.461037] Bluetooth: Core ver 2.16 [ 3.461111] NET: Registered protocol family 31 [ 3.461119] Bluetooth: HCI device and connection manager initialized [ 3.461127] Bluetooth: HCI socket layer initialized [ 3.461134] Bluetooth: L2CAP socket layer initialized [ 3.461153] Bluetooth: SCO socket layer initialized [ 3.490799] Bluetooth: RFCOMM TTY layer initialized [ 3.490815] Bluetooth: RFCOMM socket layer initialized [ 3.490822] Bluetooth: RFCOMM ver 1.11 [ 3.502389] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 3.502399] Bluetooth: BNEP filters: protocol multicast [ 3.564555] [drm:psb_driver_load] *ERROR* Enable MSI failed! [ 3.564609] [drm] Supports vblank timestamp caching Rev 1 (10.10.2010). [ 3.564616] [drm] No driver support for vblank timestamp query. [ 3.593747] ACPI Warning: _BQC returned an invalid level (20110623/video-472) [ 3.612582] acpi device:27: registered as cooling_device0 [ 3.623922] input: Video Bus as /devices/LNXSYSTM:00/device:00/PNP0A08:00/LNXVIDEO:00/input/input3 [ 3.626704] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no) [ 3.633596] input: Logitech USB Laser Mouse as /devices/pci0000:00/0000:00:1d.1/usb3/3-1/3-1:1.0/input/input4 [ 3.634656] generic-usb 0003:046D:C062.0001: input,hidraw0: USB HID v1.10 Mouse [Logitech USB Laser Mouse] on usb-0000:00:1d.1-1/input0 [ 3.640646] input: HID 0a5c:4502 as /devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2.1/2-2.1:1.0/input/input5 [ 3.641514] generic-usb 0003:0A5C:4502.0004: input,hidraw1: USB HID v1.11 Keyboard [HID 0a5c:4502] on usb-0000:00:1d.0-2.1/input0 [ 3.646458] input: HID 0a5c:4503 as /devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2.2/2-2.2:1.0/input/input6 [ 3.647376] generic-usb 0003:0A5C:4503.0005: input,hidraw2: USB HID v1.11 Mouse [HID 0a5c:4503] on usb-0000:00:1d.0-2.2/input0 [ 3.647546] usbcore: registered new interface driver usbhid [ 3.647553] usbhid: USB HID core driver [ 3.820161] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 3.820217] Raw EDID: [ 3.820256] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 3.820299] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 3.820342] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 3.820385] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 3.820429] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 3.820471] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 3.820513] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 3.820556] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125380] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 4.125432] Raw EDID: [ 4.125469] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125510] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125551] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125592] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125633] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125676] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125728] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.125780] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.353421] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 4.353496] Raw EDID: [ 4.353544] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.353595] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.353648] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.353699] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.353750] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.356855] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.356919] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.356973] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.437279] type=1400 audit(1360643552.401:2): apparmor="STATUS" operation="profile_load" name="/sbin/dhclient" pid=478 comm="apparmor_parser" [ 4.437487] type=1400 audit(1360643552.401:3): apparmor="STATUS" operation="profile_load" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=478 comm="apparmor_parser" [ 4.437646] type=1400 audit(1360643552.401:4): apparmor="STATUS" operation="profile_load" name="/usr/lib/connman/scripts/dhclient-script" pid=478 comm="apparmor_parser" [ 4.482031] Bluetooth: Generic Bluetooth USB driver ver 0.6 [ 4.487125] usbcore: registered new interface driver btusb [ 4.535029] input: Apple, Inc Apple Keyboard as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input7 [ 4.537979] apple 0003:05AC:0220.0002: input,hidraw3: USB HID v1.11 Keyboard [Apple, Inc Apple Keyboard] on usb-0000:00:1d.7-4.2/input0 [ 4.543700] input: Apple, Inc Apple Keyboard as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input8 [ 4.545757] apple 0003:05AC:0220.0003: input,hidraw4: USB HID v1.11 Device [Apple, Inc Apple Keyboard] on usb-0000:00:1d.7-4.2/input1 [ 4.579414] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 4.579488] Raw EDID: [ 4.579537] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.579590] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.579643] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.580210] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.580269] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.580323] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.580378] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.580430] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.580488] pvrsrvkm 0000:00:02.0: LVDS-1: EDID block 0 invalid. [ 4.591132] Overlay GTT address is 7c0000 [ 4.941831] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 4.941902] Raw EDID: [ 4.941948] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.941999] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.942048] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.942098] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.942148] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.942198] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.942248] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 4.942299] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.014708] type=1400 audit(1360643552.979:5): apparmor="STATUS" operation="profile_replace" name="/sbin/dhclient" pid=583 comm="apparmor_parser" [ 5.014909] type=1400 audit(1360643552.979:6): apparmor="STATUS" operation="profile_replace" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=583 comm="apparmor_parser" [ 5.015071] type=1400 audit(1360643552.979:7): apparmor="STATUS" operation="profile_replace" name="/usr/lib/connman/scripts/dhclient-script" pid=583 comm="apparmor_parser" [ 5.050310] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 5.050384] Raw EDID: [ 5.050433] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.054720] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.058678] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.058740] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.058795] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.058850] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.058904] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.058958] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.149419] init: failsafe main process (661) killed by TERM signal [ 5.187775] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 5.187854] Raw EDID: [ 5.187902] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.187955] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.188010] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.188064] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.188118] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.188174] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.188230] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.188285] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.230032] type=1400 audit(1360643553.194:8): apparmor="STATUS" operation="profile_load" name="/usr/lib/cups/backend/cups-pdf" pid=556 comm="apparmor_parser" [ 5.230572] type=1400 audit(1360643553.195:9): apparmor="STATUS" operation="profile_load" name="/usr/sbin/cupsd" pid=556 comm="apparmor_parser" [ 5.348508] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [ 5.348949] Raw EDID: [ 5.349007] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.349062] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.349804] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.349870] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.349935] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.350002] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.350059] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.350129] ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff [ 5.350578] pvrsrvkm 0000:00:02.0: LVDS-1: EDID block 0 invalid. [ 5.397896] fbcon: psbfb (fb0) is primary device [ 5.515792] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 5.904040] type=1400 audit(1360643553.868:10): apparmor="STATUS" operation="profile_load" name="/usr/lib/lightdm/lightdm/lightdm-guest-session-wrapper" pid=727 comm="apparmor_parser" [ 5.920579] Console: switching to colour frame buffer device 170x48 [ 5.934583] fb0: psbfb frame buffer device [ 5.934589] drm: registered panic notifier [ 5.934780] Cedartrail: apply sample cache workaround [ 5.935095] Device ID: 2 [ 5.935181] [drm] Initialized pvrsrvkm 8.1.0 2009-03-10 for 0000:00:02.0 on minor 0 [ 5.935276] snd_hda_intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [ 5.935379] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 [ 6.001379] input: HDA Intel Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9 [ 6.555078] type=1400 audit(1360643554.520:11): apparmor="STATUS" operation="profile_replace" name="/sbin/dhclient" pid=728 comm="apparmor_parser" [ 6.555279] type=1400 audit(1360643554.520:12): apparmor="STATUS" operation="profile_replace" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=728 comm="apparmor_parser" [ 6.555442] type=1400 audit(1360643554.520:13): apparmor="STATUS" operation="profile_replace" name="/usr/lib/connman/scripts/dhclient-script" pid=728 comm="apparmor_parser" [ 7.286679] type=1400 audit(1360643555.252:14): apparmor="STATUS" operation="profile_load" name="/usr/sbin/tcpdump" pid=770 comm="apparmor_parser" [ 7.723426] type=1400 audit(1360643555.689:15): apparmor="STATUS" operation="profile_replace" name="/usr/lib/cups/backend/cups-pdf" pid=753 comm="apparmor_parser" [ 7.723799] type=1400 audit(1360643555.689:16): apparmor="STATUS" operation="profile_replace" name="/usr/sbin/cupsd" pid=753 comm="apparmor_parser" [ 8.000172] type=1400 audit(1360643555.965:17): apparmor="STATUS" operation="profile_load" name="/usr/lib/telepathy/mission-control-5" pid=732 comm="apparmor_parser" [ 8.000741] type=1400 audit(1360643555.966:18): apparmor="STATUS" operation="profile_load" name="/usr/lib/telepathy/telepathy-*" pid=732 comm="apparmor_parser" [ 8.594056] e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx/Tx [ 8.594583] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 18.848681] eth0: no IPv6 routers present [ 23.172841] type=1400 audit(1360643571.142:19): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince" pid=729 comm="apparmor_parser" [ 23.173537] type=1400 audit(1360643571.143:20): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince//launchpad_integration" pid=729 comm="apparmor_parser" [ 23.173896] type=1400 audit(1360643571.143:21): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince//sanitized_helper" pid=729 comm="apparmor_parser" [ 23.175341] type=1400 audit(1360643571.145:22): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince-previewer" pid=729 comm="apparmor_parser" [ 23.175981] type=1400 audit(1360643571.146:23): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince-previewer//launchpad_integration" pid=729 comm="apparmor_parser" [ 23.176329] type=1400 audit(1360643571.146:24): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince-previewer//sanitized_helper" pid=729 comm="apparmor_parser" [ 23.177361] type=1400 audit(1360643571.147:25): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince-thumbnailer" pid=729 comm="apparmor_parser" [ 23.177729] type=1400 audit(1360643571.147:26): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince-thumbnailer//sanitized_helper" pid=729 comm="apparmor_parser" [ 23.357714] init: alsa-restore main process (885) terminated with status 99