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/easy/rand308.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/easy/rand308.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/trendy-size/upgrade/easy/rand308.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.28 1.09 1.02 2/60 24877
/proc/meminfo: memFree=621648/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=3152 CPUtime=0
/proc/24877/stat : 24877 (runsolver) R 24876 32685 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 41636942 3227648 32 18446744073709551615 134512640 134586868 4291837616 4291835664 4151501872 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 788 32 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.137942 s]
/proc/loadavg: 1.28 1.09 1.02 2/60 24877
/proc/meminfo: memFree=621648/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200285 s]
/proc/loadavg: 1.28 1.09 1.02 2/60 24877
/proc/meminfo: memFree=621648/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300276 s]
/proc/loadavg: 1.28 1.09 1.02 2/60 24877
/proc/meminfo: memFree=621648/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.70022 s]
/proc/loadavg: 1.28 1.09 1.02 2/60 24877
/proc/meminfo: memFree=621648/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50061 s]
/proc/loadavg: 1.28 1.09 1.02 4/71 24889
/proc/meminfo: memFree=503132/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1075692 CPUtime=1.47
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 44874 0 0 0 131 16 0 0 20 0 10 0 41636943 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 268923 39868 2345 9 0 256273 0
[pid=24880/tid=24881] ppid=24877 vsize=1075692 CPUtime=0.63
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 23583 0 0 0 54 9 0 0 20 0 10 0 41636944 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722317136576 139722214943459 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 41636945 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 41636946 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 41636946 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41636948 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1075692 CPUtime=0.42
/proc/24880/task/24886/stat : 24886 (java) R 24877 24877 32685 0 -1 4202560 10391 0 0 0 39 3 0 0 20 0 10 0 41636948 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722205557816 139722296273299 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1075692 CPUtime=0.4
/proc/24880/task/24887/stat : 24887 (java) R 24877 24877 32685 0 -1 4202560 9608 0 0 0 37 3 0 0 20 0 10 0 41636948 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722204504808 139722296067523 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41636948 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41636948 1101508608 39868 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.47
Current children cumulated vsize (KiB) 1084860

[startup+3.10077 s]
/proc/loadavg: 1.28 1.09 1.02 2/71 24889
/proc/meminfo: memFree=329904/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1075692 CPUtime=2.99
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 98008 0 0 0 266 33 0 0 20 0 10 0 41636943 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 268923 93001 2366 9 0 256273 0
[pid=24880/tid=24881] ppid=24877 vsize=1075692 CPUtime=1.53
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47409 0 0 0 134 19 0 0 20 0 10 0 41636944 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722317136576 139722215215754 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1075692 CPUtime=0.46
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 29274 0 0 0 39 7 0 0 20 0 10 0 41636945 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 41636946 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 41636946 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41636948 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1075692 CPUtime=0.5
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10420 0 0 0 47 3 0 0 20 0 10 0 41636948 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1075692 CPUtime=0.47
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 9612 0 0 0 44 3 0 0 20 0 10 0 41636948 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41636948 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1075692 CPUtime=0
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41636948 1101508608 93001 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.99
Current children cumulated vsize (KiB) 1084860

[startup+6.30058 s]
/proc/loadavg: 1.26 1.08 1.02 3/71 24897
/proc/meminfo: memFree=134704/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1077380 CPUtime=6.11
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 127816 0 0 0 570 41 0 0 20 0 10 0 41636943 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 269345 121045 2374 9 0 256695 0
[pid=24880/tid=24881] ppid=24877 vsize=1077380 CPUtime=3.03
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47710 0 0 0 282 21 0 0 20 0 10 0 41636944 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722317144264 139722214636059 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1077380 CPUtime=1.08
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 53197 0 0 0 95 13 0 0 20 0 10 0 41636945 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1077380 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 41636946 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1077380 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 41636946 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1077380 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41636948 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1077380 CPUtime=0.93
/proc/24880/task/24886/stat : 24886 (java) R 24877 24877 32685 0 -1 4202560 10593 0 0 0 90 3 0 0 20 0 10 0 41636948 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722205571856 139722294441359 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1077380 CPUtime=1.05
/proc/24880/task/24887/stat : 24887 (java) R 24877 24877 32685 0 -1 4202560 15022 0 0 0 101 4 0 0 20 0 10 0 41636948 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722204507016 139722294914934 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1077380 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 41636948 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1077380 CPUtime=0
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 41636948 1103237120 121045 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.11
Current children cumulated vsize (KiB) 1086548

[startup+12.7006 s]
/proc/loadavg: 1.24 1.08 1.02 2/72 24898
/proc/meminfo: memFree=132588/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=12.45
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 129143 0 0 0 1203 42 0 0 20 0 11 0 41636943 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 118501 2381 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=8.11
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47793 0 0 0 789 22 0 0 20 0 11 0 41636944 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722317144184 139722215689977 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=1.1
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 53198 0 0 0 96 14 0 0 20 0 11 0 41636945 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.56
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10686 0 0 0 153 3 0 0 20 0 11 0 41636948 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.67
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16166 0 0 0 163 4 0 0 20 0 11 0 41636948 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 118501 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.45
Current children cumulated vsize (KiB) 1076388

[startup+25.5006 s]
/proc/loadavg: 1.26 1.09 1.02 2/72 24898
/proc/meminfo: memFree=92784/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=25.14
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 139683 0 0 0 2470 44 0 0 20 0 11 0 41636943 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 129041 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=19.48
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 1926 22 0 0 20 0 11 0 41636944 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215690092 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=2.35
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 63727 0 0 0 220 15 0 0 20 0 11 0 41636945 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.6
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 157 3 0 0 20 0 11 0 41636948 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.69
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 165 4 0 0 20 0 11 0 41636948 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.01
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 1 0 0 20 0 11 0 41636948 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 129041 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.14
Current children cumulated vsize (KiB) 1076388

[startup+51.1007 s]
/proc/loadavg: 1.17 1.08 1.02 2/72 24898
/proc/meminfo: memFree=89436/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=50.53
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 139996 0 0 0 5009 44 0 0 20 0 11 0 41636943 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 129350 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=43.55
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 4333 22 0 0 20 0 11 0 41636944 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215152299 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=3.61
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 64037 0 0 0 346 15 0 0 20 0 11 0 41636945 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.72
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 168 4 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.02
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 4 0 0 0 0 2 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.53
Current children cumulated vsize (KiB) 1076388

[startup+102.301 s]
/proc/loadavg: 1.07 1.07 1.02 2/72 24898
/proc/meminfo: memFree=89312/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=101.29
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 140000 0 0 0 10085 44 0 0 20 0 11 0 41636943 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 129350 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=92.54
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 9232 22 0 0 20 0 11 0 41636944 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215724231 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=5.36
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 64038 0 0 0 521 15 0 0 20 0 11 0 41636945 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.72
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 168 4 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.05
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 7 0 0 0 0 5 0 0 20 0 11 0 41636948 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 129350 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.29
Current children cumulated vsize (KiB) 1076388

[startup+162.301 s]
/proc/loadavg: 1.02 1.05 1.01 2/72 24898
/proc/meminfo: memFree=81872/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=160.77
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 141810 0 0 0 16032 45 0 0 20 0 11 0 41636943 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 131152 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=150.22
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 15000 22 0 0 20 0 11 0 41636944 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215724125 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=7.12
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 65842 0 0 0 697 15 0 0 20 0 11 0 41636945 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.72
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 168 4 0 0 20 0 11 0 41636948 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.08
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 13 0 0 0 0 8 0 0 20 0 11 0 41636948 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 131152 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 160.77
Current children cumulated vsize (KiB) 1076388

[startup+222.304 s]
/proc/loadavg: 1.01 1.04 1.00 2/72 24898
/proc/meminfo: memFree=76912/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=220.25
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 143064 0 0 0 21980 45 0 0 20 0 11 0 41636943 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 132398 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=206.71
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 20649 22 0 0 20 0 11 0 41636944 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722214810340 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=10.06
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 67090 0 0 0 991 15 0 0 20 0 11 0 41636945 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.74
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 170 4 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.11
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 19 0 0 0 0 11 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 220.25
Current children cumulated vsize (KiB) 1076388

[startup+282.301 s]
/proc/loadavg: 1.05 1.05 1.00 2/72 24898
/proc/meminfo: memFree=76912/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=279.73
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 143071 0 0 0 27928 45 0 0 20 0 11 0 41636943 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 132398 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=264.4
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 26418 22 0 0 20 0 11 0 41636944 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215724102 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=11.83
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 67091 0 0 0 1168 15 0 0 20 0 11 0 41636945 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.74
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 170 4 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.14
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 25 0 0 0 0 14 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 279.73
Current children cumulated vsize (KiB) 1076388

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

[startup+288.001 s]
/proc/loadavg: 1.05 1.05 1.00 2/72 24898
/proc/meminfo: memFree=76912/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=285.39
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 143072 0 0 0 28494 45 0 0 20 0 11 0 41636943 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 132398 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=269.47
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 26925 22 0 0 20 0 11 0 41636944 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215724486 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=12.4
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 67092 0 0 0 1225 15 0 0 20 0 11 0 41636945 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.74
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 170 4 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.15
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 25 0 0 0 0 15 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 285.39
Current children cumulated vsize (KiB) 1076388

[startup+291.201 s]
/proc/loadavg: 1.04 1.05 1.00 2/72 24898
/proc/meminfo: memFree=76912/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=288.56
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 143072 0 0 0 28811 45 0 0 20 0 11 0 41636943 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 132398 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=272.64
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 27242 22 0 0 20 0 11 0 41636944 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215690092 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=12.4
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 67092 0 0 0 1225 15 0 0 20 0 11 0 41636945 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.74
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 170 4 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.15
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 25 0 0 0 0 15 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 288.56
Current children cumulated vsize (KiB) 1076388

[startup+292.001 s]
/proc/loadavg: 1.04 1.05 1.00 2/72 24898
/proc/meminfo: memFree=76912/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1067220 CPUtime=289.35
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 143072 0 0 0 28890 45 0 0 20 0 11 0 41636943 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 266805 132398 2393 9 0 254155 0
[pid=24880/tid=24881] ppid=24877 vsize=1067220 CPUtime=273.43
/proc/24880/task/24881/stat : 24881 (java) R 24877 24877 32685 0 -1 4202560 47795 0 0 0 27321 22 0 0 20 0 11 0 41636944 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722317144136 139722215928000 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1067220 CPUtime=12.4
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 67092 0 0 0 1225 15 0 0 20 0 11 0 41636945 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1067220 CPUtime=1.61
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 158 3 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1067220 CPUtime=1.74
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 170 4 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1067220 CPUtime=0.15
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 25 0 0 0 0 15 0 0 20 0 11 0 41636948 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24898] ppid=24877 vsize=1067220 CPUtime=0
/proc/24880/task/24898/stat : 24898 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41637690 1092833280 132398 18446744073709551615 4194304 4228012 140735525092096 139722201212768 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 289.35
Current children cumulated vsize (KiB) 1076388

[startup+292.801 s]
/proc/loadavg: 1.04 1.05 1.00 1/72 24899
/proc/meminfo: memFree=76912/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=1068248 CPUtime=289.87
/proc/24880/stat : 24880 (java) S 24877 24877 32685 0 -1 4202496 143086 0 0 0 28942 45 0 0 20 0 11 0 41636943 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 140735525083120 139722310610549 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 267062 132410 2393 9 0 254412 0
[pid=24880/tid=24881] ppid=24877 vsize=1068248 CPUtime=273.93
/proc/24880/task/24881/stat : 24881 (java) S 24877 24877 32685 0 -1 4202560 47803 0 0 0 27371 22 0 0 20 0 11 0 41636944 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722317145008 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 9 0 0
[pid=24880/tid=24882] ppid=24877 vsize=1068248 CPUtime=12.4
/proc/24880/task/24882/stat : 24882 (java) S 24877 24877 32685 0 -1 4202560 67092 0 0 0 1225 15 0 0 20 0 11 0 41636945 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722209782912 139722310624843 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24883] ppid=24877 vsize=1068248 CPUtime=0
/proc/24880/task/24883/stat : 24883 (java) S 24877 24877 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 41636946 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722208729104 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24884] ppid=24877 vsize=1068248 CPUtime=0
/proc/24880/task/24884/stat : 24884 (java) S 24877 24877 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 41636946 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722207676320 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24885] ppid=24877 vsize=1068248 CPUtime=0
/proc/24880/task/24885/stat : 24885 (java) S 24877 24877 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 41636948 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722206624752 139722310632480 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24886] ppid=24877 vsize=1068248 CPUtime=1.62
/proc/24880/task/24886/stat : 24886 (java) S 24877 24877 32685 0 -1 4202560 10690 0 0 0 159 3 0 0 20 0 11 0 41636948 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722205572112 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24887] ppid=24877 vsize=1068248 CPUtime=1.75
/proc/24880/task/24887/stat : 24887 (java) S 24877 24877 32685 0 -1 4202560 16171 0 0 0 171 4 0 0 20 0 11 0 41636948 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722204519440 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24888] ppid=24877 vsize=1068248 CPUtime=0
/proc/24880/task/24888/stat : 24888 (java) S 24877 24877 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 41636948 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722203466960 139722310623956 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24889] ppid=24877 vsize=1068248 CPUtime=0.15
/proc/24880/task/24889/stat : 24889 (java) S 24877 24877 32685 0 -1 4202560 25 0 0 0 0 15 0 0 20 0 11 0 41636948 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722202414464 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=24880/tid=24899] ppid=24877 vsize=1068248 CPUtime=0
/proc/24880/task/24899/stat : 24899 (java) S 24877 24877 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 41666194 1093885952 132410 18446744073709551615 4194304 4228012 140735525092096 139722200160432 139722310624843 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 289.87
Current children cumulated vsize (KiB) 1077416

[startup+293.201 s]
/proc/loadavg: 1.04 1.05 1.00 1/72 24899
/proc/meminfo: memFree=76912/1022884 swapFree=0/0
[pid=24877] ppid=24876 vsize=9168 CPUtime=0
/proc/24877/stat : 24877 (p2cudf-full-1.1) S 24876 24877 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 41636942 9388032 331 18446744073709551615 4194304 5129932 140733509367424 140733509365568 140171305981022 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/24877/statm: 2292 331 280 229 0 52 0
[pid=24880] ppid=24877 vsize=0 CPUtime=290.05
/proc/24880/stat : 24880 (java) Z 24877 24877 32685 0 -1 4203532 143100 0 0 0 28953 52 0 0 20 0 2 0 41636943 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/24880/statm: 0 0 0 0 0 0 0
[pid=24880/tid=24899] ppid=24877 vsize=0 CPUtime=0.15
/proc/24880/task/24899/stat : 24899 (java) R 24877 24877 32685 0 -1 4203588 9 0 0 0 7 8 0 0 20 0 2 0 41666194 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) 290.05
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 293.213
CPU time (s): 290.074
CPU user time (s): 289.534
CPU system time (s): 0.540033
CPU usage (%): 98.9296
Max. virtual memory (cumulated for all children) (KiB): 1086548

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 289.534
system time used= 0.540033
maximum resident set size= 529688
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 143860
page faults= 0
swaps= 0
block input operations= 42368
block output operations= 520
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 7106
involuntary context switches= 12307

runsolver used 0.948059 second user time and 1.5801 second system time

The end