runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201012070034/p2cudf-trendy-1.9/rand6b4d6e.cudf.impossible.log.runsolver ./p2cudf-trendy-1.9 /home/misc2010/data/2010/impossible//rand6b4d6e.cudf /home/misc2010/tmp/201012070034/p2cudf-trendy-1.9/rand6b4d6e.cudf.impossible.result 

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


[startup+0 s]
/proc/loadavg: 1.00 1.03 1.00 1/40 16848
/proc/meminfo: memFree=774428/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=3024 CPUtime=0
/proc/16848/stat : 16848 (runsolver) D 16847 16848 4159 34819 4229 4202560 72 0 0 0 0 0 0 0 24 0 1 0 880666835 3096576 94 1283457024 134512640 134586868 4294361296 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/16848/statm: 756 94 62 19 0 54 0

[startup+0.134585 s]
/proc/loadavg: 1.00 1.03 1.00 1/40 16848
/proc/meminfo: memFree=774428/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.206603 s]
/proc/loadavg: 1.00 1.03 1.00 1/40 16848
/proc/meminfo: memFree=774428/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.318677 s]
/proc/loadavg: 1.00 1.03 1.00 1/40 16848
/proc/meminfo: memFree=774428/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.706698 s]
/proc/loadavg: 1.00 1.03 1.00 1/40 16848
/proc/meminfo: memFree=774428/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+1.50666 s]
/proc/loadavg: 1.00 1.03 1.00 1/43 16862
/proc/meminfo: memFree=755356/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=855248 CPUtime=0.03
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 3095 0 144 0 3 0 0 0 18 0 10 0 880666920 875773952 2940 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 213812 2940 1335 10 0 210930 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 860396

[startup+3.1072 s]
/proc/loadavg: 1.00 1.03 1.00 4/52 16871
/proc/meminfo: memFree=731876/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871444 CPUtime=1.29
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 19174 0 153 0 120 9 0 0 18 0 10 0 880666920 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217861 15380 1742 10 0 214951 0
[pid=16862/tid=16863] ppid=16850 vsize=871444 CPUtime=0.39
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 10046 0 60 0 34 5 0 0 18 0 10 0 880666948 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4095221572 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871444 CPUtime=0
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 15 0 10 0 880666963 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871444 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 19 0 10 0 880666964 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871444 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 20 0 10 0 880666964 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871444 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 10 0 880666975 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871444 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 10 0 880666975 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871444 CPUtime=0.74
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 7465 0 2 0 70 4 0 0 16 0 10 0 880666975 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871444 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 10 0 880666975 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871444 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 10 0 880666975 892358656 15380 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.29
Current children cumulated vsize (KiB) 876592
heavy processes:

[startup+6.31391 s]
/proc/loadavg: 1.00 1.03 1.00 3/52 16871
/proc/meminfo: memFree=452264/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871576 CPUtime=4.3
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 93363 0 154 0 393 37 0 0 18 0 10 0 880666920 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217894 89570 1763 10 0 214984 0
[pid=16862/tid=16863] ppid=16850 vsize=871576 CPUtime=2.15
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50208 0 60 0 189 26 0 0 21 0 10 0 880666948 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4095513573 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871576 CPUtime=0.79
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 33960 0 0 0 72 7 0 0 16 0 10 0 880666963 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871576 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 18 0 10 0 880666964 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871576 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 10 0 880666964 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871576 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 10 0 880666975 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871576 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 10 0 880666975 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871576 CPUtime=1.2
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 7535 0 3 0 116 4 0 0 16 0 10 0 880666975 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871576 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 10 0 880666975 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871576 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 10 0 880666975 892493824 89570 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 4.3
Current children cumulated vsize (KiB) 876724
heavy processes:

[startup+12.709 s]
/proc/loadavg: 1.08 1.04 1.01 3/53 16873
/proc/meminfo: memFree=347556/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=870552 CPUtime=10.54
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 102972 0 154 0 1013 41 0 0 18 0 11 0 880666920 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217638 95593 1785 10 0 214728 0
[pid=16862/tid=16863] ppid=16850 vsize=870552 CPUtime=6.28
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50372 0 60 0 602 26 0 0 25 0 11 0 880666948 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4096149733 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=870552 CPUtime=0.99
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 39933 0 0 0 89 10 0 0 16 0 11 0 880666963 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=870552 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 18 0 11 0 880666964 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=870552 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 11 0 880666964 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=870552 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=870552 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=870552 CPUtime=3.08
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11003 0 3 0 304 4 0 0 15 0 11 0 880666975 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=870552 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=870552 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16873] ppid=16850 vsize=870552 CPUtime=0
/proc/16862/task/16873/stat : 16873 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880668000 891445248 95593 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 10.54
Current children cumulated vsize (KiB) 875700

[startup+25.5135 s]
/proc/loadavg: 1.14 1.06 1.01 3/53 16891
/proc/meminfo: memFree=311844/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=23.32
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112135 0 154 0 2286 46 0 0 18 0 11 0 880666920 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 104756 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=17.07
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50378 0 60 0 1681 26 0 0 25 0 11 0 880666948 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4096164704 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=2.36
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49037 0 0 0 222 14 0 0 16 0 11 0 880666963 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 18 0 11 0 880666964 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.71
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11048 0 3 0 366 5 0 0 15 0 11 0 880666975 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16891] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16891/stat : 16891 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 24 0 11 0 880669062 892108800 104756 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 23.32
Current children cumulated vsize (KiB) 876348

[startup+51.1113 s]
/proc/loadavg: 1.09 1.05 1.01 2/53 16896
/proc/meminfo: memFree=309612/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=48.89
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112398 0 154 0 4841 48 0 0 18 0 11 0 880666920 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105019 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=40.71
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50378 0 60 0 4044 27 0 0 25 0 11 0 880666948 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4096149815 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=4.22
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 408 14 0 0 15 0 11 0 880666963 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.78
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11054 0 3 0 373 5 0 0 15 0 11 0 880666975 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) R 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16896] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16896/stat : 16896 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880669895 892108800 105019 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 48.89
Current children cumulated vsize (KiB) 876348

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

[startup+63.8051 s]
/proc/loadavg: 1.07 1.05 1.01 2/53 16900
/proc/meminfo: memFree=309488/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=61.56
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112402 0 154 0 6108 48 0 0 18 0 11 0 880666920 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105023 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=52.76
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50378 0 60 0 5249 27 0 0 25 0 11 0 880666948 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4096194113 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=4.79
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 465 14 0 0 16 0 11 0 880666963 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.82
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11058 0 3 0 377 5 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16900] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16900/stat : 16900 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880673169 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 61.56
Current children cumulated vsize (KiB) 876348

[startup+70.2072 s]
/proc/loadavg: 1.15 1.06 1.01 2/53 16900
/proc/meminfo: memFree=309488/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=67.96
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112402 0 154 0 6748 48 0 0 18 0 11 0 880666920 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105023 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=58.58
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50378 0 60 0 5831 27 0 0 25 0 11 0 880666948 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4096194113 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=5.37
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 523 14 0 0 15 0 11 0 880666963 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.82
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11058 0 3 0 377 5 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16900] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16900/stat : 16900 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880673169 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 67.96
Current children cumulated vsize (KiB) 876348

[startup+76.6088 s]
/proc/loadavg: 1.13 1.06 1.01 2/53 16900
/proc/meminfo: memFree=309488/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=74.35
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112402 0 154 0 7387 48 0 0 18 0 11 0 880666920 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105023 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=64.97
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50378 0 60 0 6470 27 0 0 25 0 11 0 880666948 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4096099145 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=5.37
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 523 14 0 0 15 0 11 0 880666963 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.82
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11058 0 3 0 377 5 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16900] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16900/stat : 16900 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880673169 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 74.35
Current children cumulated vsize (KiB) 876348

[startup+79.8095 s]
/proc/loadavg: 1.12 1.06 1.01 2/53 16900
/proc/meminfo: memFree=309488/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=77.55
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112402 0 154 0 7707 48 0 0 18 0 11 0 880666920 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105023 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=68.17
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50378 0 60 0 6790 27 0 0 25 0 11 0 880666948 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4096194271 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=5.37
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 523 14 0 0 15 0 11 0 880666963 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.82
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11058 0 3 0 377 5 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) R 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16900] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16900/stat : 16900 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880673169 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 77.55
Current children cumulated vsize (KiB) 876348

[startup+81.41 s]
/proc/loadavg: 1.12 1.06 1.01 2/53 16900
/proc/meminfo: memFree=309488/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=79.14
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112402 0 154 0 7866 48 0 0 18 0 11 0 880666920 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105023 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=69.76
/proc/16862/task/16863/stat : 16863 (java) R 16850 16848 4159 34819 4229 4202560 50378 0 60 0 6949 27 0 0 25 0 11 0 880666948 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4096149733 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=5.37
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 523 14 0 0 15 0 11 0 880666963 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.82
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11058 0 3 0 377 5 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16900] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16900/stat : 16900 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880673169 892108800 105023 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.14
Current children cumulated vsize (KiB) 876348

[startup+82.2037 s]
/proc/loadavg: 1.12 1.06 1.01 2/53 16900
/proc/meminfo: memFree=309488/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=79.87
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112411 0 154 0 7939 48 0 0 18 0 11 0 880666920 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105032 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=70.45
/proc/16862/task/16863/stat : 16863 (java) S 16850 16848 4159 34819 4229 4202560 50384 0 60 0 7018 27 0 0 25 0 11 0 880666948 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=5.37
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 523 14 0 0 15 0 11 0 880666963 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.86
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11061 0 3 0 381 5 0 0 16 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) R 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.87
Current children cumulated vsize (KiB) 876348

[startup+82.6078 s]
/proc/loadavg: 1.11 1.06 1.01 1/53 16901
/proc/meminfo: memFree=309364/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=79.87
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112411 0 154 0 7939 48 0 0 18 0 11 0 880666920 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105032 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=70.45
/proc/16862/task/16863/stat : 16863 (java) S 16850 16848 4159 34819 4229 4202560 50384 0 60 0 7018 27 0 0 25 0 11 0 880666948 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=5.37
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 523 14 0 0 15 0 11 0 880666963 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.86
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11061 0 3 0 381 5 0 0 16 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16901] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16901/stat : 16901 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 880675051 892108800 105032 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.87
Current children cumulated vsize (KiB) 876348

[startup+82.7129 s]
/proc/loadavg: 1.11 1.06 1.01 1/53 16901
/proc/meminfo: memFree=309364/1048576 swapFree=2080268/2097144
[pid=16848] ppid=16847 vsize=2572 CPUtime=0
/proc/16848/stat : 16848 (p2cudf-trendy-1) S 16847 16848 4159 34819 4229 4202496 376 0 2 0 0 0 0 0 25 0 1 0 880666835 2633728 274 1283457024 134512640 135304128 4290344384 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16848/statm: 643 274 233 194 0 29 0
[pid=16850] ppid=16848 vsize=2576 CPUtime=0
/proc/16850/stat : 16850 (p2cudf) S 16848 16848 4159 34819 4229 4202496 391 2856 2 136 0 0 0 0 18 0 1 0 880666837 2637824 282 1283457024 134512640 135304128 4291784464 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/16850/statm: 644 282 241 194 0 30 0
[pid=16862] ppid=16850 vsize=871200 CPUtime=79.91
/proc/16862/stat : 16862 (java) S 16850 16848 4159 34819 4229 4202496 112412 0 154 0 7943 48 0 0 18 0 11 0 880666920 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/16862/statm: 217800 105033 1794 10 0 214890 0
[pid=16862/tid=16863] ppid=16850 vsize=871200 CPUtime=70.45
/proc/16862/task/16863/stat : 16863 (java) S 16850 16848 4159 34819 4229 4202560 50384 0 60 0 7018 27 0 0 25 0 11 0 880666948 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16864] ppid=16850 vsize=871200 CPUtime=5.37
/proc/16862/task/16864/stat : 16864 (java) S 16850 16848 4159 34819 4229 4202560 49294 0 0 0 523 14 0 0 15 0 11 0 880666963 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 0 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16865] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16865/stat : 16865 (java) S 16850 16848 4159 34819 4229 4202560 8 0 1 0 0 0 0 0 15 0 11 0 880666964 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16866] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16866/stat : 16866 (java) S 16850 16848 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 880666964 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16867] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16867/stat : 16867 (java) S 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 20 0 11 0 880666975 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16868] ppid=16850 vsize=871200 CPUtime=0.16
/proc/16862/task/16868/stat : 16868 (java) S 16850 16848 4159 34819 4229 4202560 635 0 7 0 16 0 0 0 16 0 11 0 880666975 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16869] ppid=16850 vsize=871200 CPUtime=3.87
/proc/16862/task/16869/stat : 16869 (java) S 16850 16848 4159 34819 4229 4202560 11061 0 3 0 382 5 0 0 15 0 11 0 880666975 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16870] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16870/stat : 16870 (java) S 16850 16848 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 21 0 11 0 880666975 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 18446612133393159168 0 0 -1 0 0 0 0
[pid=16862/tid=16871] ppid=16850 vsize=871200 CPUtime=0
/proc/16862/task/16871/stat : 16871 (java) R 16850 16848 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 15 0 11 0 880666975 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=16862/tid=16901] ppid=16850 vsize=871200 CPUtime=0.03
/proc/16862/task/16901/stat : 16901 (java) R 16850 16848 4159 34819 4229 4202560 1 0 0 0 3 0 0 0 20 0 11 0 880675051 892108800 105033 1283457024 134512640 134550932 4291001584 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 79.91
Current children cumulated vsize (KiB) 876348

Child status: 0
Real time (s): 82.7931
CPU time (s): 79.961
CPU user time (s): 79.441
CPU system time (s): 0.520032
CPU usage (%): 96.5793
Max. virtual memory (cumulated for all children) (KiB): 881648

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 79.441
system time used= 0.520032
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 116058
page faults= 294
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 4042
involuntary context switches= 3837

runsolver used 0.008 second user time and 0 second system time

The end