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: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201012061533/gj-paranoid-solver-0.1/8ad21cec-4b22-11df-b280-00163e7a6f5e.cudf.debian-dudf.log.runsolver ./gj-paranoid-solver-0.1 /home/misc2010/data/2010/debian-dudf//8ad21cec-4b22-11df-b280-00163e7a6f5e.cudf /home/misc2010/tmp/201012061533/gj-paranoid-solver-0.1/8ad21cec-4b22-11df-b280-00163e7a6f5e.cudf.debian-dudf.result 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 290 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 320 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: 1.41 1.29 1.21 3/46 29572
/proc/meminfo: memFree=642588/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) R 29570 29571 2059 34821 2220 4202496 359 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 272 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/29571/statm: 643 272 231 194 0 29 0
[pid=29572] ppid=29571 vsize=2572 CPUtime=0
/proc/29572/stat : 29572 (gj-paranoid-sol) R 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 41 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/29572/statm: 643 41 0 194 0 29 0

[startup+0.189892 s]
/proc/loadavg: 1.41 1.29 1.21 3/46 29572
/proc/meminfo: memFree=642588/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=409996 CPUtime=0.18
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 4494 0 1 0 15 3 0 0 25 0 9 0 876514750 419835904 3958 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 102499 3958 1875 10 0 96679 0
Current children cumulated CPU time (s) 0.18
Current children cumulated vsize (KiB) 412568

[startup+0.209911 s]
/proc/loadavg: 1.41 1.29 1.21 3/46 29572
/proc/meminfo: memFree=642588/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=410140 CPUtime=0.2
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 5106 0 1 0 17 3 0 0 25 0 9 0 876514750 419983360 4570 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 102535 4570 1880 10 0 96715 0
Current children cumulated CPU time (s) 0.2
Current children cumulated vsize (KiB) 412712

[startup+0.309903 s]
/proc/loadavg: 1.41 1.29 1.21 3/46 29572
/proc/meminfo: memFree=642588/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=410140 CPUtime=0.3
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 5197 0 1 0 27 3 0 0 25 0 9 0 876514750 419983360 4660 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 102535 4660 1883 10 0 96715 0
Current children cumulated CPU time (s) 0.3
Current children cumulated vsize (KiB) 412712

[startup+0.709997 s]
/proc/loadavg: 1.41 1.29 1.21 3/46 29572
/proc/meminfo: memFree=642588/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=410740 CPUtime=0.7
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 13091 0 1 0 64 6 0 0 25 0 9 0 876514750 420597760 12376 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 102685 12376 2879 10 0 96865 0
Current children cumulated CPU time (s) 0.7
Current children cumulated vsize (KiB) 413312

[startup+1.5101 s]
/proc/loadavg: 1.54 1.32 1.22 2/55 29581
/proc/meminfo: memFree=580084/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=410740 CPUtime=1.51
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 29330 0 1 0 139 12 0 0 25 0 9 0 876514750 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 102685 28615 2879 10 0 96865 0
[pid=29572/tid=29574] ppid=29571 vsize=410740 CPUtime=0.7
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 6930 0 1 0 67 3 0 0 25 0 9 0 876514751 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=410740 CPUtime=0.76
/proc/29572/task/29575/stat : 29575 (java) R 29571 29571 2059 34821 2220 4202560 21012 0 0 0 68 8 0 0 20 0 9 0 876514752 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4151001586 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=410740 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 20 0 9 0 876514752 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=410740 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 24 0 9 0 876514752 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=410740 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 9 0 876514753 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=410740 CPUtime=0.03
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 455 0 0 0 3 0 0 0 18 0 9 0 876514753 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=410740 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 9 0 876514753 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=410740 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 9 0 876514753 420597760 28615 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.51
Current children cumulated vsize (KiB) 413312

[startup+3.1104 s]
/proc/loadavg: 1.54 1.32 1.22 2/55 29581
/proc/meminfo: memFree=499484/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=410872 CPUtime=3.11
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 52370 0 1 0 285 26 0 0 25 0 9 0 876514750 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 102718 51655 2879 10 0 96898 0
[pid=29572/tid=29574] ppid=29571 vsize=410872 CPUtime=1.24
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13810 0 1 0 117 7 0 0 25 0 9 0 876514751 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=410872 CPUtime=1.81
/proc/29572/task/29575/stat : 29575 (java) R 29571 29571 2059 34821 2220 4202560 37168 0 0 0 163 18 0 0 16 0 9 0 876514752 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4150622029 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=410872 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 20 0 9 0 876514752 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=410872 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 24 0 9 0 876514752 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=410872 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 9 0 876514753 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=410872 CPUtime=0.04
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 459 0 0 0 4 0 0 0 15 0 9 0 876514753 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=410872 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 9 0 876514753 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=410872 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 9 0 876514753 420732928 51655 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.11
Current children cumulated vsize (KiB) 413444

[startup+6.31129 s]
/proc/loadavg: 1.50 1.31 1.22 3/55 29581
/proc/meminfo: memFree=369904/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=433180 CPUtime=6.28
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 76509 0 1 0 596 32 0 0 25 0 9 0 876514750 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 108295 75776 2880 10 0 102475 0
[pid=29572/tid=29574] ppid=29571 vsize=433180 CPUtime=1.95
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13896 0 1 0 188 7 0 0 25 0 9 0 876514751 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=433180 CPUtime=4.25
/proc/29572/task/29575/stat : 29575 (java) R 29571 29571 2059 34821 2220 4202560 61192 0 0 0 400 25 0 0 16 0 9 0 876514752 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4152112838 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 18 0 9 0 876514752 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 9 0 876514752 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=433180 CPUtime=0.08
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 488 0 0 0 8 0 0 0 15 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.28
Current children cumulated vsize (KiB) 435752

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

[startup+6.41132 s]
/proc/loadavg: 1.50 1.31 1.22 3/55 29581
/proc/meminfo: memFree=369904/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=433180 CPUtime=6.38
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 76509 0 1 0 606 32 0 0 25 0 9 0 876514750 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 108295 75776 2880 10 0 102475 0
[pid=29572/tid=29574] ppid=29571 vsize=433180 CPUtime=1.95
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13896 0 1 0 188 7 0 0 25 0 9 0 876514751 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=433180 CPUtime=4.35
/proc/29572/task/29575/stat : 29575 (java) R 29571 29571 2059 34821 2220 4202560 61192 0 0 0 410 25 0 0 16 0 9 0 876514752 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4152112794 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 18 0 9 0 876514752 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 9 0 876514752 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=433180 CPUtime=0.08
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 488 0 0 0 8 0 0 0 15 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=433180 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 9 0 876514753 443576320 75776 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.38
Current children cumulated vsize (KiB) 435752

[startup+9.60221 s]
/proc/loadavg: 1.50 1.31 1.22 2/56 29582
/proc/meminfo: memFree=370516/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=432884 CPUtime=9.57
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 86731 0 1 0 918 39 0 0 25 0 10 0 876514750 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 108221 75709 2882 10 0 102401 0
[pid=29572/tid=29574] ppid=29571 vsize=432884 CPUtime=3.45
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13917 0 1 0 338 7 0 0 25 0 10 0 876514751 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=432884 CPUtime=6
/proc/29572/task/29575/stat : 29575 (java) R 29571 29571 2059 34821 2220 4202560 71346 0 0 0 568 32 0 0 16 0 10 0 876514752 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4152292024 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=432884 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 18 0 10 0 876514752 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=432884 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 10 0 876514752 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=432884 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876514753 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=432884 CPUtime=0.11
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 530 0 0 0 11 0 0 0 15 0 10 0 876514753 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=432884 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 10 0 876514753 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=432884 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 10 0 876514753 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29582] ppid=29571 vsize=432884 CPUtime=0
/proc/29572/task/29582/stat : 29582 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 25 0 10 0 876515524 443273216 75709 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 9.57
Current children cumulated vsize (KiB) 435456

[startup+11.2027 s]
/proc/loadavg: 1.46 1.31 1.21 2/56 29582
/proc/meminfo: memFree=370144/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=412280 CPUtime=11.17
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 86732 0 1 0 1077 40 0 0 25 0 10 0 876514750 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 103070 70568 2882 10 0 97250 0
[pid=29572/tid=29574] ppid=29571 vsize=412280 CPUtime=4.77
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13917 0 1 0 470 7 0 0 25 0 10 0 876514751 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4115160141 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=412280 CPUtime=6.29
/proc/29572/task/29575/stat : 29575 (java) S 29571 29571 2059 34821 2220 4202560 71346 0 0 0 596 33 0 0 16 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 18 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=412280 CPUtime=0.11
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 531 0 0 0 11 0 0 0 15 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29582] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29582/stat : 29582 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 25 0 10 0 876515524 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.17
Current children cumulated vsize (KiB) 414852

[startup+12.0029 s]
/proc/loadavg: 1.46 1.31 1.21 2/56 29582
/proc/meminfo: memFree=370144/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=412280 CPUtime=11.98
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 86732 0 1 0 1158 40 0 0 25 0 10 0 876514750 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 103070 70568 2882 10 0 97250 0
[pid=29572/tid=29574] ppid=29571 vsize=412280 CPUtime=5.57
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13917 0 1 0 550 7 0 0 25 0 10 0 876514751 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4115287221 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=412280 CPUtime=6.29
/proc/29572/task/29575/stat : 29575 (java) S 29571 29571 2059 34821 2220 4202560 71346 0 0 0 596 33 0 0 15 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 18 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=412280 CPUtime=0.11
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 531 0 0 0 11 0 0 0 16 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29582] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29582/stat : 29582 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 25 0 10 0 876515524 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.98
Current children cumulated vsize (KiB) 414852

[startup+12.403 s]
/proc/loadavg: 1.46 1.31 1.21 3/56 29582
/proc/meminfo: memFree=370144/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=412280 CPUtime=12.38
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 86732 0 1 0 1198 40 0 0 25 0 10 0 876514750 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 103070 70568 2882 10 0 97250 0
[pid=29572/tid=29574] ppid=29571 vsize=412280 CPUtime=5.97
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13917 0 1 0 590 7 0 0 25 0 10 0 876514751 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4115286748 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=412280 CPUtime=6.29
/proc/29572/task/29575/stat : 29575 (java) S 29571 29571 2059 34821 2220 4202560 71346 0 0 0 596 33 0 0 15 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 18 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 10 0 876514752 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=412280 CPUtime=0.11
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 531 0 0 0 11 0 0 0 16 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 10 0 876514753 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29582] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29582/stat : 29582 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 25 0 10 0 876515524 422174720 70568 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.38
Current children cumulated vsize (KiB) 414852

[startup+12.6031 s]
/proc/loadavg: 1.46 1.31 1.21 3/56 29582
/proc/meminfo: memFree=370144/1048576 swapFree=2078744/2097144
[pid=29571] ppid=29570 vsize=2572 CPUtime=0
/proc/29571/stat : 29571 (gj-paranoid-sol) S 29570 29571 2059 34821 2220 4202496 376 0 0 0 0 0 0 0 25 0 1 0 876514750 2633728 273 1283457024 134512640 135304128 4292679600 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/29571/statm: 643 273 232 194 0 29 0
[pid=29572] ppid=29571 vsize=412280 CPUtime=12.58
/proc/29572/stat : 29572 (java) S 29571 29571 2059 34821 2220 4202496 86738 0 1 0 1218 40 0 0 25 0 9 0 876514750 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/29572/statm: 103070 70574 2883 10 0 97250 0
[pid=29572/tid=29574] ppid=29571 vsize=412280 CPUtime=6.17
/proc/29572/task/29574/stat : 29574 (java) R 29571 29571 2059 34821 2220 4202560 13921 0 1 0 610 7 0 0 25 0 9 0 876514751 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4114417990 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=29572/tid=29575] ppid=29571 vsize=412280 CPUtime=6.29
/proc/29572/task/29575/stat : 29575 (java) S 29571 29571 2059 34821 2220 4202560 71346 0 0 0 596 33 0 0 15 0 9 0 876514752 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29576] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29576/stat : 29576 (java) S 29571 29571 2059 34821 2220 4202560 18 0 0 0 0 0 0 0 18 0 9 0 876514752 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29577] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29577/stat : 29577 (java) S 29571 29571 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 9 0 876514752 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29578] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29578/stat : 29578 (java) S 29571 29571 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 9 0 876514753 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29579] ppid=29571 vsize=412280 CPUtime=0.11
/proc/29572/task/29579/stat : 29579 (java) S 29571 29571 2059 34821 2220 4202560 533 0 0 0 11 0 0 0 15 0 9 0 876514753 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29580] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29580/stat : 29580 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 9 0 876514753 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
[pid=29572/tid=29581] ppid=29571 vsize=412280 CPUtime=0
/proc/29572/task/29581/stat : 29581 (java) S 29571 29571 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 15 0 9 0 876514753 422174720 70574 1283457024 134512640 134550932 4291687952 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.58
Current children cumulated vsize (KiB) 414852

Child status: 0
Real time (s): 12.6648
CPU time (s): 12.5968
CPU user time (s): 12.1808
CPU system time (s): 0.416026
CPU usage (%): 99.463
Max. virtual memory (cumulated for all children) (KiB): 435752

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 12.1808
system time used= 0.416026
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 87139
page faults= 1
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 907
involuntary context switches= 1028

runsolver used 0 second user time and 0 second system time

The end