runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

This program is distributed in the hope that it will be useful,
but WITHOUT ANY WARRANTY; without even the implied warranty of
MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
GNU General Public License for more details.

command line: runsolver -s SIGUSR1 -M 1124 -C 300 -d 10 -w /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/install/rand83.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/install/rand83.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/slowlink/install/rand83.cudf.result -sum(changed,installedsize),-count(removed),-notuptodate(solution),-count(changed) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 300 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 330 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.03 1.03 1.00 2/59 22292
/proc/meminfo: memFree=652536/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 424 0 0 0 0 0 0 0 20 0 1 0 120790599 9388032 325 18446744073709551615 4194304 5129932 140734034062736 140734034060408 140716407392032 0 0 16781316 65536 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 325 275 229 0 52 0

[startup+0.179706 s]
/proc/loadavg: 1.03 1.03 1.00 2/59 22292
/proc/meminfo: memFree=652536/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200318 s]
/proc/loadavg: 1.03 1.03 1.00 2/59 22292
/proc/meminfo: memFree=652536/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300309 s]
/proc/loadavg: 1.03 1.03 1.00 2/59 22292
/proc/meminfo: memFree=652536/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700222 s]
/proc/loadavg: 1.03 1.03 1.00 2/59 22292
/proc/meminfo: memFree=652536/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50074 s]
/proc/loadavg: 1.03 1.03 1.00 4/70 22304
/proc/meminfo: memFree=596888/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1049364 CPUtime=1.46
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 34442 0 0 0 129 17 0 0 20 0 10 0 120790599 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 262341 30533 2346 9 0 249691 0
[pid=22295/tid=22296] ppid=22292 vsize=1049364 CPUtime=0.65
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 14904 0 0 0 58 7 0 0 20 0 10 0 120790600 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646197723808 140646095221854 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1049364 CPUtime=0
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 120790602 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1049364 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 120790602 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1049364 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 120790602 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1049364 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120790605 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1049364 CPUtime=0.38
/proc/22295/task/22301/stat : 22301 (java) R 22292 22292 1750 0 -1 4202560 9494 0 0 0 34 4 0 0 20 0 10 0 120790605 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646086147224 140646174786761 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1049364 CPUtime=0.4
/proc/22295/task/22302/stat : 22302 (java) R 22292 22292 1750 0 -1 4202560 8753 0 0 0 36 4 0 0 20 0 10 0 120790605 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646085094504 140646175472424 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1049364 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120790605 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1049364 CPUtime=0
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120790605 1074548736 30533 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.46
Current children cumulated vsize (KiB) 1058532

[startup+3.10078 s]
/proc/loadavg: 1.03 1.03 1.00 4/70 22304
/proc/meminfo: memFree=499796/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1049572 CPUtime=3.04
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 76084 0 0 0 274 30 0 0 20 0 10 0 120790599 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 262393 70947 2366 9 0 249743 0
[pid=22295/tid=22296] ppid=22292 vsize=1049572 CPUtime=1.53
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47419 0 0 0 135 18 0 0 20 0 10 0 120790600 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646197723840 140646095724209 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1049572 CPUtime=0.16
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 7952 0 0 0 14 2 0 0 20 0 10 0 120790602 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1049572 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120790602 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1049572 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120790602 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1049572 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120790605 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1049572 CPUtime=0.65
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10195 0 0 0 60 5 0 0 20 0 10 0 120790605 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1049572 CPUtime=0.67
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9227 0 0 0 63 4 0 0 20 0 10 0 120790605 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1049572 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120790605 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1049572 CPUtime=0
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120790605 1074761728 70947 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.04
Current children cumulated vsize (KiB) 1058740

[startup+6.3008 s]
/proc/loadavg: 1.02 1.03 1.00 2/70 22304
/proc/meminfo: memFree=208272/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1046716 CPUtime=6.18
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 123703 0 0 0 567 51 0 0 20 0 10 0 120790599 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261679 117930 2368 9 0 249029 0
[pid=22295/tid=22296] ppid=22292 vsize=1046716 CPUtime=3.3
/proc/22295/task/22296/stat : 22296 (java) S 22292 22292 1750 0 -1 4202560 47421 0 0 0 308 22 0 0 20 0 10 0 120790600 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646197731808 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1046716 CPUtime=1.45
/proc/22295/task/22297/stat : 22297 (java) R 22292 22292 1750 0 -1 4202560 55562 0 0 0 126 19 0 0 20 0 10 0 120790602 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646090369552 140646175321385 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1046716 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 120790602 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1046716 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 120790602 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1046716 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120790605 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1046716 CPUtime=0.68
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10195 0 0 0 63 5 0 0 20 0 10 0 120790605 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1046716 CPUtime=0.72
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9233 0 0 0 67 5 0 0 20 0 10 0 120790605 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1046716 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 120790605 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1046716 CPUtime=0
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 120790605 1071837184 117930 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.18
Current children cumulated vsize (KiB) 1055884

[startup+12.7009 s]
/proc/loadavg: 1.18 1.06 1.01 2/71 22305
/proc/meminfo: memFree=38756/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=12.48
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 152625 0 0 0 1186 62 0 0 20 0 11 0 120790599 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 146852 2381 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=6.5
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47805 0 0 0 626 24 0 0 20 0 11 0 120790600 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646197723040 140646095240960 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=2.21
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 83891 0 0 0 193 28 0 0 20 0 11 0 120790602 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=1.8
/proc/22295/task/22301/stat : 22301 (java) R 22292 22292 1750 0 -1 4202560 10300 0 0 0 175 5 0 0 20 0 11 0 120790605 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646086159120 140646178534531 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=1.95
/proc/22295/task/22302/stat : 22302 (java) R 22292 22292 1750 0 -1 4202560 9331 0 0 0 190 5 0 0 20 0 11 0 120790605 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646085106448 140646175502192 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 146852 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.48
Current children cumulated vsize (KiB) 1056912

[startup+25.5009 s]
/proc/loadavg: 1.14 1.06 1.01 2/71 22305
/proc/meminfo: memFree=10240/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=25.08
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 160965 0 0 0 2443 65 0 0 20 0 11 0 120790599 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 155192 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=16.23
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 1599 24 0 0 20 0 11 0 120790600 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646197729512 140646096493053 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=4.53
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 92188 0 0 0 422 31 0 0 20 0 11 0 120790602 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.21
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 216 5 0 0 20 0 11 0 120790605 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.08
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 203 5 0 0 20 0 11 0 120790605 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.01
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 1 0 0 0 20 0 11 0 120790605 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 155192 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.08
Current children cumulated vsize (KiB) 1056912

[startup+51.1009 s]
/proc/loadavg: 1.09 1.05 1.01 2/71 22305
/proc/meminfo: memFree=10192/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=50.32
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 161842 0 0 0 4966 66 0 0 20 0 11 0 120790599 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 156065 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=37.53
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 3729 24 0 0 20 0 11 0 120790600 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646197731304 140646096474837 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=8.39
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 93062 0 0 0 808 31 0 0 20 0 11 0 120790602 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.23
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 218 5 0 0 20 0 11 0 120790605 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.11
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 206 5 0 0 20 0 11 0 120790605 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.02
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 4 0 0 0 2 0 0 0 20 0 11 0 120790605 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 156065 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.32
Current children cumulated vsize (KiB) 1056912

[startup+102.301 s]
/proc/loadavg: 1.04 1.04 1.00 2/71 22305
/proc/meminfo: memFree=10088/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=100.91
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 166135 0 0 0 10024 67 0 0 20 0 11 0 120790599 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 160350 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=82.15
/proc/22295/task/22296/stat : 22296 (java) S 22292 22292 1750 0 -1 4202560 47808 0 0 0 8191 24 0 0 20 0 11 0 120790600 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646197731104 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=14.33
/proc/22295/task/22297/stat : 22297 (java) R 22292 22292 1750 0 -1 4202560 97349 0 0 0 1401 32 0 0 20 0 11 0 120790602 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646090369136 140646175506321 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.11
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 206 5 0 0 20 0 11 0 120790605 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.05
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 10 0 0 0 5 0 0 0 20 0 11 0 120790605 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 160350 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.91
Current children cumulated vsize (KiB) 1056912

[startup+162.301 s]
/proc/loadavg: 1.01 1.03 1.00 2/71 22305
/proc/meminfo: memFree=10132/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=160.28
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 170804 0 0 0 15960 68 0 0 20 0 11 0 120790599 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 165011 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=136.8
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 13656 24 0 0 20 0 11 0 120790600 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646197731304 140646096460271 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=19.01
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102012 0 0 0 1867 34 0 0 20 0 11 0 120790602 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.12
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 207 5 0 0 20 0 11 0 120790605 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.07
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 7 0 0 0 20 0 11 0 120790605 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 165011 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 160.28
Current children cumulated vsize (KiB) 1056912

[startup+222.305 s]
/proc/loadavg: 1.07 1.04 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=219.56
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171058 0 0 0 21888 68 0 0 20 0 11 0 120790599 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 165258 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=192.07
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 19183 24 0 0 20 0 11 0 120790600 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646197731304 140646096503618 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=23
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102260 0 0 0 2266 34 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.12
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 207 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.1
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 22 0 0 0 10 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 219.56
Current children cumulated vsize (KiB) 1056912

[startup+282.301 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=278.75
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171067 0 0 0 27806 69 0 0 20 0 11 0 120790599 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 165258 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=248.12
/proc/22295/task/22296/stat : 22296 (java) S 22292 22292 1750 0 -1 4202560 47808 0 0 0 24787 25 0 0 20 0 11 0 120790600 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646197731104 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=26.11
/proc/22295/task/22297/stat : 22297 (java) R 22292 22292 1750 0 -1 4202560 102263 0 0 0 2577 34 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646090369136 140646178061520 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.12
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 207 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.13
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 28 0 0 0 13 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 278.75
Current children cumulated vsize (KiB) 1056912

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

[startup+288.001 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=284.37
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171067 0 0 0 28368 69 0 0 20 0 11 0 120790599 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 165258 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=253.25
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 25300 25 0 0 20 0 11 0 120790600 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646197731304 140646096492949 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=26.6
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102263 0 0 0 2626 34 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.12
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 207 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.13
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 28 0 0 0 13 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 284.37
Current children cumulated vsize (KiB) 1056912

[startup+291.201 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=287.53
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171067 0 0 0 28684 69 0 0 20 0 11 0 120790599 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 165258 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=256.41
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 25616 25 0 0 20 0 11 0 120790600 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646197731304 140646095761210 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=26.6
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102263 0 0 0 2626 34 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.12
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 207 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.13
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 28 0 0 0 13 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 287.53
Current children cumulated vsize (KiB) 1056912

[startup+294.401 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=290.69
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171067 0 0 0 29000 69 0 0 20 0 11 0 120790599 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 165258 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=259.56
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 25931 25 0 0 20 0 11 0 120790600 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646197731304 140646095987646 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=26.6
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102263 0 0 0 2626 34 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.12
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 207 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.14
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 290.69
Current children cumulated vsize (KiB) 1056912

[startup+296.009 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1047744 CPUtime=292.27
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171067 0 0 0 29158 69 0 0 20 0 11 0 120790599 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 261936 165258 2393 9 0 249286 0
[pid=22295/tid=22296] ppid=22292 vsize=1047744 CPUtime=261.14
/proc/22295/task/22296/stat : 22296 (java) R 22292 22292 1750 0 -1 4202560 47808 0 0 0 26089 25 0 0 20 0 11 0 120790600 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646197731304 140646096474832 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1047744 CPUtime=26.6
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102263 0 0 0 2626 34 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1047744 CPUtime=2.24
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 219 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1047744 CPUtime=2.12
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 207 5 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1047744 CPUtime=0.14
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120790605 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22305] ppid=22292 vsize=1047744 CPUtime=0
/proc/22295/task/22305/stat : 22305 (java) S 22292 22292 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 120791713 1072889856 165258 18446744073709551615 4194304 4228012 140735958668352 140646081804128 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.27
Current children cumulated vsize (KiB) 1056912

[startup+296.401 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1048772 CPUtime=292.49
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171081 0 0 0 29179 70 0 0 20 0 11 0 120790599 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 262193 165270 2393 9 0 249543 0
[pid=22295/tid=22296] ppid=22292 vsize=1048772 CPUtime=261.33
/proc/22295/task/22296/stat : 22296 (java) S 22292 22292 1750 0 -1 4202560 47816 0 0 0 26107 26 0 0 20 0 11 0 120790600 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646197732272 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1048772 CPUtime=26.6
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102263 0 0 0 2626 34 0 0 20 0 11 0 120790602 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1048772 CPUtime=2.26
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 221 5 0 0 20 0 11 0 120790605 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1048772 CPUtime=2.14
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 209 5 0 0 20 0 11 0 120790605 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1048772 CPUtime=0.14
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120790605 1073942528 165270 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.49
Current children cumulated vsize (KiB) 1057940

[startup+296.801 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=1048772 CPUtime=292.56
/proc/22295/stat : 22295 (java) S 22292 22292 1750 0 -1 4202496 171083 0 0 0 29185 71 0 0 20 0 11 0 120790599 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140735958659376 140646191197813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 262193 165272 2393 9 0 249543 0
[pid=22295/tid=22296] ppid=22292 vsize=1048772 CPUtime=261.33
/proc/22295/task/22296/stat : 22296 (java) S 22292 22292 1750 0 -1 4202560 47816 0 0 0 26107 26 0 0 20 0 11 0 120790600 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646197732272 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=22295/tid=22297] ppid=22292 vsize=1048772 CPUtime=26.6
/proc/22295/task/22297/stat : 22297 (java) S 22292 22292 1750 0 -1 4202560 102263 0 0 0 2626 34 0 0 20 0 11 0 120790602 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646090370176 140646191212107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22298] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22298/stat : 22298 (java) S 22292 22292 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 120790602 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646089316368 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22299] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22299/stat : 22299 (java) S 22292 22292 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 120790602 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646088263584 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22300] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22300/stat : 22300 (java) S 22292 22292 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 120790605 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646087212016 140646191219744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22301] ppid=22292 vsize=1048772 CPUtime=2.27
/proc/22295/task/22301/stat : 22301 (java) S 22292 22292 1750 0 -1 4202560 10340 0 0 0 222 5 0 0 20 0 11 0 120790605 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646086159376 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22302] ppid=22292 vsize=1048772 CPUtime=2.14
/proc/22295/task/22302/stat : 22302 (java) S 22292 22292 1750 0 -1 4202560 9331 0 0 0 209 5 0 0 20 0 11 0 120790605 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646085106704 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22303] ppid=22292 vsize=1048772 CPUtime=0
/proc/22295/task/22303/stat : 22303 (java) S 22292 22292 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 120790605 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646084054224 140646191211220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22295/tid=22304] ppid=22292 vsize=1048772 CPUtime=0.14
/proc/22295/task/22304/stat : 22304 (java) S 22292 22292 1750 0 -1 4202560 28 0 0 0 14 0 0 0 20 0 11 0 120790605 1073942528 165272 18446744073709551615 4194304 4228012 140735958668352 140646083001728 140646191212107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.56
Current children cumulated vsize (KiB) 1057940

[startup+296.901 s]
/proc/loadavg: 1.02 1.03 1.00 2/71 22305
/proc/meminfo: memFree=9388/1022884 swapFree=0/0
[pid=22292] ppid=22291 vsize=9168 CPUtime=0
/proc/22292/stat : 22292 (p2cudf-full-1.1) S 22291 22292 1750 0 -1 4202496 455 292 0 0 0 0 0 0 20 0 1 0 120790599 9388032 330 18446744073709551615 4194304 5129932 140734034062736 140734034060880 140716407247966 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22292/statm: 2292 330 280 229 0 52 0
[pid=22295] ppid=22292 vsize=0 CPUtime=292.66
/proc/22295/stat : 22295 (java) Z 22292 22292 1750 0 -1 4203532 171094 0 0 0 29192 74 0 0 20 0 2 0 120790599 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22295/statm: 0 0 0 0 0 0 0
Current children cumulated CPU time (s) 292.66
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 296.958
CPU time (s): 292.73
CPU user time (s): 291.93
CPU system time (s): 0.80005
CPU usage (%): 98.5763
Max. virtual memory (cumulated for all children) (KiB): 1059212

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 291.93
system time used= 0.80005
maximum resident set size= 661124
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 171854
page faults= 0
swaps= 0
block input operations= 68424
block output operations= 592
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7445
involuntary context switches= 41794

runsolver used 1.08007 second user time and 1.94412 second system time

The end