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/90.runsolver.aptitude aptitude -s -y --without-recommends install wmtemp php3-cgi-mysql xbindkeys openoffice.org-l10n-zh-tw itcl3.1 

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.76 0.37 2/55 20025
/proc/meminfo: memFree=243688/1022884 swapFree=0/0
[pid=20025] ppid=20024 vsize=3152 CPUtime=0
/proc/20025/stat : 20025 (runsolver) R 20024 17863 17863 34816 17863 4202560 0 0 0 0 0 0 0 0 20 0 1 0 28206212 3227648 32 18446744073709551615 134512640 134586868 4288606896 4288604944 4152149040 0 0 0 24578 0 0 0 17 0 0 0 0 0 0
/proc/20025/statm: 788 32 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.152405 s]
/proc/loadavg: 0.99 0.76 0.37 2/55 20025
/proc/meminfo: memFree=243688/1022884 swapFree=0/0
[pid=20025] ppid=20024 vsize=86100 CPUtime=0.14
/proc/20025/stat : 20025 (aptitude) R 20024 20025 17863 34816 17863 4202496 7108 1708 0 0 12 2 0 0 20 0 1 0 28206212 88166400 6899 18446744073709551615 139972019777536 139972024084888 140734026267024 140734026258672 139972021928512 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0
/proc/20025/statm: 21525 6899 4711 1052 0 2116 0
Current children cumulated CPU time (s) 0.14
Current children cumulated vsize (KiB) 86100

[startup+0.200293 s]
/proc/loadavg: 0.99 0.76 0.37 2/55 20025
/proc/meminfo: memFree=243688/1022884 swapFree=0/0
[pid=20025] ppid=20024 vsize=87812 CPUtime=0.19
/proc/20025/stat : 20025 (aptitude) R 20024 20025 17863 34816 17863 4202496 7740 1708 0 0 17 2 0 0 20 0 1 0 28206212 89919488 7170 18446744073709551615 139972019777536 139972024084888 140734026267024 140734026256536 139972020833428 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0
/proc/20025/statm: 21953 7170 4721 1052 0 2544 0
Current children cumulated CPU time (s) 0.19
Current children cumulated vsize (KiB) 87812

[startup+0.300268 s]
/proc/loadavg: 0.99 0.76 0.37 2/55 20025
/proc/meminfo: memFree=243688/1022884 swapFree=0/0
[pid=20025] ppid=20024 vsize=90632 CPUtime=0.28
/proc/20025/stat : 20025 (aptitude) R 20024 20025 17863 34816 17863 4202496 8629 1708 0 0 26 2 0 0 20 0 1 0 28206212 92807168 7674 18446744073709551615 139972019777536 139972024084888 140734026267024 140734026256456 139972014677894 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0
/proc/20025/statm: 22658 7674 4725 1052 0 3249 0
Current children cumulated CPU time (s) 0.28
Current children cumulated vsize (KiB) 90632

[startup+0.700219 s]
/proc/loadavg: 0.99 0.76 0.37 2/55 20025
/proc/meminfo: memFree=243688/1022884 swapFree=0/0
[pid=20025] ppid=20024 vsize=100600 CPUtime=0.68
/proc/20025/stat : 20025 (aptitude) R 20024 20025 17863 34816 17863 4202496 10118 1708 0 0 65 3 0 0 20 0 2 0 28206212 103014400 8746 18446744073709551615 139972019777536 139972024084888 140734026267024 140734026254184 139971977287776 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/20025/statm: 25150 8746 4995 1052 0 5741 0
Current children cumulated CPU time (s) 0.68
Current children cumulated vsize (KiB) 100600

[startup+1.50025 s]
/proc/loadavg: 0.99 0.76 0.37 2/57 20031
/proc/meminfo: memFree=227924/1022884 swapFree=0/0
[pid=20025] ppid=20024 vsize=87420 CPUtime=1.48
/proc/20025/stat : 20025 (aptitude) R 20024 20025 17863 34816 17863 4202496 14007 2712 0 0 141 6 0 1 20 0 1 0 28206212 89518080 5621 18446744073709551615 139972019777536 139972024084888 140734026267024 140734026264104 139972021953056 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0
/proc/20025/statm: 21855 5621 1495 1052 0 6111 0
Current children cumulated CPU time (s) 1.48
Current children cumulated vsize (KiB) 87420

Solver just ended. Dumping a history of the last processes samples

[startup+1.50025 s]
/proc/loadavg: 0.99 0.76 0.37 2/57 20031
/proc/meminfo: memFree=227924/1022884 swapFree=0/0
[pid=20025] ppid=20024 vsize=87420 CPUtime=1.48
/proc/20025/stat : 20025 (aptitude) R 20024 20025 17863 34816 17863 4202496 14007 2712 0 0 141 6 0 1 20 0 1 0 28206212 89518080 5621 18446744073709551615 139972019777536 139972024084888 140734026267024 140734026264104 139972021953056 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0
/proc/20025/statm: 21855 5621 1495 1052 0 6111 0
Current children cumulated CPU time (s) 1.48
Current children cumulated vsize (KiB) 87420

Child status: 0
Real time (s): 1.50594
CPU time (s): 1.50409
CPU user time (s): 1.42409
CPU system time (s): 0.080005
CPU usage (%): 99.8772
Max. virtual memory (cumulated for all children) (KiB): 105748

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 1.42409
system time used= 0.080005
maximum resident set size= 40760
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 16813
page faults= 0
swaps= 0
block input operations= 0
block output operations= 8
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 60
involuntary context switches= 74

runsolver used 0.012 second user time and 0 second system time

The end