runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: runsolver -s SIGUSR1 -M 1124 -C 300 -d 10 -w /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/trendy-size/upgrade/difficult/rand874.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/difficult/rand874.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/trendy-size/upgrade/difficult/rand874.cudf.result -count(removed),-sum(solution,installedsize),-notuptodate(solution),-unsat_recommends(solution),-count(new) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 300 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 330 seconds
Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB
Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB

[startup+0 s]
/proc/loadavg: 1.00 1.06 1.03 2/60 25018
/proc/meminfo: memFree=646796/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=3152 CPUtime=0
/proc/25018/stat : 25018 (runsolver) R 25017 32685 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 41718519 3227648 32 18446744073709551615 134512640 134586868 4293978160 4293976208 4151415856 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/25018/statm: 788 32 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.188324 s]
/proc/loadavg: 1.00 1.06 1.03 2/60 25018
/proc/meminfo: memFree=646796/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200323 s]
/proc/loadavg: 1.00 1.06 1.03 2/60 25018
/proc/meminfo: memFree=646796/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300324 s]
/proc/loadavg: 1.00 1.06 1.03 2/60 25018
/proc/meminfo: memFree=646796/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700205 s]
/proc/loadavg: 1.00 1.06 1.03 2/60 25018
/proc/meminfo: memFree=646796/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50085 s]
/proc/loadavg: 1.00 1.06 1.03 4/71 25030
/proc/meminfo: memFree=546632/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1052032 CPUtime=1.34
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 38063 0 18 0 121 13 0 0 20 0 10 0 41718522 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 263008 34045 2345 9 0 250358 0
[pid=25021/tid=25022] ppid=25018 vsize=1052032 CPUtime=0.6
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 17739 0 7 0 52 8 0 0 20 0 10 0 41718528 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527315419808 140527213376855 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1052032 CPUtime=0
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 41718535 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1052032 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 41718535 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1052032 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 41718535 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1052032 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41718539 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1052032 CPUtime=0.36
/proc/25021/task/25027/stat : 25027 (java) R 25018 25018 32685 0 -1 4202560 10004 0 0 0 34 2 0 0 20 0 10 0 41718539 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527203842952 140527295580838 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1052032 CPUtime=0.36
/proc/25021/task/25028/stat : 25028 (java) R 25018 25018 32685 0 -1 4202560 9040 0 0 0 33 3 0 0 20 0 10 0 41718539 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527202790232 140527293197496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1052032 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41718539 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1052032 CPUtime=0
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41718539 1077280768 34045 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.34
Current children cumulated vsize (KiB) 1061200

[startup+3.10079 s]
/proc/loadavg: 1.00 1.06 1.03 2/71 25030
/proc/meminfo: memFree=424120/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1051560 CPUtime=2.91
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 89857 0 18 0 262 29 0 0 20 0 10 0 41718522 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 262890 84435 2366 9 0 250240 0
[pid=25021/tid=25022] ppid=25018 vsize=1051560 CPUtime=1.44
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47413 0 7 0 128 16 0 0 20 0 10 0 41718528 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527315419840 140527213213443 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1051560 CPUtime=0.39
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 21346 0 0 0 31 8 0 0 20 0 10 0 41718535 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1051560 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 41718535 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1051560 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 41718535 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1051560 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41718539 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1051560 CPUtime=0.52
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10668 0 0 0 50 2 0 0 20 0 10 0 41718539 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1051560 CPUtime=0.54
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 9150 0 0 0 51 3 0 0 20 0 10 0 41718539 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1051560 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41718539 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1051560 CPUtime=0
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41718539 1076797440 84435 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.91
Current children cumulated vsize (KiB) 1060728

[startup+6.3006 s]
/proc/loadavg: 1.00 1.06 1.03 2/71 25030
/proc/meminfo: memFree=190752/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1024168 CPUtime=5.98
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 129986 0 18 0 556 42 0 0 20 0 10 0 41718522 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 256042 118055 2367 9 0 243392 0
[pid=25021/tid=25022] ppid=25018 vsize=1024168 CPUtime=3.43
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47416 0 7 0 323 20 0 0 20 0 10 0 41718528 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527315419840 140527213342140 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1024168 CPUtime=1.38
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 61461 0 0 0 122 16 0 0 20 0 10 0 41718535 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1024168 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 41718535 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1024168 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 41718535 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1024168 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41718539 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1024168 CPUtime=0.56
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10674 0 0 0 54 2 0 0 20 0 10 0 41718539 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1024168 CPUtime=0.57
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 9154 0 0 0 54 3 0 0 20 0 10 0 41718539 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1024168 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41718539 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1024168 CPUtime=0
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41718539 1048748032 118055 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 5.98
Current children cumulated vsize (KiB) 1033336

[startup+12.7006 s]
/proc/loadavg: 1.08 1.07 1.04 2/72 25031
/proc/meminfo: memFree=47276/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1032856 CPUtime=12.31
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 156218 0 18 0 1178 53 0 0 20 0 11 0 41718522 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 258214 142864 2378 9 0 245564 0
[pid=25021/tid=25022] ppid=25018 vsize=1032856 CPUtime=6.97
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47797 0 7 0 674 23 0 0 20 0 11 0 41718528 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527315419040 140527213307560 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1032856 CPUtime=1.96
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 83701 0 0 0 173 23 0 0 20 0 11 0 41718535 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1032856 CPUtime=1.66
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10875 0 0 0 164 2 0 0 20 0 11 0 41718539 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1032856 CPUtime=1.68
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12558 0 0 0 164 4 0 0 20 0 11 0 41718539 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1032856 CPUtime=0.01
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 1 0 0 20 0 11 0 41718539 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1057644544 142864 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.31
Current children cumulated vsize (KiB) 1042024

[startup+25.5007 s]
/proc/loadavg: 1.06 1.07 1.04 2/72 25031
/proc/meminfo: memFree=47152/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1032856 CPUtime=24.99
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 156242 0 18 0 2442 57 0 0 20 0 11 0 41718522 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 258214 142888 2381 9 0 245564 0
[pid=25021/tid=25022] ppid=25018 vsize=1032856 CPUtime=19.4
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47803 0 7 0 1914 26 0 0 20 0 11 0 41718528 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527315427592 140527214318360 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1032856 CPUtime=1.97
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 83701 0 0 0 173 24 0 0 20 0 11 0 41718535 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1032856 CPUtime=1.75
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 173 2 0 0 20 0 11 0 41718539 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1032856 CPUtime=1.81
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12569 0 0 0 177 4 0 0 20 0 11 0 41718539 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1032856 CPUtime=0.02
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 2 0 0 20 0 11 0 41718539 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1057644544 142888 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.99
Current children cumulated vsize (KiB) 1042024

[startup+51.1007 s]
/proc/loadavg: 1.04 1.06 1.03 2/72 25031
/proc/meminfo: memFree=10272/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1035628 CPUtime=50.36
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 167483 0 18 0 4974 62 0 0 20 0 11 0 41718522 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 258907 154125 2393 9 0 246257 0
[pid=25021/tid=25022] ppid=25018 vsize=1035628 CPUtime=43.75
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47805 0 7 0 4346 29 0 0 20 0 11 0 41718528 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527315427608 140527213620744 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1035628 CPUtime=2.91
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 94934 0 0 0 265 26 0 0 20 0 11 0 41718535 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1035628 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1035628 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1035628 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1035628 CPUtime=1.79
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 176 3 0 0 20 0 11 0 41718539 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1035628 CPUtime=1.85
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12572 0 0 0 181 4 0 0 20 0 11 0 41718539 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1035628 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1035628 CPUtime=0.03
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 4 0 0 0 0 3 0 0 20 0 11 0 41718539 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1035628 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1060483072 154125 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.36
Current children cumulated vsize (KiB) 1044796

[startup+102.301 s]
/proc/loadavg: 1.02 1.05 1.03 2/72 25031
/proc/meminfo: memFree=12256/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1032856 CPUtime=101.04
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 168213 0 18 0 10037 67 0 0 20 0 11 0 41718522 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 258214 154014 2393 9 0 245564 0
[pid=25021/tid=25022] ppid=25018 vsize=1032856 CPUtime=91.32
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47805 0 7 0 9100 32 0 0 20 0 11 0 41718528 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527315427624 140527213438995 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1032856 CPUtime=5.96
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 95658 0 0 0 568 28 0 0 20 0 11 0 41718535 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1032856 CPUtime=1.81
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 178 3 0 0 20 0 11 0 41718539 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1032856 CPUtime=1.86
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12572 0 0 0 182 4 0 0 20 0 11 0 41718539 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1032856 CPUtime=0.06
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 10 0 0 0 2 4 0 0 20 0 11 0 41718539 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1032856 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1057644544 154014 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.04
Current children cumulated vsize (KiB) 1042024

[startup+162.301 s]
/proc/loadavg: 1.06 1.06 1.03 2/72 25031
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1036576 CPUtime=160.37
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 169120 0 18 0 15970 67 0 0 20 0 11 0 41718522 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 259144 154913 2393 9 0 246494 0
[pid=25021/tid=25022] ppid=25018 vsize=1036576 CPUtime=148.57
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47805 0 7 0 14825 32 0 0 20 0 11 0 41718528 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527315419040 140527214319963 0 4 0 16800975 0 0 0 -1 0 0 0 19 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1036576 CPUtime=7.98
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 96549 0 0 0 770 28 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1036576 CPUtime=1.81
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 178 3 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1036576 CPUtime=1.88
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12582 0 0 0 184 4 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1036576 CPUtime=0.08
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 4 4 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 160.37
Current children cumulated vsize (KiB) 1045744

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

[startup+166.401 s]
/proc/loadavg: 1.06 1.05 1.03 2/72 25031
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1036576 CPUtime=164.41
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 169121 0 18 0 16374 67 0 0 20 0 11 0 41718522 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 259144 154913 2393 9 0 246494 0
[pid=25021/tid=25022] ppid=25018 vsize=1036576 CPUtime=151.33
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47805 0 7 0 15101 32 0 0 20 0 11 0 41718528 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527315427336 140527213620741 0 4 0 16800975 0 0 0 -1 0 0 0 19 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1036576 CPUtime=9.26
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 96550 0 0 0 898 28 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1036576 CPUtime=1.81
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 178 3 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1036576 CPUtime=1.88
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12582 0 0 0 184 4 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1036576 CPUtime=0.08
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 4 4 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 164.41
Current children cumulated vsize (KiB) 1045744

[startup+172.81 s]
/proc/loadavg: 1.05 1.05 1.03 2/72 25031
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1036576 CPUtime=170.74
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 169121 0 18 0 17007 67 0 0 20 0 11 0 41718522 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 259144 154913 2393 9 0 246494 0
[pid=25021/tid=25022] ppid=25018 vsize=1036576 CPUtime=157.66
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47805 0 7 0 15734 32 0 0 20 0 11 0 41718528 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527315427336 140527214319237 0 4 0 16800975 0 0 0 -1 0 0 0 19 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1036576 CPUtime=9.26
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 96550 0 0 0 898 28 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1036576 CPUtime=1.81
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 178 3 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1036576 CPUtime=1.88
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12582 0 0 0 184 4 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1036576 CPUtime=0.09
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 4 5 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 170.74
Current children cumulated vsize (KiB) 1045744

[startup+176.001 s]
/proc/loadavg: 1.05 1.05 1.03 2/72 25031
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1036576 CPUtime=173.91
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 169121 0 18 0 17323 68 0 0 20 0 11 0 41718522 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 259144 154913 2393 9 0 246494 0
[pid=25021/tid=25022] ppid=25018 vsize=1036576 CPUtime=160.82
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47805 0 7 0 16050 32 0 0 20 0 11 0 41718528 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527315427336 140527213464792 0 4 0 16800975 0 0 0 -1 0 0 0 19 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1036576 CPUtime=9.26
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 96550 0 0 0 898 28 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1036576 CPUtime=1.81
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 178 3 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1036576 CPUtime=1.88
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12582 0 0 0 184 4 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1036576 CPUtime=0.09
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 4 5 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 173.91
Current children cumulated vsize (KiB) 1045744

[startup+176.801 s]
/proc/loadavg: 1.05 1.05 1.03 2/72 25031
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1036576 CPUtime=174.69
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 169121 0 18 0 17401 68 0 0 20 0 11 0 41718522 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 259144 154913 2393 9 0 246494 0
[pid=25021/tid=25022] ppid=25018 vsize=1036576 CPUtime=161.6
/proc/25021/task/25022/stat : 25022 (java) R 25018 25018 32685 0 -1 4202560 47805 0 7 0 16128 32 0 0 20 0 11 0 41718528 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527315427336 140527213461504 0 4 0 16800975 0 0 0 -1 0 0 0 19 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1036576 CPUtime=9.26
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 96550 0 0 0 898 28 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1036576 CPUtime=1.81
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 178 3 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1036576 CPUtime=1.88
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12582 0 0 0 184 4 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1036576 CPUtime=0.09
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 4 5 0 0 20 0 11 0 41718539 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25031] ppid=25018 vsize=1036576 CPUtime=0
/proc/25021/task/25031/stat : 25031 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41719585 1061453824 154913 18446744073709551615 4194304 4228012 140736994867136 140527199496032 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 174.69
Current children cumulated vsize (KiB) 1045744

[startup+177.208 s]
/proc/loadavg: 1.05 1.05 1.03 1/72 25032
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1037604 CPUtime=174.94
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 169135 0 18 0 17426 68 0 0 20 0 11 0 41718522 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 259401 154925 2393 9 0 246751 0
[pid=25021/tid=25022] ppid=25018 vsize=1037604 CPUtime=161.84
/proc/25021/task/25022/stat : 25022 (java) S 25018 25018 32685 0 -1 4202560 47813 0 7 0 16152 32 0 0 20 0 11 0 41718528 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527315428272 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 19 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1037604 CPUtime=9.26
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 96550 0 0 0 898 28 0 0 20 0 11 0 41718535 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1037604 CPUtime=1.82
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 179 3 0 0 20 0 11 0 41718539 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1037604 CPUtime=1.88
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12582 0 0 0 184 4 0 0 20 0 11 0 41718539 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1037604 CPUtime=0.1
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 5 5 0 0 20 0 11 0 41718539 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25032] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25032/stat : 25032 (java) S 25018 25018 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41736223 1062506496 154925 18446744073709551615 4194304 4228012 140736994867136 140527198443696 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 174.94
Current children cumulated vsize (KiB) 1046772

[startup+177.601 s]
/proc/loadavg: 1.05 1.05 1.03 1/72 25032
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=1037604 CPUtime=174.98
/proc/25021/stat : 25021 (java) S 25018 25018 32685 0 -1 4202496 169137 0 18 0 17429 69 0 0 20 0 11 0 41718522 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140736994858160 140527308893813 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 259401 154927 2393 9 0 246751 0
[pid=25021/tid=25022] ppid=25018 vsize=1037604 CPUtime=161.84
/proc/25021/task/25022/stat : 25022 (java) S 25018 25018 32685 0 -1 4202560 47813 0 7 0 16152 32 0 0 20 0 11 0 41718528 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527315428272 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 19 0 0
[pid=25021/tid=25023] ppid=25018 vsize=1037604 CPUtime=9.26
/proc/25021/task/25023/stat : 25023 (java) S 25018 25018 32685 0 -1 4202560 96550 0 0 0 898 28 0 0 20 0 11 0 41718535 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527208066176 140527308908107 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25024] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25024/stat : 25024 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41718535 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527207012368 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25025] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25025/stat : 25025 (java) S 25018 25018 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41718535 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527205959584 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25026] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25026/stat : 25026 (java) S 25018 25018 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41718539 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527204908016 140527308915744 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25027] ppid=25018 vsize=1037604 CPUtime=1.83
/proc/25021/task/25027/stat : 25027 (java) S 25018 25018 32685 0 -1 4202560 10882 0 0 0 180 3 0 0 20 0 11 0 41718539 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527203855376 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25028] ppid=25018 vsize=1037604 CPUtime=1.89
/proc/25021/task/25028/stat : 25028 (java) S 25018 25018 32685 0 -1 4202560 12582 0 0 0 185 4 0 0 20 0 11 0 41718539 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527202802704 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25029] ppid=25018 vsize=1037604 CPUtime=0
/proc/25021/task/25029/stat : 25029 (java) S 25018 25018 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41718539 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527201750224 140527308907220 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25030] ppid=25018 vsize=1037604 CPUtime=0.1
/proc/25021/task/25030/stat : 25030 (java) S 25018 25018 32685 0 -1 4202560 16 0 0 0 5 5 0 0 20 0 11 0 41718539 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527200697728 140527308908107 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=25021/tid=25032] ppid=25018 vsize=1037604 CPUtime=0.04
/proc/25021/task/25032/stat : 25032 (java) R 25018 25018 32685 0 -1 4202560 8 0 0 0 2 2 0 0 20 0 11 0 41736223 1062506496 154927 18446744073709551615 4194304 4228012 140736994867136 140527198434640 140527212940132 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 174.98
Current children cumulated vsize (KiB) 1046772

[startup+177.704 s]
/proc/loadavg: 1.05 1.05 1.03 1/72 25032
/proc/meminfo: memFree=9032/1022884 swapFree=0/0
[pid=25018] ppid=25017 vsize=9168 CPUtime=0
/proc/25018/stat : 25018 (p2cudf-full-1.1) S 25017 25018 32685 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 41718519 9388032 330 18446744073709551615 4194304 5129932 140734804989440 140734804987584 140268461253726 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/25018/statm: 2292 330 280 229 0 52 0
[pid=25021] ppid=25018 vsize=0 CPUtime=175.09
/proc/25021/stat : 25021 (java) Z 25018 25018 32685 0 -1 4203532 169148 0 18 0 17436 73 0 0 20 0 2 0 41718522 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 4 0 0
/proc/25021/statm: 0 0 0 0 0 0 0
[pid=25021/tid=25032] ppid=25018 vsize=0 CPUtime=0.13
/proc/25021/task/25032/stat : 25032 (java) R 25018 25018 32685 0 -1 4203588 8 0 0 0 6 7 0 0 20 0 2 0 41736223 0 0 18446744073709551615 0 0 0 0 0 0 4 0 16800975 18446744073709551615 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 175.09
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 177.744
CPU time (s): 175.143
CPU user time (s): 174.363
CPU system time (s): 0.780048
CPU usage (%): 98.5367
Max. virtual memory (cumulated for all children) (KiB): 1061200

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 174.363
system time used= 0.780048
maximum resident set size= 619744
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 169907
page faults= 21
swaps= 0
block input operations= 70640
block output operations= 400
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 4801
involuntary context switches= 8363

runsolver used 0.536033 second user time and 1.24408 second system time

The end