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/201108291842/p2cudf-user-1.13/4a69cf16-c731-11df-9182-00163e3d3b7c.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//4a69cf16-c731-11df-9182-00163e3d3b7c.cudf /home/misc2010/tmp/201108291842/p2cudf-user-1.13/4a69cf16-c731-11df-9182-00163e3d3b7c.cudf.dudf-real.result -notuptodate,-removed,-changed 

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.13 1.29 1.18 5/34 23167
/proc/meminfo: memFree=276480/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) R 23165 23166 17511 34816 17511 4202496 356 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2564 CPUtime=0
/proc/23167/stat : 23167 (p2cudf-user-1.1) R 23166 23166 17511 34816 17511 4202560 0 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 40 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/23167/statm: 641 40 0 194 0 28 0

[startup+0.195406 s]
/proc/loadavg: 1.13 1.29 1.18 5/34 23167
/proc/meminfo: memFree=276480/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.205399 s]
/proc/loadavg: 1.13 1.29 1.18 5/34 23167
/proc/meminfo: memFree=276480/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.305429 s]
/proc/loadavg: 1.13 1.29 1.18 5/34 23167
/proc/meminfo: memFree=276480/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+0.705523 s]
/proc/loadavg: 1.13 1.29 1.18 5/34 23167
/proc/meminfo: memFree=276480/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5136

[startup+1.50573 s]
/proc/loadavg: 1.13 1.29 1.18 3/45 23189
/proc/meminfo: memFree=229748/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877152 CPUtime=1.46
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 27650 0 1 0 137 9 0 0 25 0 10 0 46257058 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219288 24781 1723 10 0 216379 0
[pid=23180/tid=23181] ppid=23167 vsize=877152 CPUtime=0.78
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 18208 0 1 0 72 6 0 0 25 0 10 0 46257059 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4095180573 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 7 0 0 0 0 0 0 0 18 0 10 0 46257060 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 46257061 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 46257061 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 46257063 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877152 CPUtime=0.53
/proc/23180/task/23186/stat : 23186 (java) R 23167 23166 17511 34816 17511 4202560 8075 0 0 0 51 2 0 0 25 0 10 0 46257063 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877152 CPUtime=0.12
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 286 0 0 0 12 0 0 0 21 0 10 0 46257063 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 46257063 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 46257063 898203648 24781 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.48
Current children cumulated vsize (KiB) 882288

[startup+3.10611 s]
/proc/loadavg: 1.13 1.29 1.18 2/45 23189
/proc/meminfo: memFree=73136/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877152 CPUtime=3.06
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 71720 0 1 0 285 21 0 0 25 0 10 0 46257058 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219288 68851 1743 10 0 216379 0
[pid=23180/tid=23181] ppid=23167 vsize=877152 CPUtime=1.59
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50090 0 1 0 143 16 0 0 25 0 10 0 46257059 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877152 CPUtime=0.25
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 12101 0 0 0 23 2 0 0 16 0 10 0 46257060 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 10 0 46257061 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 46257061 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 46257063 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877152 CPUtime=0.94
/proc/23180/task/23186/stat : 23186 (java) R 23167 23166 17511 34816 17511 4202560 8114 0 0 0 92 2 0 0 16 0 10 0 46257063 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4151829906 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877152 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 10 0 46257063 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 46257063 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877152 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 46257063 898203648 68851 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.08
Current children cumulated vsize (KiB) 882288

[startup+6.30709 s]
/proc/loadavg: 1.20 1.30 1.18 2/46 23190
/proc/meminfo: memFree=5672/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=6.24
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 82486 0 1 0 602 22 0 0 25 0 11 0 46257058 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 79429 1779 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=3.23
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50276 0 1 0 307 16 0 0 25 0 11 0 46257059 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=0.51
/proc/23180/task/23182/stat : 23182 (java) R 23167 23166 17511 34816 17511 4202560 22279 0 0 0 48 3 0 0 16 0 11 0 46257060 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4149886224 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=2.22
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8512 0 0 0 220 2 0 0 15 0 11 0 46257063 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 79429 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.26
Current children cumulated vsize (KiB) 882612

[startup+12.7084 s]
/proc/loadavg: 1.18 1.30 1.18 2/46 23190
/proc/meminfo: memFree=6112/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=12.63
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 85166 0 1 0 1241 22 0 0 25 0 11 0 46257058 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 82109 1782 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=9.11
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50277 0 1 0 895 16 0 0 25 0 11 0 46257059 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=0.57
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 24921 0 0 0 54 3 0 0 16 0 11 0 46257060 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=2.67
/proc/23180/task/23186/stat : 23186 (java) R 23167 23166 17511 34816 17511 4202560 8549 0 0 0 265 2 0 0 16 0 11 0 46257063 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4152549284 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 82109 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.65
Current children cumulated vsize (KiB) 882612

[startup+25.5121 s]
/proc/loadavg: 1.14 1.28 1.18 2/46 23190
/proc/meminfo: memFree=5988/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=25.41
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 85179 0 1 0 2519 22 0 0 25 0 11 0 46257058 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 82122 1784 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=21.77
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50278 0 1 0 2161 16 0 0 25 0 11 0 46257059 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4096163243 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=0.57
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 24921 0 0 0 54 3 0 0 15 0 11 0 46257060 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=2.79
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8561 0 0 0 277 2 0 0 15 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.43
Current children cumulated vsize (KiB) 882612

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

[startup+25.6121 s]
/proc/loadavg: 1.14 1.28 1.18 2/46 23190
/proc/meminfo: memFree=5988/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=25.51
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 85179 0 1 0 2529 22 0 0 25 0 11 0 46257058 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 82122 1784 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=21.87
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50278 0 1 0 2171 16 0 0 25 0 11 0 46257059 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4096155986 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=0.57
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 24921 0 0 0 54 3 0 0 16 0 11 0 46257060 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=2.79
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8561 0 0 0 277 2 0 0 15 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 82122 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.53
Current children cumulated vsize (KiB) 882612

[startup+38.4061 s]
/proc/loadavg: 1.12 1.27 1.18 2/46 23190
/proc/meminfo: memFree=6024/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=38.29
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 91408 0 1 0 3803 26 0 0 25 0 11 0 46257058 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 88351 1788 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=33.55
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50279 0 1 0 3339 16 0 0 25 0 11 0 46257059 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4096404060 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=1.18
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 31114 0 0 0 111 7 0 0 15 0 11 0 46257060 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=3.29
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8596 0 0 0 327 2 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 38.31
Current children cumulated vsize (KiB) 882612

[startup+41.6071 s]
/proc/loadavg: 1.11 1.27 1.17 2/46 23190
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=41.49
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 91408 0 1 0 4123 26 0 0 25 0 11 0 46257058 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 88351 1788 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=36.75
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50279 0 1 0 3659 16 0 0 25 0 11 0 46257059 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4096162970 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=1.18
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 31114 0 0 0 111 7 0 0 15 0 11 0 46257060 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=3.29
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8596 0 0 0 327 2 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 41.51
Current children cumulated vsize (KiB) 882612

[startup+44.8081 s]
/proc/loadavg: 1.10 1.26 1.17 2/46 23190
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=44.69
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 91408 0 1 0 4442 27 0 0 25 0 11 0 46257058 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 88351 1788 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=39.94
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50279 0 1 0 3977 17 0 0 25 0 11 0 46257059 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4096187238 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=1.18
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 31114 0 0 0 111 7 0 0 15 0 11 0 46257060 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=3.29
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8596 0 0 0 327 2 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 44.71
Current children cumulated vsize (KiB) 882612

[startup+46.4111 s]
/proc/loadavg: 1.10 1.26 1.17 2/46 23190
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877476 CPUtime=46.28
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 91408 0 1 0 4601 27 0 0 25 0 11 0 46257058 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219369 88351 1788 10 0 216460 0
[pid=23180/tid=23181] ppid=23167 vsize=877476 CPUtime=41.5
/proc/23180/task/23181/stat : 23181 (java) R 23167 23166 17511 34816 17511 4202560 50279 0 1 0 4133 17 0 0 25 0 11 0 46257059 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877476 CPUtime=1.18
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 31114 0 0 0 111 7 0 0 15 0 11 0 46257060 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877476 CPUtime=3.33
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8596 0 0 0 331 2 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877476 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23190] ppid=23167 vsize=877476 CPUtime=0
/proc/23180/task/23190/stat : 23190 (java) S 23167 23166 17511 34816 17511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 46257542 898535424 88351 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 46.3
Current children cumulated vsize (KiB) 882612

[startup+47.2043 s]
/proc/loadavg: 1.10 1.26 1.17 2/46 23190
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877800 CPUtime=46.9
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 91421 0 1 0 4663 27 0 0 25 0 11 0 46257058 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219450 88364 1789 10 0 216541 0
[pid=23180/tid=23181] ppid=23167 vsize=877800 CPUtime=42.04
/proc/23180/task/23181/stat : 23181 (java) S 23167 23166 17511 34816 17511 4202560 50287 0 1 0 4187 17 0 0 25 0 11 0 46257059 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877800 CPUtime=1.18
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 31114 0 0 0 111 7 0 0 16 0 11 0 46257060 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877800 CPUtime=3.4
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8596 0 0 0 338 2 0 0 16 0 11 0 46257063 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877800 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898867200 88364 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 46.92
Current children cumulated vsize (KiB) 882936

[startup+47.6123 s]
/proc/loadavg: 1.10 1.26 1.17 1/46 23191
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877800 CPUtime=46.98
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 91423 0 1 0 4670 28 0 0 25 0 11 0 46257058 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219450 88366 1789 10 0 216541 0
[pid=23180/tid=23181] ppid=23167 vsize=877800 CPUtime=42.04
/proc/23180/task/23181/stat : 23181 (java) S 23167 23166 17511 34816 17511 4202560 50287 0 1 0 4187 17 0 0 25 0 11 0 46257059 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877800 CPUtime=1.18
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 31114 0 0 0 111 7 0 0 16 0 11 0 46257060 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877800 CPUtime=3.42
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8596 0 0 0 340 2 0 0 15 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877800 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23191] ppid=23167 vsize=877800 CPUtime=0.06
/proc/23180/task/23191/stat : 23191 (java) R 23167 23166 17511 34816 17511 4202560 6 0 0 0 6 0 0 0 21 0 11 0 46261757 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4095469331 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 47
Current children cumulated vsize (KiB) 882936

[startup+47.7124 s]
/proc/loadavg: 1.10 1.26 1.17 1/46 23191
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=23166] ppid=23165 vsize=2564 CPUtime=0
/proc/23166/stat : 23166 (p2cudf-user-1.1) S 23165 23166 17511 34816 17511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 46257055 2625536 270 1283457024 134512640 135304128 4290145584 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23166/statm: 641 270 230 194 0 28 0
[pid=23167] ppid=23166 vsize=2572 CPUtime=0.02
/proc/23167/stat : 23167 (p2cudf) S 23166 23166 17511 34816 17511 4202496 391 3012 0 1 0 0 2 0 25 0 1 0 46257055 2633728 280 1283457024 134512640 135304128 4287017568 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/23167/statm: 643 280 239 194 0 30 0
[pid=23180] ppid=23167 vsize=877800 CPUtime=47.08
/proc/23180/stat : 23180 (java) S 23167 23166 17511 34816 17511 4202496 91423 0 1 0 4675 33 0 0 25 0 11 0 46257058 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23180/statm: 219450 88366 1789 10 0 216541 0
[pid=23180/tid=23181] ppid=23167 vsize=877800 CPUtime=42.04
/proc/23180/task/23181/stat : 23181 (java) S 23167 23166 17511 34816 17511 4202560 50287 0 1 0 4187 17 0 0 25 0 11 0 46257059 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23182] ppid=23167 vsize=877800 CPUtime=1.18
/proc/23180/task/23182/stat : 23182 (java) S 23167 23166 17511 34816 17511 4202560 31114 0 0 0 111 7 0 0 16 0 11 0 46257060 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 0 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23183] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23183/stat : 23183 (java) S 23167 23166 17511 34816 17511 4202560 9 0 0 0 0 0 0 0 18 0 11 0 46257061 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23184] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23184/stat : 23184 (java) S 23167 23166 17511 34816 17511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 46257061 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23185] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23185/stat : 23185 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23186] ppid=23167 vsize=877800 CPUtime=3.44
/proc/23180/task/23186/stat : 23186 (java) S 23167 23166 17511 34816 17511 4202560 8596 0 0 0 342 2 0 0 15 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23187] ppid=23167 vsize=877800 CPUtime=0.26
/proc/23180/task/23187/stat : 23187 (java) S 23167 23166 17511 34816 17511 4202560 338 0 0 0 26 0 0 0 16 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23188] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23188/stat : 23188 (java) S 23167 23166 17511 34816 17511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23189] ppid=23167 vsize=877800 CPUtime=0
/proc/23180/task/23189/stat : 23189 (java) S 23167 23166 17511 34816 17511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 46257063 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4294960130 0 4 0 16800975 18446612133194181568 0 0 -1 0 0 0 0
[pid=23180/tid=23191] ppid=23167 vsize=877800 CPUtime=0.13
/proc/23180/task/23191/stat : 23191 (java) R 23167 23166 17511 34816 17511 4202560 6 0 0 0 8 5 0 0 21 0 11 0 46261757 898867200 88366 1283457024 134512640 134550932 4292511280 18446744073709551615 4095290115 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 47.1
Current children cumulated vsize (KiB) 882936

Child status: 0
Real time (s): 47.7761
CPU time (s): 47.1469
CPU user time (s): 46.7789
CPU system time (s): 0.368023
CPU usage (%): 98.6832
Max. virtual memory (cumulated for all children) (KiB): 883052

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 46.7789
system time used= 0.368023
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 95221
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= 1911
involuntary context switches= 2329

runsolver used 0 second user time and 0 second system time

The end