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/201012091704/p2cudf-user-1.10/rand4d6b1c.cudf.difficult.log.runsolver ./p2cudf-user-1.10 /home/misc2010/data/2010/difficult//rand4d6b1c.cudf /home/misc2010/tmp/201012091704/p2cudf-user-1.10/rand4d6b1c.cudf.difficult.result -changed,-notuptodate,-removed,-new 

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.04 0.99 0.99 3/39 5681
/proc/meminfo: memFree=391388/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) R 5679 5680 25521 34816 2180 4202496 360 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2572 CPUtime=0
/proc/5681/stat : 5681 (p2cudf-user-1.1) R 5680 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 40 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/5681/statm: 643 40 0 194 0 29 0

[startup+0.124647 s]
/proc/loadavg: 1.04 0.99 0.99 3/39 5681
/proc/meminfo: memFree=391388/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+0.204665 s]
/proc/loadavg: 1.04 0.99 0.99 3/39 5681
/proc/meminfo: memFree=391388/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+0.30468 s]
/proc/loadavg: 1.04 0.99 0.99 3/39 5681
/proc/meminfo: memFree=391388/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+0.704741 s]
/proc/loadavg: 1.04 0.99 0.99 3/39 5681
/proc/meminfo: memFree=391388/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+1.50487 s]
/proc/loadavg: 1.20 1.02 1.01 5/50 5703
/proc/meminfo: memFree=352876/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=874980 CPUtime=1.46
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 19427 0 1 0 140 6 0 0 25 0 10 0 901279319 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 218745 16726 1732 10 0 215835 0
[pid=5694/tid=5695] ppid=5681 vsize=874980 CPUtime=0.79
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 11094 0 1 0 77 2 0 0 25 0 10 0 901279320 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4095395081 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=874980 CPUtime=0
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 5 0 0 0 0 0 0 0 18 0 10 0 901279322 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=874980 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 9 0 0 0 0 0 0 0 25 0 10 0 901279322 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=874980 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 25 0 10 0 901279322 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=874980 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 10 0 901279325 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=874980 CPUtime=0.38
/proc/5694/task/5700/stat : 5700 (java) R 5681 5680 25521 34816 2180 4202560 6438 0 0 0 35 3 0 0 23 0 10 0 901279325 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4150199314 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=874980 CPUtime=0.28
/proc/5694/task/5701/stat : 5701 (java) R 5681 5680 25521 34816 2180 4202560 782 0 0 0 28 0 0 0 25 0 10 0 901279325 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4149091713 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=874980 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 10 0 901279325 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=874980 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 10 0 901279325 895979520 16726 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 880132

[startup+3.10477 s]
/proc/loadavg: 1.20 1.02 1.01 4/50 5703
/proc/meminfo: memFree=283852/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=896448 CPUtime=3.02
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 51855 0 1 0 278 24 0 0 25 0 10 0 901279319 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 224112 44673 1732 10 0 221202 0
[pid=5694/tid=5695] ppid=5681 vsize=896448 CPUtime=1.35
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 33380 0 1 0 118 17 0 0 25 0 10 0 901279320 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4095769100 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=896448 CPUtime=0
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 5 0 0 0 0 0 0 0 18 0 10 0 901279322 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=896448 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 9 0 0 0 0 0 0 0 25 0 10 0 901279322 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=896448 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 25 0 10 0 901279322 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=896448 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 10 0 901279325 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=896448 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 10 0 901279325 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=896448 CPUtime=0.84
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 5393 0 0 0 83 1 0 0 24 0 10 0 901279325 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=896448 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 10 0 901279325 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=896448 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 10 0 901279325 917962752 44673 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.05
Current children cumulated vsize (KiB) 901600

[startup+6.30632 s]
/proc/loadavg: 1.26 1.04 1.01 3/51 5704
/proc/meminfo: memFree=82504/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=893996 CPUtime=6.2
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 84560 0 1 0 581 39 0 0 25 0 11 0 901279319 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223499 74855 1792 10 0 220589 0
[pid=5694/tid=5695] ppid=5681 vsize=893996 CPUtime=2.51
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 50467 0 1 0 226 25 0 0 25 0 11 0 901279320 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4096630791 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=893996 CPUtime=0.32
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 13444 0 0 0 27 5 0 0 16 0 11 0 901279322 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=893996 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 11 0 901279325 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=893996 CPUtime=2.53
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7565 0 0 0 251 2 0 0 15 0 11 0 901279325 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 11 0 901279325 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 11 0 901279836 915451904 74855 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.23
Current children cumulated vsize (KiB) 899148

[startup+12.7081 s]
/proc/loadavg: 1.24 1.04 1.01 3/51 5704
/proc/meminfo: memFree=53868/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=893996 CPUtime=12.6
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92449 0 1 0 1217 43 0 0 25 0 11 0 901279319 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223499 82744 1793 10 0 220589 0
[pid=5694/tid=5695] ppid=5681 vsize=893996 CPUtime=8.16
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 50469 0 1 0 791 25 0 0 25 0 11 0 901279320 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4096439784 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=893996 CPUtime=0.88
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21303 0 0 0 80 8 0 0 16 0 11 0 901279322 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=893996 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 11 0 901279325 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=893996 CPUtime=2.73
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7593 0 0 0 269 4 0 0 16 0 11 0 901279325 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 11 0 901279325 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 11 0 901279836 915451904 82744 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.63
Current children cumulated vsize (KiB) 899148

[startup+25.5116 s]
/proc/loadavg: 1.19 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=893996 CPUtime=25.4
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92618 0 1 0 2497 43 0 0 25 0 11 0 901279319 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223499 82913 1793 10 0 220589 0
[pid=5694/tid=5695] ppid=5681 vsize=893996 CPUtime=20.68
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 50469 0 1 0 2043 25 0 0 25 0 11 0 901279320 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4096631292 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=893996 CPUtime=1.12
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21468 0 0 0 104 8 0 0 15 0 11 0 901279322 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=893996 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=893996 CPUtime=2.77
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7597 0 0 0 273 4 0 0 15 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 11 0 901279836 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.43
Current children cumulated vsize (KiB) 899148

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

[startup+31.9132 s]
/proc/loadavg: 1.17 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=893996 CPUtime=31.79
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92618 0 1 0 3136 43 0 0 25 0 11 0 901279319 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223499 82913 1793 10 0 220589 0
[pid=5694/tid=5695] ppid=5681 vsize=893996 CPUtime=26.81
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 50469 0 1 0 2656 25 0 0 25 0 11 0 901279320 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4096714900 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=893996 CPUtime=1.38
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21468 0 0 0 130 8 0 0 15 0 11 0 901279322 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=893996 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=893996 CPUtime=2.77
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7597 0 0 0 273 4 0 0 15 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 11 0 901279325 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 11 0 901279836 915451904 82913 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 31.82
Current children cumulated vsize (KiB) 899148

[startup+38.305 s]
/proc/loadavg: 1.16 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=893996 CPUtime=38.19
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92620 0 1 0 3776 43 0 0 25 0 11 0 901279319 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223499 82915 1793 10 0 220589 0
[pid=5694/tid=5695] ppid=5681 vsize=893996 CPUtime=32.93
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 50469 0 1 0 3268 25 0 0 25 0 11 0 901279320 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4096692524 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=893996 CPUtime=1.62
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21468 0 0 0 154 8 0 0 15 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=893996 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=893996 CPUtime=2.8
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7599 0 0 0 276 4 0 0 16 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 11 0 901279836 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 38.22
Current children cumulated vsize (KiB) 899148

[startup+39.9055 s]
/proc/loadavg: 1.16 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=893996 CPUtime=39.79
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92620 0 1 0 3936 43 0 0 25 0 11 0 901279319 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223499 82915 1793 10 0 220589 0
[pid=5694/tid=5695] ppid=5681 vsize=893996 CPUtime=34.53
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 50469 0 1 0 3428 25 0 0 25 0 11 0 901279320 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4096714993 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=893996 CPUtime=1.62
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21468 0 0 0 154 8 0 0 15 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=893996 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=893996 CPUtime=2.8
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7599 0 0 0 276 4 0 0 16 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 11 0 901279836 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 39.82
Current children cumulated vsize (KiB) 899148

[startup+41.506 s]
/proc/loadavg: 1.15 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=893996 CPUtime=41.39
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92620 0 1 0 4096 43 0 0 25 0 11 0 901279319 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223499 82915 1793 10 0 220589 0
[pid=5694/tid=5695] ppid=5681 vsize=893996 CPUtime=36.13
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4202560 50469 0 1 0 3588 25 0 0 25 0 11 0 901279320 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4095697014 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=893996 CPUtime=1.62
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21468 0 0 0 154 8 0 0 15 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 11 0 901279322 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=893996 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=893996 CPUtime=2.8
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7599 0 0 0 276 4 0 0 16 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 11 0 901279325 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=893996 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 11 0 901279836 915451904 82915 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 41.42
Current children cumulated vsize (KiB) 899148

[startup+42.3072 s]
/proc/loadavg: 1.15 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=894320 CPUtime=41.89
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92636 0 1 0 4146 43 0 0 25 0 12 0 901279319 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223580 82931 1793 10 0 220670 0
[pid=5694/tid=5695] ppid=5681 vsize=894320 CPUtime=36.6
/proc/5694/task/5695/stat : 5695 (java) S 5681 5680 25521 34816 2180 4202560 50476 0 1 0 3635 25 0 0 25 0 12 0 901279320 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=894320 CPUtime=1.62
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21468 0 0 0 154 8 0 0 15 0 12 0 901279322 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 12 0 901279322 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 12 0 901279322 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=894320 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=894320 CPUtime=2.83
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7604 0 0 0 279 4 0 0 16 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 12 0 901279836 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 41.92
Current children cumulated vsize (KiB) 899472

[startup+42.5073 s]
/proc/loadavg: 1.15 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=894320 CPUtime=41.89
/proc/5694/stat : 5694 (java) S 5681 5680 25521 34816 2180 4202496 92636 0 1 0 4146 43 0 0 25 0 12 0 901279319 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 223580 82931 1793 10 0 220670 0
[pid=5694/tid=5695] ppid=5681 vsize=894320 CPUtime=36.6
/proc/5694/task/5695/stat : 5695 (java) S 5681 5680 25521 34816 2180 4202560 50476 0 1 0 3635 25 0 0 25 0 12 0 901279320 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5696] ppid=5681 vsize=894320 CPUtime=1.62
/proc/5694/task/5696/stat : 5696 (java) S 5681 5680 25521 34816 2180 4202560 21468 0 0 0 154 8 0 0 15 0 12 0 901279322 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5697] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5697/stat : 5697 (java) S 5681 5680 25521 34816 2180 4202560 10 0 0 0 0 0 0 0 18 0 12 0 901279322 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5698] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5698/stat : 5698 (java) S 5681 5680 25521 34816 2180 4202560 6 0 0 0 0 0 0 0 18 0 12 0 901279322 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5699] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5699/stat : 5699 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 25 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5700] ppid=5681 vsize=894320 CPUtime=0.81
/proc/5694/task/5700/stat : 5700 (java) S 5681 5680 25521 34816 2180 4202560 11969 0 0 0 76 5 0 0 25 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5701] ppid=5681 vsize=894320 CPUtime=2.83
/proc/5694/task/5701/stat : 5701 (java) S 5681 5680 25521 34816 2180 4202560 7604 0 0 0 279 4 0 0 16 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5702] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5702/stat : 5702 (java) S 5681 5680 25521 34816 2180 4202560 0 0 0 0 0 0 0 0 25 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5703] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5703/stat : 5703 (java) S 5681 5680 25521 34816 2180 4202560 1 0 0 0 0 0 0 0 15 0 12 0 901279325 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
[pid=5694/tid=5704] ppid=5681 vsize=894320 CPUtime=0
/proc/5694/task/5704/stat : 5704 (java) S 5681 5680 25521 34816 2180 4202560 4 0 0 0 0 0 0 0 24 0 12 0 901279836 915783680 82931 1283457024 134512640 134550932 4292650640 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920896 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 41.92
Current children cumulated vsize (KiB) 899472

[startup+42.6134 s]
/proc/loadavg: 1.15 1.03 1.01 2/51 5704
/proc/meminfo: memFree=52752/1048576 swapFree=2095372/2097144
[pid=5680] ppid=5679 vsize=2572 CPUtime=0
/proc/5680/stat : 5680 (p2cudf-user-1.1) S 5679 5680 25521 34816 2180 4202496 379 0 0 0 0 0 0 0 25 0 1 0 901279316 2633728 273 1283457024 134512640 135304128 4287234704 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5680/statm: 643 273 233 194 0 29 0
[pid=5681] ppid=5680 vsize=2580 CPUtime=0.03
/proc/5681/stat : 5681 (p2cudf) S 5680 5680 25521 34816 2180 4202496 395 2990 0 1 0 0 2 1 25 0 1 0 901279316 2641920 283 1283457024 134512640 135304128 4289320128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/5681/statm: 645 283 241 194 0 31 0
[pid=5694] ppid=5681 vsize=0 CPUtime=41.97
/proc/5694/stat : 5694 (java) Z 5681 5680 25521 34816 2180 4203532 92641 0 1 0 4150 47 0 0 18 0 2 0 901279319 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/5694/statm: 0 0 0 0 0 0 0
[pid=5694/tid=5695] ppid=5681 vsize=0 CPUtime=36.63
/proc/5694/task/5695/stat : 5695 (java) R 5681 5680 25521 34816 2180 4203588 50477 0 1 0 3635 28 0 0 20 0 2 0 901279320 0 0 1283457024 0 0 0 0 0 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 42
Current children cumulated vsize (KiB) 5152

Child status: 0
Real time (s): 42.6174
CPU time (s): 42.0146
CPU user time (s): 41.5226
CPU system time (s): 0.49203
CPU usage (%): 98.5857
Max. virtual memory (cumulated for all children) (KiB): 906952

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 41.5226
system time used= 0.49203
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 96423
page faults= 2
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 1491
involuntary context switches= 1872

runsolver used 0 second user time and 0.004 second system time

The end