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/62.runsolver.aptitude aptitude -s -y --without-recommends install kernel-image-2.4.27-speakup drupal jftpgw libvibrant6 records-common 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.99 0.66 0.29 2/55 19773 /proc/meminfo: memFree=245628/1022884 swapFree=0/0 [pid=19773] ppid=19772 vsize=3152 CPUtime=0 /proc/19773/stat : 19773 (runsolver) R 19772 17863 17863 34816 17863 4202560 0 0 0 0 0 0 0 0 20 0 1 0 28194900 3227648 32 18446744073709551615 134512640 134586868 4294114336 4294112384 4151313456 0 0 0 24578 0 0 0 17 0 0 0 0 0 0 /proc/19773/statm: 788 32 0 19 0 73 0 Current StackSize limit: 8192 KiB [startup+0.167991 s] /proc/loadavg: 0.99 0.66 0.29 2/55 19773 /proc/meminfo: memFree=245628/1022884 swapFree=0/0 [pid=19773] ppid=19772 vsize=86100 CPUtime=0.15 /proc/19773/stat : 19773 (aptitude) R 19772 19773 17863 34816 17863 4202496 7108 1710 0 0 14 1 0 0 20 0 1 0 28194900 88166400 6899 18446744073709551615 140126833291264 140126837598616 140734313592256 140734313583368 140126828144610 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0 /proc/19773/statm: 21525 6899 4712 1052 0 2116 0 Current children cumulated CPU time (s) 0.15 Current children cumulated vsize (KiB) 86100 [startup+0.200299 s] /proc/loadavg: 0.99 0.66 0.29 2/55 19773 /proc/meminfo: memFree=245628/1022884 swapFree=0/0 [pid=19773] ppid=19772 vsize=87812 CPUtime=0.18 /proc/19773/stat : 19773 (aptitude) R 19772 19773 17863 34816 17863 4202496 7878 1710 0 0 17 1 0 0 20 0 1 0 28194900 89919488 7308 18446744073709551615 140126833291264 140126837598616 140734313592256 140734313581768 140126834347156 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0 /proc/19773/statm: 21953 7308 4721 1052 0 2544 0 Current children cumulated CPU time (s) 0.18 Current children cumulated vsize (KiB) 87812 [startup+0.300272 s] /proc/loadavg: 0.99 0.66 0.29 2/55 19773 /proc/meminfo: memFree=245628/1022884 swapFree=0/0 [pid=19773] ppid=19772 vsize=95900 CPUtime=0.28 /proc/19773/stat : 19773 (aptitude) R 19772 19773 17863 34816 17863 4202496 8814 1710 0 0 26 2 0 0 20 0 2 0 28194900 98201600 7449 18446744073709551615 140126833291264 140126837598616 140734313592256 140734313584240 140126806570649 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19773/statm: 23975 7449 4871 1052 0 4566 0 Current children cumulated CPU time (s) 0.28 Current children cumulated vsize (KiB) 95900 [startup+0.700218 s] /proc/loadavg: 0.99 0.66 0.29 2/55 19773 /proc/meminfo: memFree=245628/1022884 swapFree=0/0 [pid=19773] ppid=19772 vsize=100668 CPUtime=0.68 /proc/19773/stat : 19773 (aptitude) R 19772 19773 17863 34816 17863 4202496 10132 1710 0 0 66 2 0 0 20 0 2 0 28194900 103084032 8762 18446744073709551615 140126833291264 140126837598616 140734313592256 140734313582552 140126790801760 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19773/statm: 25167 8762 4994 1052 0 5758 0 Current children cumulated CPU time (s) 0.68 Current children cumulated vsize (KiB) 100668 [startup+1.50025 s] /proc/loadavg: 0.99 0.66 0.29 2/57 19779 /proc/meminfo: memFree=229748/1022884 swapFree=0/0 [pid=19773] ppid=19772 vsize=108464 CPUtime=1.48 /proc/19773/stat : 19773 (aptitude) R 19772 19773 17863 34816 17863 4202496 14525 2212 0 0 143 4 0 1 20 0 2 0 28194900 111067136 10881 18446744073709551615 140126833291264 140126837598616 140734313592256 140734313580120 140126834120240 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19773/statm: 27116 10881 5151 1052 0 7700 0 [pid=19773/tid=19778] ppid=19772 vsize=108464 CPUtime=0.22 /proc/19773/task/19778/stat : 19778 (aptitude) S 19772 19773 17863 34816 17863 4202560 2415 2212 0 0 20 1 0 1 20 0 2 0 28194930 111067136 10881 18446744073709551615 140126833291264 140126837598616 140734313592256 140126749870080 140126802035412 0 134217728 4096 0 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.48 Current children cumulated vsize (KiB) 108464 Solver just ended. Dumping a history of the last processes samples [startup+1.50025 s] /proc/loadavg: 0.99 0.66 0.29 2/57 19779 /proc/meminfo: memFree=229748/1022884 swapFree=0/0 [pid=19773] ppid=19772 vsize=108464 CPUtime=1.48 /proc/19773/stat : 19773 (aptitude) R 19772 19773 17863 34816 17863 4202496 14525 2212 0 0 143 4 0 1 20 0 2 0 28194900 111067136 10881 18446744073709551615 140126833291264 140126837598616 140734313592256 140734313580120 140126834120240 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19773/statm: 27116 10881 5151 1052 0 7700 0 [pid=19773/tid=19778] ppid=19772 vsize=108464 CPUtime=0.22 /proc/19773/task/19778/stat : 19778 (aptitude) S 19772 19773 17863 34816 17863 4202560 2415 2212 0 0 20 1 0 1 20 0 2 0 28194930 111067136 10881 18446744073709551615 140126833291264 140126837598616 140734313592256 140126749870080 140126802035412 0 134217728 4096 0 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.48 Current children cumulated vsize (KiB) 108464 Child status: 0 Real time (s): 1.55042 CPU time (s): 1.5481 CPU user time (s): 1.46809 CPU system time (s): 0.080005 CPU usage (%): 99.85 Max. virtual memory (cumulated for all children) (KiB): 108464 getrusage(RUSAGE_CHILDREN,...) data: user time used= 1.46809 system time used= 0.080005 maximum resident set size= 43564 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 17476 page faults= 0 swaps= 0 block input operations= 0 block output operations= 16 messages sent= 0 messages received= 0 signals received= 0 voluntary context switches= 60 involuntary context switches= 79 runsolver used 0 second user time and 0.012 second system time The end