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/201108300820/p2cudf-user-1.13/ed1cc19e-51b7-11e0-8436-00163e1e087d.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//ed1cc19e-51b7-11e0-8436-00163e1e087d.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/ed1cc19e-51b7-11e0-8436-00163e1e087d.cudf.dudf-real.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.85 0.98 0.99 1/33 18452
/proc/meminfo: memFree=941068/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=3016 CPUtime=0
/proc/18452/stat : 18452 (runsolver) D 18451 18452 2160 34817 2160 4202560 72 0 0 0 0 0 0 0 25 0 1 0 59562364 3088384 93 1283457024 134512640 134586868 4290796800 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/18452/statm: 754 93 62 19 0 53 0

[startup+0.109476 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 18452
/proc/meminfo: memFree=941068/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.205459 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 18452
/proc/meminfo: memFree=941068/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.305506 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 18452
/proc/meminfo: memFree=941068/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.705519 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 18452
/proc/meminfo: memFree=941068/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+1.50976 s]
/proc/loadavg: 0.85 0.98 0.99 3/45 18475
/proc/meminfo: memFree=907728/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=872920 CPUtime=0.84
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 15380 0 106 0 79 5 0 0 23 0 10 0 59562368 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218230 13871 1742 10 0 215321 0
[pid=18466/tid=18467] ppid=18454 vsize=872920 CPUtime=0.31
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 8394 0 15 0 28 3 0 0 25 0 10 0 59562394 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4152994785 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=872920 CPUtime=0
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 7 0 0 0 0 0 0 0 18 0 10 0 59562403 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=872920 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 59562404 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=872920 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 59562405 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=872920 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59562415 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=872920 CPUtime=0.29
/proc/18466/task/18472/stat : 18472 (java) R 18454 18452 2160 34817 2160 4202560 4138 0 1 0 28 1 0 0 24 0 10 0 59562415 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4152132186 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=872920 CPUtime=0.22
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1850 0 8 0 22 0 0 0 20 0 10 0 59562415 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=872920 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59562415 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=872920 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) R 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 59562415 893870080 13871 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.86
Current children cumulated vsize (KiB) 878056

[startup+3.13316 s]
/proc/loadavg: 0.85 0.98 0.99 2/45 18475
/proc/meminfo: memFree=799104/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=879072 CPUtime=2.42
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 62037 0 106 0 219 23 0 0 23 0 10 0 59562368 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 219768 59432 1752 10 0 216859 0
[pid=18466/tid=18467] ppid=18454 vsize=879072 CPUtime=1.26
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50089 0 15 0 107 19 0 0 25 0 10 0 59562394 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=879072 CPUtime=0.06
/proc/18466/task/18468/stat : 18468 (java) R 18454 18452 2160 34817 2160 4202560 2220 0 0 0 6 0 0 0 15 0 10 0 59562403 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4149318006 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=879072 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 59562404 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=879072 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 59562405 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=879072 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59562415 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=879072 CPUtime=0.79
/proc/18466/task/18472/stat : 18472 (java) R 18454 18452 2160 34817 2160 4202560 6881 0 1 0 76 3 0 0 19 0 10 0 59562415 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4147624321 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=879072 CPUtime=0.29
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1856 0 8 0 29 0 0 0 15 0 10 0 59562415 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=879072 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59562415 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=879072 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) R 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 59562415 900169728 59432 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.44
Current children cumulated vsize (KiB) 884208
heavy processes:

[startup+6.31164 s]
/proc/loadavg: 0.94 1.00 0.99 3/46 18476
/proc/meminfo: memFree=661728/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=879396 CPUtime=5.42
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 71452 0 107 0 516 26 0 0 23 0 11 0 59562368 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 219849 68848 1781 10 0 216940 0
[pid=18466/tid=18467] ppid=18454 vsize=879396 CPUtime=2.94
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50275 0 15 0 274 20 0 0 25 0 11 0 59562394 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4096081676 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=879396 CPUtime=0.26
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 11255 0 0 0 24 2 0 0 15 0 11 0 59562403 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=879396 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=879396 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=879396 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=879396 CPUtime=1.89
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7068 0 2 0 186 3 0 0 15 0 11 0 59562415 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=879396 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=879396 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=879396 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=879396 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 900501504 68848 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.44
Current children cumulated vsize (KiB) 884532

[startup+12.7031 s]
/proc/loadavg: 0.94 1.00 0.99 2/46 18476
/proc/meminfo: memFree=625032/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=11.8
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 82132 0 107 0 1152 28 0 0 23 0 11 0 59562368 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 77978 1786 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=8.52
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 832 20 0 0 25 0 11 0 59562394 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4096074715 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=0.97
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 21915 0 0 0 93 4 0 0 15 0 11 0 59562403 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=1.99
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7087 0 2 0 196 3 0 0 15 0 11 0 59562415 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 77978 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.82
Current children cumulated vsize (KiB) 878216

[startup+25.5056 s]
/proc/loadavg: 0.95 1.00 0.99 2/46 18476
/proc/meminfo: memFree=616848/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=24.6
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 84160 0 107 0 2432 28 0 0 23 0 11 0 59562368 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 80006 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=20.38
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 2018 20 0 0 25 0 11 0 59562394 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4096081673 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=1.84
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 23931 0 0 0 180 4 0 0 15 0 11 0 59562403 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.05
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 202 3 0 0 15 0 11 0 59562415 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 80006 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.62
Current children cumulated vsize (KiB) 878216

[startup+51.1111 s]
/proc/loadavg: 0.97 1.00 0.99 2/46 18476
/proc/meminfo: memFree=604448/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=50.19
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 87208 0 107 0 4991 28 0 0 23 0 11 0 59562368 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 83054 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=44.82
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 4462 20 0 0 25 0 11 0 59562394 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4096119348 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=2.96
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 26979 0 0 0 292 4 0 0 15 0 11 0 59562403 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.07
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 204 3 0 0 15 0 11 0 59562415 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 83054 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.21
Current children cumulated vsize (KiB) 878216

[startup+102.313 s]
/proc/loadavg: 0.98 1.00 0.99 2/46 18476
/proc/meminfo: memFree=583368/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=101.34
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 92445 0 107 0 10103 31 0 0 23 0 11 0 59562368 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 88291 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=94.44
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 9424 20 0 0 25 0 11 0 59562394 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4096020175 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=4.5
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 32216 0 0 0 443 7 0 0 15 0 11 0 59562403 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.07
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 204 3 0 0 15 0 11 0 59562415 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 88291 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.36
Current children cumulated vsize (KiB) 878216

[startup+162.31 s]
/proc/loadavg: 1.03 1.01 1.00 2/46 18476
/proc/meminfo: memFree=580764/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=161.26
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 93061 0 107 0 16091 35 0 0 23 0 11 0 59562368 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 88907 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=152.93
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 15270 23 0 0 25 0 11 0 59562394 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4096058700 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=5.92
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 32832 0 0 0 584 8 0 0 15 0 11 0 59562403 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.07
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 204 3 0 0 15 0 11 0 59562415 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 88907 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.28
Current children cumulated vsize (KiB) 878216

[startup+222.306 s]
/proc/loadavg: 1.01 1.01 1.00 2/48 18478
/proc/meminfo: memFree=555072/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=221.22
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 99427 0 107 0 22085 37 0 0 23 0 11 0 59562368 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 95273 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=211.66
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 21143 23 0 0 25 0 11 0 59562394 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4096081673 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=7.16
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 39198 0 0 0 706 10 0 0 15 0 11 0 59562403 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.07
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 204 3 0 0 15 0 11 0 59562415 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 95273 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.24
Current children cumulated vsize (KiB) 878216

[startup+282.309 s]
/proc/loadavg: 1.00 1.00 1.00 2/48 18483
/proc/meminfo: memFree=552220/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=281.18
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 100138 0 107 0 28080 38 0 0 23 0 11 0 59562368 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 95984 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=270.4
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 27017 23 0 0 25 0 11 0 59562394 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4096075322 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=8.37
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 39909 0 0 0 827 10 0 0 15 0 11 0 59562403 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.07
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 204 3 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.2
Current children cumulated vsize (KiB) 878216

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

[startup+283.209 s]
/proc/loadavg: 1.00 1.00 1.00 2/48 18484
/proc/meminfo: memFree=552220/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=282.07
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 100138 0 107 0 28169 38 0 0 23 0 11 0 59562368 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 95984 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=271.29
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 27106 23 0 0 25 0 11 0 59562394 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4096020820 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=8.37
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 39909 0 0 0 827 10 0 0 15 0 11 0 59562403 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.07
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 204 3 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.09
Current children cumulated vsize (KiB) 878216

[startup+284.01 s]
/proc/loadavg: 1.00 1.00 1.00 3/48 18484
/proc/meminfo: memFree=552220/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873080 CPUtime=282.86
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 100138 0 107 0 28248 38 0 0 23 0 11 0 59562368 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218270 95984 1788 10 0 215361 0
[pid=18466/tid=18467] ppid=18454 vsize=873080 CPUtime=272.1
/proc/18466/task/18467/stat : 18467 (java) R 18454 18452 2160 34817 2160 4202560 50276 0 15 0 27186 24 0 0 25 0 11 0 59562394 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4096119786 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873080 CPUtime=8.37
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 39909 0 0 0 827 10 0 0 15 0 11 0 59562403 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873080 CPUtime=2.07
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 204 3 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873080 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18476] ppid=18454 vsize=873080 CPUtime=0
/proc/18466/task/18476/stat : 18476 (java) S 18454 18452 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 59562816 894033920 95984 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.88
Current children cumulated vsize (KiB) 878216

[startup+284.807 s]
/proc/loadavg: 1.00 1.00 1.00 3/48 18484
/proc/meminfo: memFree=552220/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873404 CPUtime=283.4
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 100151 0 107 0 28302 38 0 0 23 0 11 0 59562368 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218351 95997 1789 10 0 215442 0
[pid=18466/tid=18467] ppid=18454 vsize=873404 CPUtime=272.62
/proc/18466/task/18467/stat : 18467 (java) S 18454 18452 2160 34817 2160 4202560 50284 0 15 0 27238 24 0 0 25 0 11 0 59562394 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873404 CPUtime=8.37
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 39909 0 0 0 827 10 0 0 16 0 11 0 59562403 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873404 CPUtime=2.09
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 206 3 0 0 15 0 11 0 59562415 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873404 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894365696 95997 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.42
Current children cumulated vsize (KiB) 878540

[startup+285.209 s]
/proc/loadavg: 1.00 1.00 1.00 1/48 18485
/proc/meminfo: memFree=552096/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873404 CPUtime=283.54
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 100153 0 107 0 28315 39 0 0 23 0 11 0 59562368 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218351 95999 1789 10 0 215442 0
[pid=18466/tid=18467] ppid=18454 vsize=873404 CPUtime=272.62
/proc/18466/task/18467/stat : 18467 (java) S 18454 18452 2160 34817 2160 4202560 50284 0 15 0 27238 24 0 0 25 0 11 0 59562394 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873404 CPUtime=8.37
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 39909 0 0 0 827 10 0 0 16 0 11 0 59562403 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 11 0 59562404 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 59562405 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873404 CPUtime=2.14
/proc/18466/task/18472/stat : 18472 (java) R 18454 18452 2160 34817 2160 4202560 7099 0 2 0 211 3 0 0 16 0 11 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4150043497 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873404 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 11 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) S 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18485] ppid=18454 vsize=873404 CPUtime=0.07
/proc/18466/task/18485/stat : 18485 (java) R 18454 18452 2160 34817 2160 4202560 6 0 0 0 7 0 0 0 20 0 11 0 59590821 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.56
Current children cumulated vsize (KiB) 878540

[startup+285.303 s]
/proc/loadavg: 1.00 1.00 1.00 1/48 18485
/proc/meminfo: memFree=552096/1048576 swapFree=0/0
[pid=18452] ppid=18451 vsize=2568 CPUtime=0
/proc/18452/stat : 18452 (p2cudf-user-1.1) S 18451 18452 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 59562364 2629632 270 1283457024 134512640 135304128 4289903872 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18452/statm: 642 270 230 194 0 29 0
[pid=18454] ppid=18452 vsize=2568 CPUtime=0.02
/proc/18454/stat : 18454 (p2cudf) S 18452 18452 2160 34817 2160 4202496 389 3019 0 1 0 0 1 1 25 0 1 0 59562365 2629632 280 1283457024 134512640 135304128 4288228240 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/18454/statm: 642 280 239 194 0 29 0
[pid=18466] ppid=18454 vsize=873404 CPUtime=283.6
/proc/18466/stat : 18466 (java) S 18454 18452 2160 34817 2160 4202496 100153 0 107 0 28320 40 0 0 23 0 10 0 59562368 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/18466/statm: 218351 95999 1789 10 0 215442 0
[pid=18466/tid=18467] ppid=18454 vsize=873404 CPUtime=272.62
/proc/18466/task/18467/stat : 18467 (java) S 18454 18452 2160 34817 2160 4202560 50284 0 15 0 27238 24 0 0 18 0 10 0 59562394 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18468] ppid=18454 vsize=873404 CPUtime=8.37
/proc/18466/task/18468/stat : 18468 (java) S 18454 18452 2160 34817 2160 4202560 39909 0 0 0 827 10 0 0 16 0 10 0 59562403 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 0 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18469] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18469/stat : 18469 (java) S 18454 18452 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 18 0 10 0 59562404 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18470] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18470/stat : 18470 (java) S 18454 18452 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 59562405 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18471] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18471/stat : 18471 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18472] ppid=18454 vsize=873404 CPUtime=2.16
/proc/18466/task/18472/stat : 18472 (java) S 18454 18452 2160 34817 2160 4202560 7099 0 2 0 213 3 0 0 15 0 10 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18473] ppid=18454 vsize=873404 CPUtime=0.3
/proc/18466/task/18473/stat : 18473 (java) S 18454 18452 2160 34817 2160 4202560 1857 0 8 0 30 0 0 0 15 0 10 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18474] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18474/stat : 18474 (java) S 18454 18452 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 18446612133393236096 0 0 -1 0 0 0 0
[pid=18466/tid=18475] ppid=18454 vsize=873404 CPUtime=0
/proc/18466/task/18475/stat : 18475 (java) R 18454 18452 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 59562415 894365696 95999 1283457024 134512640 134550932 4290399296 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.62
Current children cumulated vsize (KiB) 878540

Child status: 0
Real time (s): 285.327
CPU time (s): 283.658
CPU user time (s): 283.226
CPU system time (s): 0.432027
CPU usage (%): 99.4151
Max. virtual memory (cumulated for all children) (KiB): 884532

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.226
system time used= 0.432027
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 103958
page faults= 108
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6460
involuntary context switches= 8608

runsolver used 0.008 second user time and 0.004 second system time

The end