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/52.runsolver.aptitude aptitude -s -y --without-recommends install libsqlrelay-ruby python-biopython-martel mird1 med-imaging libginac-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 Current StackSize limit: 8192 KiB [startup+0 s] /proc/loadavg: 0.99 0.61 0.26 2/55 19684 /proc/meminfo: memFree=246280/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=54860 CPUtime=0 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 588 0 0 0 0 0 0 0 20 0 1 0 28190926 56176640 487 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473296696 139807318668072 0 0 0 0 0 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 13715 487 398 1052 0 73 0 [startup+0.116224 s] /proc/loadavg: 0.99 0.61 0.26 2/55 19684 /proc/meminfo: memFree=246280/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=80316 CPUtime=0.1 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 5568 1710 0 0 9 1 0 0 20 0 1 0 28190926 82243584 5366 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473288752 139807315707467 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 20079 5366 4643 1052 0 670 0 Current children cumulated CPU time (s) 0.1 Current children cumulated vsize (KiB) 80316 [startup+0.200292 s] /proc/loadavg: 0.99 0.61 0.26 2/55 19684 /proc/meminfo: memFree=246280/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=87044 CPUtime=0.19 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 7480 1710 0 0 17 2 0 0 20 0 1 0 28190926 89133056 7101 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473287000 139807323791217 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 21761 7101 4721 1052 0 2352 0 Current children cumulated CPU time (s) 0.19 Current children cumulated vsize (KiB) 87044 [startup+0.300275 s] /proc/loadavg: 0.99 0.61 0.26 2/55 19684 /proc/meminfo: memFree=246280/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=90632 CPUtime=0.29 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 8631 1710 0 0 25 4 0 0 20 0 1 0 28190926 92807168 7674 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473286920 139807323792061 0 134217728 4096 0 0 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 22658 7674 4725 1052 0 3249 0 Current children cumulated CPU time (s) 0.29 Current children cumulated vsize (KiB) 90632 [startup+0.700216 s] /proc/loadavg: 0.99 0.61 0.26 2/55 19684 /proc/meminfo: memFree=246280/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=100688 CPUtime=0.68 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 10141 1710 0 0 64 4 0 0 20 0 2 0 28190926 103104512 8769 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473284360 139807287180224 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 25172 8769 4994 1052 0 5763 0 Current children cumulated CPU time (s) 0.68 Current children cumulated vsize (KiB) 100688 Solver just ended. Dumping a history of the last processes samples [startup+0.800294 s] /proc/loadavg: 0.99 0.61 0.26 2/55 19684 /proc/meminfo: memFree=246280/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=100688 CPUtime=0.78 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 10153 1710 0 0 74 4 0 0 20 0 2 0 28190926 103104512 8781 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473291736 139807323073191 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 25172 8781 5002 1052 0 5763 0 Current children cumulated CPU time (s) 0.78 Current children cumulated vsize (KiB) 100688 [startup+1.2033 s] /proc/loadavg: 0.99 0.61 0.26 2/57 19690 /proc/meminfo: memFree=230640/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=101384 CPUtime=1.18 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 10652 2209 0 0 113 5 0 0 20 0 2 0 28190926 103817216 8847 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473284304 139807287179488 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 25346 8847 5046 1052 0 5937 0 [pid=19684/tid=19689] ppid=19683 vsize=101384 CPUtime=0 /proc/19684/task/19689/stat : 19689 (aptitude) S 19683 19684 17863 34816 17863 4202560 6 2209 0 0 0 0 0 0 20 0 2 0 28190957 103817216 8847 18446744073709551615 139807320866816 139807325174168 140736473297488 139807237445632 139807289610964 0 134217728 4096 0 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.18 Current children cumulated vsize (KiB) 101384 [startup+1.40025 s] /proc/loadavg: 0.99 0.61 0.26 2/57 19690 /proc/meminfo: memFree=230640/1022884 swapFree=0/0 [pid=19684] ppid=19683 vsize=105240 CPUtime=1.38 /proc/19684/stat : 19684 (aptitude) R 19683 19684 17863 34816 17863 4202496 13250 2209 0 0 132 6 0 0 20 0 2 0 28190926 107765760 10067 18446744073709551615 139807320866816 139807325174168 140736473297488 140736473289560 139807315764536 0 134217728 4096 0 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/19684/statm: 26310 10067 5149 1052 0 6894 0 [pid=19684/tid=19689] ppid=19683 vsize=105240 CPUtime=0.09 /proc/19684/task/19689/stat : 19689 (aptitude) S 19683 19684 17863 34816 17863 4202560 1209 2209 0 0 9 0 0 0 20 0 2 0 28190957 107765760 10067 18446744073709551615 139807320866816 139807325174168 140736473297488 139807237445632 139807289610964 0 134217728 4096 0 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.38 Current children cumulated vsize (KiB) 105240 Child status: 0 Real time (s): 1.444 CPU time (s): 1.44009 CPU user time (s): 1.36408 CPU system time (s): 0.076004 CPU usage (%): 99.7292 Max. virtual memory (cumulated for all children) (KiB): 105240 getrusage(RUSAGE_CHILDREN,...) data: user time used= 1.36408 system time used= 0.076004 maximum resident set size= 40280 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 16208 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= 72 runsolver used 0 second user time and 0.012 second system time The end