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 150 -d 10 -w /tmp/misc2012/2012-09-02-17:21/basic/p2cudf-basic-1.15/paranoid-size/install/rand96.cudf.log.runsolver /home/competition/p2cudf-basic-1.15/p2cudf-basic-1.15 /home/competition/data/install/rand96.cudf /tmp/misc2012/2012-09-02-17:21/basic/p2cudf-basic-1.15/paranoid-size/install/rand96.cudf.result -count(removed),-sum(solution,installedsize),-count(changed) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 150 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 180 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.02 1.04 0.94 2/65 7729
/proc/meminfo: memFree=653276/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 425 0 0 0 0 0 0 0 20 0 1 0 37230709 9388032 325 18446744073709551615 4194304 5129932 140735211690992 140735211688664 139877736609568 0 0 16781316 65536 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 325 275 229 0 52 0

[startup+0.145065 s]
/proc/loadavg: 1.02 1.04 0.94 2/65 7729
/proc/meminfo: memFree=653276/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200311 s]
/proc/loadavg: 1.02 1.04 0.94 2/65 7729
/proc/meminfo: memFree=653276/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300302 s]
/proc/loadavg: 1.02 1.04 0.94 2/65 7729
/proc/meminfo: memFree=653276/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700233 s]
/proc/loadavg: 1.02 1.04 0.94 2/65 7729
/proc/meminfo: memFree=653276/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50073 s]
/proc/loadavg: 1.18 1.07 0.95 4/76 7741
/proc/meminfo: memFree=600976/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113228 CPUtime=1.47
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 34597 0 0 0 129 18 0 0 20 0 10 0 37230710 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278307 30509 2345 9 0 265657 0
[pid=7732/tid=7733] ppid=7729 vsize=1113228 CPUtime=0.68
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 14846 0 0 0 60 8 0 0 20 0 10 0 37230711 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989619937952 139989517457777 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113228 CPUtime=0
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 37230713 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113228 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 37230714 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113228 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 37230714 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113228 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 37230717 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113228 CPUtime=0.37
/proc/7732/task/7738/stat : 7738 (java) R 7729 7729 32685 0 -1 4202560 9343 0 0 0 32 5 0 0 20 0 10 0 37230717 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989508358952 139989599919347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113228 CPUtime=0.39
/proc/7732/task/7739/stat : 7739 (java) R 7729 7729 32685 0 -1 4202560 9115 0 0 0 35 4 0 0 20 0 10 0 37230717 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989507308696 139989598984596 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113228 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 37230717 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113228 CPUtime=0
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 37230718 1139945472 30509 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 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) 1122396

[startup+3.10076 s]
/proc/loadavg: 1.18 1.07 0.95 4/76 7741
/proc/meminfo: memFree=498924/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1112100 CPUtime=3.04
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 76528 0 0 0 273 31 0 0 20 0 10 0 37230710 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278025 71330 2365 9 0 265375 0
[pid=7732/tid=7733] ppid=7729 vsize=1112100 CPUtime=1.56
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47408 0 0 0 138 18 0 0 20 0 10 0 37230711 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989619937984 139989517820822 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1112100 CPUtime=0.17
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 7949 0 0 0 13 4 0 0 20 0 10 0 37230713 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 37230714 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 37230714 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 37230717 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1112100 CPUtime=0.63
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10047 0 0 0 58 5 0 0 20 0 10 0 37230717 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1112100 CPUtime=0.66
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 9831 0 0 0 62 4 0 0 20 0 10 0 37230717 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 37230717 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 37230718 1138790400 71330 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.04
Current children cumulated vsize (KiB) 1121268

[startup+6.30083 s]
/proc/loadavg: 1.18 1.07 0.95 2/76 7741
/proc/meminfo: memFree=186444/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1112100 CPUtime=6.12
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 129877 0 0 0 562 50 0 0 20 0 10 0 37230710 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278025 123538 2367 9 0 265375 0
[pid=7732/tid=7733] ppid=7729 vsize=1112100 CPUtime=3.36
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47412 0 0 0 316 20 0 0 20 0 10 0 37230711 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989619937984 139989517611046 0 4 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1112100 CPUtime=1.37
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 61288 0 0 0 117 20 0 0 20 0 10 0 37230713 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 37230714 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 37230714 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 37230717 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1112100 CPUtime=0.66
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10047 0 0 0 61 5 0 0 20 0 10 0 37230717 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1112100 CPUtime=0.69
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 9836 0 0 0 65 4 0 0 20 0 10 0 37230717 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 37230717 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1112100 CPUtime=0
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 37230718 1138790400 123538 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.12
Current children cumulated vsize (KiB) 1121268

[startup+12.7006 s]
/proc/loadavg: 1.31 1.10 0.96 2/77 7742
/proc/meminfo: memFree=38628/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=12.44
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 154178 0 0 0 1184 60 0 0 20 0 11 0 37230710 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 146984 2381 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=6.85
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47899 0 0 0 663 22 0 0 20 0 11 0 37230711 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989619943640 139989518756090 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=1.94
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 83841 0 0 0 166 28 0 0 20 0 11 0 37230713 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.79
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 173 6 0 0 20 0 11 0 37230717 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=1.83
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10956 0 0 0 178 5 0 0 20 0 11 0 37230717 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230718 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 146984 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.44
Current children cumulated vsize (KiB) 1122296

[startup+25.5008 s]
/proc/loadavg: 1.26 1.10 0.96 2/77 7742
/proc/meminfo: memFree=9352/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=25.12
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 161883 0 0 0 2450 62 0 0 20 0 11 0 37230710 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 154689 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=16.98
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 1676 22 0 0 20 0 11 0 37230711 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989619945432 139989518373253 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=4.16
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 91510 0 0 0 387 29 0 0 20 0 11 0 37230713 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.86
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 180 6 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.1
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 205 5 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.01
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 1 0 0 0 20 0 11 0 37230718 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.12
Current children cumulated vsize (KiB) 1122296

[startup+51.1007 s]
/proc/loadavg: 1.16 1.08 0.96 2/77 7742
/proc/meminfo: memFree=9228/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=50.48
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 161887 0 0 0 4986 62 0 0 20 0 11 0 37230710 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 154689 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=38.13
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 3791 22 0 0 20 0 11 0 37230711 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989619945432 139989518364088 0 4 0 16800975 0 0 0 -1 0 0 0 13 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=8.31
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 91511 0 0 0 801 30 0 0 20 0 11 0 37230713 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.02
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 4 0 0 0 2 0 0 0 20 0 11 0 37230718 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 154689 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.48
Current children cumulated vsize (KiB) 1122296

[startup+102.301 s]
/proc/loadavg: 1.07 1.07 0.96 2/77 7742
/proc/meminfo: memFree=10208/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=101.15
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 163483 0 0 0 10053 62 0 0 20 0 11 0 37230710 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 156281 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=83.78
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 8356 22 0 0 20 0 11 0 37230711 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989619945400 139989518567494 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=13.31
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 93104 0 0 0 1301 30 0 0 20 0 11 0 37230713 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.05
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 7 0 0 0 5 0 0 0 20 0 11 0 37230718 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.15
Current children cumulated vsize (KiB) 1122296

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

[startup+102.408 s]
/proc/loadavg: 1.07 1.07 0.96 2/77 7742
/proc/meminfo: memFree=10208/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=101.26
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 163483 0 0 0 10064 62 0 0 20 0 11 0 37230710 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 156281 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=83.89
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 8367 22 0 0 20 0 11 0 37230711 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989619945400 139989518748949 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=13.31
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 93104 0 0 0 1301 30 0 0 20 0 11 0 37230713 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.05
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 7 0 0 0 5 0 0 0 20 0 11 0 37230718 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 156281 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.26
Current children cumulated vsize (KiB) 1122296

[startup+128.001 s]
/proc/loadavg: 1.04 1.06 0.96 2/77 7742
/proc/meminfo: memFree=9836/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=126.64
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 163681 0 0 0 12601 63 0 0 20 0 11 0 37230710 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 156475 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=107.09
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 10687 22 0 0 20 0 11 0 37230711 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989619945432 139989518364142 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=15.47
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 93299 0 0 0 1517 30 0 0 20 0 11 0 37230713 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.06
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 10 0 0 0 6 0 0 0 20 0 11 0 37230718 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 156475 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 126.64
Current children cumulated vsize (KiB) 1122296

[startup+140.801 s]
/proc/loadavg: 1.19 1.09 0.97 3/78 7812
/proc/meminfo: memFree=9952/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=137.06
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 164540 0 0 0 13642 64 0 0 20 0 11 0 37230710 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 157331 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=116.77
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 11655 22 0 0 20 0 11 0 37230711 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989619945432 139989518567065 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=16.2
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 94155 0 0 0 1590 30 0 0 20 0 11 0 37230713 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.07
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 13 0 0 0 6 1 0 0 20 0 11 0 37230718 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 137.06
Current children cumulated vsize (KiB) 1122296

[startup+147.201 s]
/proc/loadavg: 1.17 1.09 0.97 2/73 7854
/proc/meminfo: memFree=15952/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=142.78
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 164540 0 0 0 14214 64 0 0 20 0 11 0 37230710 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 157331 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=122.48
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 12226 22 0 0 20 0 11 0 37230711 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989619945432 139989518504730 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=16.2
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 94155 0 0 0 1590 30 0 0 20 0 11 0 37230713 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.07
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 13 0 0 0 6 1 0 0 20 0 11 0 37230718 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 142.78
Current children cumulated vsize (KiB) 1122296

[startup+148.801 s]
/proc/loadavg: 1.17 1.09 0.97 2/74 7859
/proc/meminfo: memFree=14828/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=144.37
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 164540 0 0 0 14373 64 0 0 20 0 11 0 37230710 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 157331 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=124.07
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 12385 22 0 0 20 0 11 0 37230711 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989619945432 139989518373116 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=16.2
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 94155 0 0 0 1590 30 0 0 20 0 11 0 37230713 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.07
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 13 0 0 0 6 1 0 0 20 0 11 0 37230718 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 144.37
Current children cumulated vsize (KiB) 1122296

[startup+150.401 s]
/proc/loadavg: 1.17 1.09 0.97 3/73 7874
/proc/meminfo: memFree=15192/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1113128 CPUtime=145.36
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 164541 0 0 0 14472 64 0 0 20 0 11 0 37230710 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278282 157331 2393 9 0 265632 0
[pid=7732/tid=7733] ppid=7729 vsize=1113128 CPUtime=124.32
/proc/7732/task/7733/stat : 7733 (java) R 7729 7729 32685 0 -1 4202560 47902 0 0 0 12410 22 0 0 20 0 11 0 37230711 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989619945432 139989518227359 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1113128 CPUtime=16.94
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 94156 0 0 0 1664 30 0 0 20 0 11 0 37230713 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1113128 CPUtime=1.87
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 181 6 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1113128 CPUtime=2.12
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 207 5 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1113128 CPUtime=0.07
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 13 0 0 0 6 1 0 0 20 0 11 0 37230718 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7742] ppid=7729 vsize=1113128 CPUtime=0
/proc/7732/task/7742/stat : 7742 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37231757 1139843072 157331 18446744073709551615 4194304 4228012 140735489131104 139989504014176 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 145.36
Current children cumulated vsize (KiB) 1122296

[startup+150.805 s]
/proc/loadavg: 1.16 1.09 0.97 1/73 7922
/proc/meminfo: memFree=14704/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1114156 CPUtime=145.46
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 164555 0 0 0 14482 64 0 0 20 0 11 0 37230710 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278539 157343 2393 9 0 265889 0
[pid=7732/tid=7733] ppid=7729 vsize=1114156 CPUtime=124.38
/proc/7732/task/7733/stat : 7733 (java) S 7729 7729 32685 0 -1 4202560 47910 0 0 0 12416 22 0 0 20 0 11 0 37230711 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989619946416 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1114156 CPUtime=16.94
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 94156 0 0 0 1664 30 0 0 20 0 11 0 37230713 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1114156 CPUtime=1.9
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 184 6 0 0 20 0 11 0 37230717 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1114156 CPUtime=2.13
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 208 5 0 0 20 0 11 0 37230717 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1114156 CPUtime=0.07
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 13 0 0 0 6 1 0 0 20 0 11 0 37230718 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7912] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7912/stat : 7912 (java) S 7729 7729 32685 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 37245764 1140895744 157343 18446744073709551615 4194304 4228012 140735489131104 139989502961840 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 145.46
Current children cumulated vsize (KiB) 1123324

[startup+151.201 s]
/proc/loadavg: 1.16 1.09 0.97 1/73 7922
/proc/meminfo: memFree=14704/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=1114156 CPUtime=145.54
/proc/7732/stat : 7732 (java) S 7729 7729 32685 0 -1 4202496 164557 0 0 0 14487 67 0 0 20 0 11 0 37230710 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 140735489122128 139989613411957 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 278539 157345 2393 9 0 265889 0
[pid=7732/tid=7733] ppid=7729 vsize=1114156 CPUtime=124.38
/proc/7732/task/7733/stat : 7733 (java) S 7729 7729 32685 0 -1 4202560 47910 0 0 0 12416 22 0 0 20 0 11 0 37230711 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989619946416 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=7732/tid=7734] ppid=7729 vsize=1114156 CPUtime=16.94
/proc/7732/task/7734/stat : 7734 (java) S 7729 7729 32685 0 -1 4202560 94156 0 0 0 1664 30 0 0 20 0 11 0 37230713 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989512584320 139989613426251 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7735] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7735/stat : 7735 (java) S 7729 7729 32685 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 37230714 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989511530512 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7736] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7736/stat : 7736 (java) S 7729 7729 32685 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 37230714 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989510477728 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7737] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7737/stat : 7737 (java) S 7729 7729 32685 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 37230717 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989509426160 139989613433888 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7738] ppid=7729 vsize=1114156 CPUtime=1.91
/proc/7732/task/7738/stat : 7738 (java) S 7729 7729 32685 0 -1 4202560 10182 0 0 0 185 6 0 0 20 0 11 0 37230717 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989508373520 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7739] ppid=7729 vsize=1114156 CPUtime=2.15
/proc/7732/task/7739/stat : 7739 (java) S 7729 7729 32685 0 -1 4202560 10989 0 0 0 210 5 0 0 20 0 11 0 37230717 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989507320848 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7740] ppid=7729 vsize=1114156 CPUtime=0
/proc/7732/task/7740/stat : 7740 (java) S 7729 7729 32685 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 37230717 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989506268368 139989613425364 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7741] ppid=7729 vsize=1114156 CPUtime=0.07
/proc/7732/task/7741/stat : 7741 (java) S 7729 7729 32685 0 -1 4202560 13 0 0 0 6 1 0 0 20 0 11 0 37230718 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989505215872 139989613426251 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=7732/tid=7912] ppid=7729 vsize=1114156 CPUtime=0.05
/proc/7732/task/7912/stat : 7912 (java) R 7729 7729 32685 0 -1 4202560 8 0 0 0 2 3 0 0 20 0 11 0 37245764 1140895744 157345 18446744073709551615 4194304 4228012 140735489131104 139989502952752 139989517463549 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 145.54
Current children cumulated vsize (KiB) 1123324

[startup+151.301 s]
/proc/loadavg: 1.16 1.09 0.97 1/73 7922
/proc/meminfo: memFree=14704/1022884 swapFree=0/0
[pid=7729] ppid=7728 vsize=9168 CPUtime=0
/proc/7729/stat : 7729 (p2cudf-basic-1.) S 7728 7729 32685 0 -1 4202496 457 291 0 0 0 0 0 0 20 0 1 0 37230709 9388032 330 18446744073709551615 4194304 5129932 140735211690992 140735211689136 139877736465502 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/7729/statm: 2292 330 280 229 0 52 0
[pid=7732] ppid=7729 vsize=0 CPUtime=145.6
/proc/7732/stat : 7732 (java) Z 7729 7729 32685 0 -1 4203532 164568 0 0 0 14489 71 0 0 20 0 2 0 37230710 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/7732/statm: 0 0 0 0 0 0 0
[pid=7732/tid=7912] ppid=7729 vsize=0 CPUtime=0.11
/proc/7732/task/7912/stat : 7912 (java) R 7729 7729 32685 0 -1 4203588 8 0 0 0 4 7 0 0 20 0 2 0 37245764 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) 145.6
Current children cumulated vsize (KiB) 9168

Child status: 0
Real time (s): 151.329
CPU time (s): 145.629
CPU user time (s): 144.905
CPU system time (s): 0.724045
CPU usage (%): 96.2337
Max. virtual memory (cumulated for all children) (KiB): 1125068

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 144.905
system time used= 0.724045
maximum resident set size= 629416
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 165329
page faults= 0
swaps= 0
block input operations= 68424
block output operations= 368
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 4331
involuntary context switches= 9732

runsolver used 0.388024 second user time and 0.936058 second system time

The end