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/201108311143/p2cudf-user-1.13/rand172.cudf.user-upgrades.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/user-upgrades/rand172.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/rand172.cudf.user-upgrades.result -sum(installedsize) 

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: 0.99 0.99 0.99 3/37 21429
/proc/meminfo: memFree=681932/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) R 21427 21428 19908 34817 19908 4202496 356 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2568 CPUtime=0
/proc/21429/stat : 21429 (p2cudf-user-1.1) R 21428 21428 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 40 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/21429/statm: 642 40 0 194 0 29 0

[startup+0.166471 s]
/proc/loadavg: 0.99 0.99 0.99 3/37 21429
/proc/meminfo: memFree=681932/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.20647 s]
/proc/loadavg: 0.99 0.99 0.99 3/37 21429
/proc/meminfo: memFree=681932/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.306492 s]
/proc/loadavg: 0.99 0.99 0.99 3/37 21429
/proc/meminfo: memFree=681932/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.706608 s]
/proc/loadavg: 0.99 0.99 0.99 3/37 21429
/proc/meminfo: memFree=681932/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+1.50683 s]
/proc/loadavg: 1.23 1.04 1.01 5/48 21451
/proc/meminfo: memFree=630268/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=896240 CPUtime=1.48
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 22444 0 1 0 138 10 0 0 25 0 10 0 61533761 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 224060 18505 1720 10 0 221151 0
[pid=21442/tid=21443] ppid=21429 vsize=896240 CPUtime=0.78
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 8056 0 1 0 74 4 0 0 25 0 10 0 61533762 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4094854944 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=896240 CPUtime=0
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 16 0 10 0 61533764 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=896240 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 61533764 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=896240 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 61533764 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=896240 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61533767 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=896240 CPUtime=0.32
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 6288 0 0 0 29 3 0 0 21 0 10 0 61533767 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=896240 CPUtime=0.35
/proc/21442/task/21449/stat : 21449 (java) R 21429 21428 19908 34817 19908 4202560 7021 0 0 0 34 1 0 0 25 0 10 0 61533767 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=896240 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61533767 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=896240 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 61533767 917749760 18505 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.51
Current children cumulated vsize (KiB) 901380

[startup+3.1072 s]
/proc/loadavg: 1.23 1.04 1.01 2/48 21451
/proc/meminfo: memFree=539004/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892672 CPUtime=3.07
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 75331 0 1 0 285 22 0 0 25 0 10 0 61533761 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223168 71126 1742 10 0 220259 0
[pid=21442/tid=21443] ppid=21429 vsize=892672 CPUtime=1.78
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50034 0 1 0 165 13 0 0 25 0 10 0 61533762 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892672 CPUtime=0.21
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 10625 0 0 0 18 3 0 0 16 0 10 0 61533764 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892672 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 61533764 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892672 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 61533764 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892672 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61533767 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892672 CPUtime=0.69
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 6548 0 0 0 66 3 0 0 15 0 10 0 61533767 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892672 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 10 0 61533767 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892672 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61533767 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892672 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 61533767 914096128 71126 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 897812

[startup+6.33781 s]
/proc/loadavg: 1.23 1.04 1.01 2/49 21452
/proc/meminfo: memFree=401852/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=6.29
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 78150 0 1 0 607 22 0 0 25 0 11 0 61533761 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 71637 1781 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=3.29
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 316 13 0 0 25 0 11 0 61533762 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=0.26
/proc/21442/task/21444/stat : 21444 (java) R 21429 21428 19908 34817 19908 4202560 10692 0 0 0 23 3 0 0 16 0 11 0 61533764 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4151555187 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.35
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9054 0 0 0 232 3 0 0 16 0 11 0 61533767 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) R 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 71637 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.32
Current children cumulated vsize (KiB) 898136

[startup+12.7096 s]
/proc/loadavg: 1.20 1.04 1.01 2/49 21452
/proc/meminfo: memFree=352872/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=12.65
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 90265 0 1 0 1242 23 0 0 25 0 11 0 61533761 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 83752 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=7.81
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 768 13 0 0 25 0 11 0 61533762 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4094842953 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=1.89
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 22775 0 0 0 185 4 0 0 16 0 11 0 61533764 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.57
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9086 0 0 0 254 3 0 0 16 0 11 0 61533767 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 83752 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.68
Current children cumulated vsize (KiB) 898136

[startup+25.5423 s]
/proc/loadavg: 1.17 1.03 1.01 2/49 21452
/proc/meminfo: memFree=352748/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=25.48
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 90267 0 1 0 2525 23 0 0 25 0 11 0 61533761 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 83754 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=18.74
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 1861 13 0 0 25 0 11 0 61533762 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=3.77
/proc/21442/task/21444/stat : 21444 (java) R 21429 21428 19908 34817 19908 4202560 22775 0 0 0 373 4 0 0 16 0 11 0 61533764 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4149497182 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.59
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 256 3 0 0 15 0 11 0 61533767 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) R 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 83754 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.51
Current children cumulated vsize (KiB) 898136

[startup+51.1138 s]
/proc/loadavg: 1.24 1.06 1.02 4/49 21452
/proc/meminfo: memFree=348904/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=50.64
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91196 0 1 0 5041 23 0 0 25 0 11 0 61533761 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 84683 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=40.54
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 4041 13 0 0 25 0 11 0 61533762 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4095601716 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=7.12
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 708 4 0 0 16 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.59
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 256 3 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.67
Current children cumulated vsize (KiB) 898136

[startup+102.305 s]
/proc/loadavg: 1.10 1.05 1.01 2/49 21452
/proc/meminfo: memFree=348780/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=101.8
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91196 0 1 0 10154 26 0 0 25 0 11 0 61533761 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 84683 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=86.49
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 8633 16 0 0 25 0 11 0 61533762 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4095588921 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=12.32
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 1228 4 0 0 15 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.59
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 256 3 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.83
Current children cumulated vsize (KiB) 898136

[startup+162.309 s]
/proc/loadavg: 1.03 1.04 1.01 3/49 21452
/proc/meminfo: memFree=348656/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=161.77
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91196 0 1 0 16147 30 0 0 25 0 11 0 61533761 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 84683 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=139.99
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 13982 17 0 0 25 0 11 0 61533762 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4095605731 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=18.79
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 1872 7 0 0 16 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.6
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 257 3 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.8
Current children cumulated vsize (KiB) 898136

[startup+222.321 s]
/proc/loadavg: 1.07 1.04 1.01 2/51 21459
/proc/meminfo: memFree=348384/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=221.74
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91196 0 1 0 22144 30 0 0 25 0 11 0 61533761 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 84683 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=194.08
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 19390 18 0 0 25 0 11 0 61533762 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=24.69
/proc/21442/task/21444/stat : 21444 (java) R 21429 21428 19908 34817 19908 4202560 23704 0 0 0 2462 7 0 0 15 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4149497304 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.6
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 257 3 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.77
Current children cumulated vsize (KiB) 898136

[startup+282.306 s]
/proc/loadavg: 1.08 1.05 1.00 2/50 21463
/proc/meminfo: memFree=348400/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=281.67
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91196 0 1 0 28137 30 0 0 25 0 11 0 61533761 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 84683 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=247.58
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 24740 18 0 0 25 0 11 0 61533762 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4095601716 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=31.11
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 3104 7 0 0 15 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.6
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 257 3 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.7
Current children cumulated vsize (KiB) 898136

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

[startup+283.006 s]
/proc/loadavg: 1.08 1.05 1.00 2/50 21463
/proc/meminfo: memFree=348400/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=282.37
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91196 0 1 0 28207 30 0 0 25 0 11 0 61533761 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 84683 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=248.28
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 24810 18 0 0 25 0 11 0 61533762 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4094843024 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=31.11
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 3104 7 0 0 15 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.6
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 257 3 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.4
Current children cumulated vsize (KiB) 898136

[startup+283.806 s]
/proc/loadavg: 1.08 1.05 1.00 2/50 21463
/proc/meminfo: memFree=348400/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=892996 CPUtime=283.17
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91196 0 1 0 28287 30 0 0 25 0 11 0 61533761 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223249 84683 1783 10 0 220340 0
[pid=21442/tid=21443] ppid=21429 vsize=892996 CPUtime=248.8
/proc/21442/task/21443/stat : 21443 (java) R 21429 21428 19908 34817 19908 4202560 50275 0 1 0 24862 18 0 0 25 0 11 0 61533762 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4094842991 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=892996 CPUtime=31.39
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 3132 7 0 0 16 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=892996 CPUtime=2.6
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 257 3 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=892996 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21452] ppid=21429 vsize=892996 CPUtime=0
/proc/21442/task/21452/stat : 21452 (java) S 21429 21428 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 61534209 914427904 84683 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.2
Current children cumulated vsize (KiB) 898136

[startup+284.603 s]
/proc/loadavg: 1.08 1.05 1.00 2/50 21463
/proc/meminfo: memFree=348400/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=893320 CPUtime=283.9
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91209 0 1 0 28360 30 0 0 25 0 11 0 61533761 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223330 84696 1784 10 0 220421 0
[pid=21442/tid=21443] ppid=21429 vsize=893320 CPUtime=249.51
/proc/21442/task/21443/stat : 21443 (java) S 21429 21428 19908 34817 19908 4202560 50283 0 1 0 24933 18 0 0 25 0 11 0 61533762 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=893320 CPUtime=31.39
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 3132 7 0 0 16 0 11 0 61533764 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=893320 CPUtime=2.62
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 259 3 0 0 15 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=893320 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.93
Current children cumulated vsize (KiB) 898460

[startup+285.007 s]
/proc/loadavg: 1.08 1.05 1.00 1/50 21464
/proc/meminfo: memFree=348400/1048576 swapFree=0/0
[pid=21428] ppid=21427 vsize=2568 CPUtime=0
/proc/21428/stat : 21428 (p2cudf-user-1.1) S 21427 21428 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 25 0 1 0 61533758 2629632 270 1283457024 134512640 135304128 4294711744 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21428/statm: 642 270 230 194 0 29 0
[pid=21429] ppid=21428 vsize=2572 CPUtime=0.03
/proc/21429/stat : 21429 (p2cudf) S 21428 21428 19908 34817 19908 4202496 393 3016 0 1 0 0 1 2 25 0 1 0 61533758 2633728 281 1283457024 134512640 135304128 4286712400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21429/statm: 643 281 239 194 0 30 0
[pid=21442] ppid=21429 vsize=893320 CPUtime=283.9
/proc/21442/stat : 21442 (java) S 21429 21428 19908 34817 19908 4202496 91209 0 1 0 28360 30 0 0 25 0 11 0 61533761 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21442/statm: 223330 84696 1784 10 0 220421 0
[pid=21442/tid=21443] ppid=21429 vsize=893320 CPUtime=249.51
/proc/21442/task/21443/stat : 21443 (java) S 21429 21428 19908 34817 19908 4202560 50283 0 1 0 24933 18 0 0 25 0 11 0 61533762 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21444] ppid=21429 vsize=893320 CPUtime=31.39
/proc/21442/task/21444/stat : 21444 (java) S 21429 21428 19908 34817 19908 4202560 23704 0 0 0 3132 7 0 0 16 0 11 0 61533764 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 0 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21445] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21445/stat : 21445 (java) S 21429 21428 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61533764 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21446] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21446/stat : 21446 (java) S 21429 21428 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61533764 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21447] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21447/stat : 21447 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21448] ppid=21429 vsize=893320 CPUtime=2.62
/proc/21442/task/21448/stat : 21448 (java) S 21429 21428 19908 34817 19908 4202560 9088 0 0 0 259 3 0 0 15 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21449] ppid=21429 vsize=893320 CPUtime=0.36
/proc/21442/task/21449/stat : 21449 (java) S 21429 21428 19908 34817 19908 4202560 7048 0 0 0 35 1 0 0 25 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21450] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21450/stat : 21450 (java) S 21429 21428 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21451] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21451/stat : 21451 (java) S 21429 21428 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61533767 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
[pid=21442/tid=21464] ppid=21429 vsize=893320 CPUtime=0
/proc/21442/task/21464/stat : 21464 (java) S 21429 21428 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 61562212 914759680 84696 1283457024 134512640 134550932 4291114272 18446744073709551615 4294960130 0 4 0 16800975 18446612132465458240 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.93
Current children cumulated vsize (KiB) 898460

Child status: 0
Real time (s): 285.115
CPU time (s): 283.958
CPU user time (s): 283.622
CPU system time (s): 0.336021
CPU usage (%): 99.5943
Max. virtual memory (cumulated for all children) (KiB): 902052

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.622
system time used= 0.336021
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 95017
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= 6279
involuntary context switches= 9143

runsolver used 0 second user time and 0.012 second system time

The end