runsolver Copyright (C) 2010 Olivier ROUSSEL This is runsolver version 3.2.9a (svn: 651) This program is distributed in the hope that it will be useful, but WITHOUT ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License for more details. command line: runsolver -W 300 -M 1124 -w /home/cbse/results/sarge-etch/logs/1.runsolver.aptitude aptitude -s -y --without-recommends install libgnome2-gconf-perl libroy1-prof python-simpy libchipcard20 libeb7-dev Enforcing wall clock limit (soft limit, will send signal-name then SIGKILL): 300 seconds Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB [startup+0 s] /proc/loadavg: 0.63 0.22 0.08 2/55 19225 /proc/meminfo: memFree=250144/1022884 swapFree=0/0 [pid=19225] ppid=19224 vsize=3152 CPUtime=0 /proc/19225/stat : 19225 (runsolver) R 19224 17863 17863 34816 17863 4202560 0 0 0 0 0 0 0 0 20 0 1 0 28169034 3227648 32 18446744073709551615 134512640 134586868 4289036976 4289035024 4151247920 0 0 0 24578 0 0 0 17 0 0 0 0 0 0 /proc/19225/statm: 788 32 0 19 0 73 0 Current StackSize limit: 8192 KiB [startup+0.173604 s] /proc/loadavg: 0.63 0.22 0.08 2/55 19225 /proc/meminfo: memFree=250144/1022884 swapFree=0/0 [pid=19225] ppid=19224 vsize=86100 CPUtime=0.17 /proc/19225/stat : 19225 (aptitude) R 19224 19225 17863 34816 17863 4202496 7109 1708 0 0 14 2 1 0 20 0 1 0 28169034 88166400 6900 18446744073709551615 139780598521856 139780602829208 140735793712496 140735793703608 139780593376492 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0 /proc/19225/statm: 21525 6900 4712 1052 0 2116 0 Current children cumulated CPU time (s) 0.17 Current children cumulated vsize (KiB) 86100 [startup+0.200627 s] /proc/loadavg: 0.63 0.22 0.08 2/55 19225 /proc/meminfo: memFree=250144/1022884 swapFree=0/0 [pid=19225] ppid=19224 vsize=89348 CPUtime=0.2 /proc/19225/stat : 19225 (aptitude) R 19224 19225 17863 34816 17863 4202496 8301 1708 0 0 16 3 1 0 20 0 1 0 28169034 91492352 7346 18446744073709551615 139780598521856 139780602829208 140735793712496 140735793702008 139780556402967 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0 /proc/19225/statm: 22337 7346 4721 1052 0 2928 0 Current children cumulated CPU time (s) 0.2 Current children cumulated vsize (KiB) 89348 [startup+0.300287 s] /proc/loadavg: 0.63 0.22 0.08 2/55 19225 /proc/meminfo: memFree=250144/1022884 swapFree=0/0 [pid=19225] ppid=19224 vsize=96684 CPUtime=0.3 /proc/19225/stat : 19225 (aptitude) R 19224 19225 17863 34816 17863 4202496 9019 1708 0 0 24 5 1 0 20 0 2 0 28169034 99004416 7653 18446744073709551615 139780598521856 139780602829208 140735793712496 140735793708280 139780599350864 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19225/statm: 24171 7653 4887 1052 0 4762 0 Current children cumulated CPU time (s) 0.3 Current children cumulated vsize (KiB) 96684 [startup+0.70021 s] /proc/loadavg: 0.63 0.22 0.08 2/55 19225 /proc/meminfo: memFree=250144/1022884 swapFree=0/0 [pid=19225] ppid=19224 vsize=100616 CPUtime=0.69 /proc/19225/stat : 19225 (aptitude) R 19224 19225 17863 34816 17863 4202496 10120 1708 0 0 63 5 1 0 20 0 2 0 28169034 103030784 8748 18446744073709551615 139780598521856 139780602829208 140735793712496 140735793699368 139780556022166 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19225/statm: 25154 8748 4994 1052 0 5745 0 Current children cumulated CPU time (s) 0.69 Current children cumulated vsize (KiB) 100616 [startup+1.50024 s] /proc/loadavg: 0.63 0.22 0.08 2/57 19231 /proc/meminfo: memFree=234248/1022884 swapFree=0/0 [pid=19225] ppid=19224 vsize=111940 CPUtime=1.49 /proc/19225/stat : 19225 (aptitude) S 19224 19225 17863 34816 17863 4202496 14084 2207 0 0 142 6 1 0 20 0 2 0 28169034 114626560 11700 18446744073709551615 139780598521856 139780602829208 140735793712496 140735793704256 139780567266891 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19225/statm: 27985 11700 5102 1052 0 8576 0 [pid=19225/tid=19230] ppid=19224 vsize=111940 CPUtime=0.31 /proc/19225/task/19230/stat : 19230 (aptitude) R 19224 19225 17863 34816 17863 4202560 3421 2207 0 0 30 0 1 0 20 0 2 0 28169064 114626560 11700 18446744073709551615 139780598521856 139780602829208 140735793712496 139780515092344 139780556103383 0 134217728 4096 0 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.49 Current children cumulated vsize (KiB) 111940 Solver just ended. Dumping a history of the last processes samples [startup+1.60034 s] /proc/loadavg: 0.63 0.22 0.08 2/57 19231 /proc/meminfo: memFree=234248/1022884 swapFree=0/0 [pid=19225] ppid=19224 vsize=112232 CPUtime=1.59 /proc/19225/stat : 19225 (aptitude) R 19224 19225 17863 34816 17863 4202496 15537 2207 0 0 152 6 1 0 20 0 2 0 28169034 114925568 11810 18446744073709551615 139780598521856 139780602829208 140735793712496 140735793700360 139780600726820 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19225/statm: 28058 11810 5151 1052 0 8642 0 [pid=19225/tid=19230] ppid=19224 vsize=112232 CPUtime=0.31 /proc/19225/task/19230/stat : 19230 (aptitude) S 19224 19225 17863 34816 17863 4202560 3443 2207 0 0 30 0 1 0 20 0 2 0 28169064 114925568 11810 18446744073709551615 139780598521856 139780602829208 140735793712496 139780515100672 139780567266004 0 134217728 4096 0 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.59 Current children cumulated vsize (KiB) 112232 Child status: 0 Real time (s): 1.64859 CPU time (s): 1.6481 CPU user time (s): 1.5641 CPU system time (s): 0.084005 CPU usage (%): 99.9705 Max. virtual memory (cumulated for all children) (KiB): 112232 getrusage(RUSAGE_CHILDREN,...) data: user time used= 1.5641 system time used= 0.084005 maximum resident set size= 47252 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 18459 page faults= 0 swaps= 0 block input operations= 0 block output operations= 24 messages sent= 0 messages received= 0 signals received= 0 voluntary context switches= 60 involuntary context switches= 74 runsolver used 0.004 second user time and 0.008 second system time The end