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/201012091434/p2cudf-user-1.10/randa223c3.cudf.impossible.log.runsolver ./p2cudf-user-1.10 /home/misc2010/data/2010/impossible//randa223c3.cudf /home/misc2010/tmp/201012091434/p2cudf-user-1.10/randa223c3.cudf.impossible.result -changed,-removed,-unmet_recommends,-new 

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.16 1.04 1.01 3/39 31121
/proc/meminfo: memFree=368744/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) R 31119 31120 25521 34816 25544 4202496 359 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0
/proc/31121/stat : 31121 (p2cudf-user-1.1) R 31120 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 40 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/31121/statm: 644 40 0 194 0 30 0

[startup+0.134657 s]
/proc/loadavg: 1.16 1.04 1.01 3/39 31121
/proc/meminfo: memFree=368744/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+0.204669 s]
/proc/loadavg: 1.16 1.04 1.01 3/39 31121
/proc/meminfo: memFree=368744/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+0.304689 s]
/proc/loadavg: 1.16 1.04 1.01 3/39 31121
/proc/meminfo: memFree=368744/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+0.704743 s]
/proc/loadavg: 1.16 1.04 1.01 3/39 31121
/proc/meminfo: memFree=368744/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5152

[startup+1.5049 s]
/proc/loadavg: 1.16 1.04 1.01 5/50 31143
/proc/meminfo: memFree=324036/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=879560 CPUtime=1.47
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 17739 0 1 0 144 3 0 0 25 0 10 0 900403620 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219890 13417 1732 10 0 216980 0
[pid=31134/tid=31135] ppid=31121 vsize=879560 CPUtime=0.57
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 6518 0 1 0 54 3 0 0 25 0 10 0 900403621 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4094887272 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=879560 CPUtime=0
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 5 0 0 0 0 0 0 0 17 0 10 0 900403623 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=879560 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 9 0 0 0 0 0 0 0 25 0 10 0 900403623 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=879560 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 10 0 900403623 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=879560 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 10 0 900403626 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=879560 CPUtime=0.64
/proc/31134/task/31140/stat : 31140 (java) R 31121 31120 25521 34816 25544 4202560 8851 0 0 0 64 0 0 0 25 0 10 0 900403626 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=879560 CPUtime=0.26
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 1258 0 0 0 26 0 0 0 21 0 10 0 900403626 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=879560 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 10 0 900403626 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=879560 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 10 0 900403626 900669440 13417 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.5
Current children cumulated vsize (KiB) 884712

[startup+3.11534 s]
/proc/loadavg: 1.30 1.07 1.02 3/50 31143
/proc/meminfo: memFree=276452/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878140 CPUtime=3.06
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 64764 0 1 0 278 28 0 0 25 0 10 0 900403620 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219535 58357 1733 10 0 216625 0
[pid=31134/tid=31135] ppid=31121 vsize=878140 CPUtime=1.65
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50249 0 1 0 137 28 0 0 25 0 10 0 900403621 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878140 CPUtime=0.03
/proc/31134/task/31136/stat : 31136 (java) R 31121 31120 25521 34816 25544 4202560 1158 0 0 0 3 0 0 0 15 0 10 0 900403623 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4148955320 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 9 0 0 0 0 0 0 0 25 0 10 0 900403623 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 10 0 900403623 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 10 0 900403626 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878140 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 10 0 900403626 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878140 CPUtime=0.65
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 3336 0 0 0 65 0 0 0 17 0 10 0 900403626 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 10 0 900403626 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 10 0 900403626 899215360 58357 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 883292

[startup+6.32654 s]
/proc/loadavg: 1.30 1.07 1.02 2/50 31143
/proc/meminfo: memFree=5808/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878140 CPUtime=6.19
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 100711 0 1 0 578 41 0 0 25 0 10 0 900403620 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219535 91427 1766 10 0 216625 0
[pid=31134/tid=31135] ppid=31121 vsize=878140 CPUtime=2.92
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50408 0 1 0 263 29 0 0 25 0 10 0 900403621 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878140 CPUtime=0.77
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 33960 0 0 0 67 10 0 0 15 0 10 0 900403623 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 10 0 900403623 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 10 0 900403623 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 10 0 900403626 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878140 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 10 0 900403626 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878140 CPUtime=1.76
/proc/31134/task/31141/stat : 31141 (java) R 31121 31120 25521 34816 25544 4202560 6319 0 0 0 175 1 0 0 15 0 10 0 900403626 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4152146497 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 10 0 900403626 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878140 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) R 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 10 0 900403626 899215360 91427 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.22
Current children cumulated vsize (KiB) 883292

[startup+12.7086 s]
/proc/loadavg: 1.26 1.07 1.02 2/51 31144
/proc/meminfo: memFree=5188/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=12.55
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 106908 0 1 0 1211 44 0 0 25 0 11 0 900403620 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 97624 1792 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=7.95
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50470 0 1 0 765 30 0 0 25 0 11 0 900403621 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4096192080 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=0.97
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 39933 0 0 0 84 13 0 0 16 0 11 0 900403623 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=2.9
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6477 0 0 0 289 1 0 0 15 0 11 0 900403626 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 97624 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.58
Current children cumulated vsize (KiB) 883616

[startup+25.5123 s]
/proc/loadavg: 1.22 1.07 1.02 2/51 31144
/proc/meminfo: memFree=5724/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=25.35
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 115810 0 1 0 2488 47 0 0 25 0 11 0 900403620 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 106526 1793 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=19.68
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50472 0 1 0 1938 30 0 0 25 0 11 0 900403621 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4096191888 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=1.71
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 48794 0 0 0 156 15 0 0 15 0 11 0 900403623 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=3.22
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6516 0 0 0 321 1 0 0 15 0 11 0 900403626 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) R 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 106526 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.38
Current children cumulated vsize (KiB) 883616

[startup+51.1102 s]
/proc/loadavg: 1.14 1.06 1.02 2/51 31144
/proc/meminfo: memFree=5188/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=50.95
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116289 0 1 0 5048 47 0 0 25 0 11 0 900403620 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 107005 1793 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=44.17
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50472 0 1 0 4387 30 0 0 25 0 11 0 900403621 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4096215991 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=2.79
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 264 15 0 0 15 0 11 0 900403623 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=3.25
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6516 0 0 0 324 1 0 0 15 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.98
Current children cumulated vsize (KiB) 883616

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

[startup+63.9133 s]
/proc/loadavg: 1.11 1.06 1.01 2/51 31144
/proc/meminfo: memFree=5188/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=63.73
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116289 0 1 0 6326 47 0 0 25 0 11 0 900403620 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 107005 1793 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=56.3
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50472 0 1 0 5600 30 0 0 25 0 11 0 900403621 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4096191891 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=3.43
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 328 15 0 0 15 0 11 0 900403623 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=3.27
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6516 0 0 0 326 1 0 0 16 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 107005 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 63.76
Current children cumulated vsize (KiB) 883616

[startup+70.315 s]
/proc/loadavg: 1.10 1.06 1.01 2/51 31144
/proc/meminfo: memFree=6204/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=70.13
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116292 0 1 0 6966 47 0 0 25 0 11 0 900403620 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 107008 1793 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=62.16
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50472 0 1 0 6186 30 0 0 25 0 11 0 900403621 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4096216133 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=3.95
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 380 15 0 0 16 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=3.29
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6519 0 0 0 328 1 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 70.16
Current children cumulated vsize (KiB) 883616

[startup+73.5058 s]
/proc/loadavg: 1.09 1.06 1.01 2/51 31144
/proc/meminfo: memFree=6204/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=73.33
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116292 0 1 0 7286 47 0 0 25 0 11 0 900403620 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 107008 1793 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=65.35
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50472 0 1 0 6505 30 0 0 25 0 11 0 900403621 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4096192012 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=3.95
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 380 15 0 0 15 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=3.29
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6519 0 0 0 328 1 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 73.36
Current children cumulated vsize (KiB) 883616

[startup+76.7065 s]
/proc/loadavg: 1.09 1.06 1.01 2/51 31144
/proc/meminfo: memFree=6204/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=76.53
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116292 0 1 0 7606 47 0 0 25 0 11 0 900403620 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 107008 1793 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=68.55
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50472 0 1 0 6825 30 0 0 25 0 11 0 900403621 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4096192080 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=3.95
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 380 15 0 0 15 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=3.29
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6519 0 0 0 328 1 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 76.56
Current children cumulated vsize (KiB) 883616

[startup+77.5067 s]
/proc/loadavg: 1.08 1.05 1.01 2/51 31144
/proc/meminfo: memFree=6204/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878464 CPUtime=77.33
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116292 0 1 0 7686 47 0 0 25 0 11 0 900403620 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219616 107008 1793 10 0 216706 0
[pid=31134/tid=31135] ppid=31121 vsize=878464 CPUtime=69.35
/proc/31134/task/31135/stat : 31135 (java) R 31121 31120 25521 34816 25544 4202560 50472 0 1 0 6905 30 0 0 25 0 11 0 900403621 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4096192080 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878464 CPUtime=3.95
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 380 15 0 0 15 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 11 0 900403623 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878464 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878464 CPUtime=3.29
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6519 0 0 0 328 1 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 11 0 900403626 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878464 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 11 0 900404416 899547136 107008 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 77.36
Current children cumulated vsize (KiB) 883616

[startup+77.9055 s]
/proc/loadavg: 1.08 1.05 1.01 2/51 31144
/proc/meminfo: memFree=6204/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878788 CPUtime=77.41
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116304 0 1 0 7694 47 0 0 25 0 12 0 900403620 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219697 107020 1793 10 0 216787 0
[pid=31134/tid=31135] ppid=31121 vsize=878788 CPUtime=69.43
/proc/31134/task/31135/stat : 31135 (java) S 31121 31120 25521 34816 25544 4202560 50479 0 1 0 6913 30 0 0 25 0 12 0 900403621 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878788 CPUtime=3.95
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 380 15 0 0 15 0 12 0 900403623 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 12 0 900403623 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 12 0 900403623 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878788 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878788 CPUtime=3.3
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6520 0 0 0 329 1 0 0 16 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 12 0 900404416 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 77.44
Current children cumulated vsize (KiB) 883940

[startup+78.1055 s]
/proc/loadavg: 1.08 1.05 1.01 1/52 31145
/proc/meminfo: memFree=6196/1048576 swapFree=2095372/2097144
[pid=31120] ppid=31119 vsize=2576 CPUtime=0
/proc/31120/stat : 31120 (p2cudf-user-1.1) S 31119 31120 25521 34816 25544 4202496 377 0 0 0 0 0 0 0 25 0 1 0 900403617 2637824 273 1283457024 134512640 135304128 4287001184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31120/statm: 644 273 233 194 0 30 0
[pid=31121] ppid=31120 vsize=2576 CPUtime=0.03
/proc/31121/stat : 31121 (p2cudf) S 31120 31120 25521 34816 25544 4202496 392 2994 0 1 1 0 0 2 25 0 1 0 900403617 2637824 282 1283457024 134512640 135304128 4287072912 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31121/statm: 644 282 241 194 0 30 0
[pid=31134] ppid=31121 vsize=878788 CPUtime=77.41
/proc/31134/stat : 31134 (java) S 31121 31120 25521 34816 25544 4202496 116304 0 1 0 7694 47 0 0 25 0 12 0 900403620 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31134/statm: 219697 107020 1793 10 0 216787 0
[pid=31134/tid=31135] ppid=31121 vsize=878788 CPUtime=69.43
/proc/31134/task/31135/stat : 31135 (java) S 31121 31120 25521 34816 25544 4202560 50479 0 1 0 6913 30 0 0 25 0 12 0 900403621 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31136] ppid=31121 vsize=878788 CPUtime=3.95
/proc/31134/task/31136/stat : 31136 (java) S 31121 31120 25521 34816 25544 4202560 49273 0 0 0 380 15 0 0 15 0 12 0 900403623 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 0 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31137] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31137/stat : 31137 (java) S 31121 31120 25521 34816 25544 4202560 10 0 0 0 0 0 0 0 18 0 12 0 900403623 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31138] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31138/stat : 31138 (java) S 31121 31120 25521 34816 25544 4202560 6 0 0 0 0 0 0 0 18 0 12 0 900403623 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31139] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31139/stat : 31139 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 25 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31140] ppid=31121 vsize=878788 CPUtime=0.72
/proc/31134/task/31140/stat : 31140 (java) S 31121 31120 25521 34816 25544 4202560 8914 0 0 0 72 0 0 0 22 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31141] ppid=31121 vsize=878788 CPUtime=3.3
/proc/31134/task/31141/stat : 31141 (java) S 31121 31120 25521 34816 25544 4202560 6520 0 0 0 329 1 0 0 16 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31142] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31142/stat : 31142 (java) S 31121 31120 25521 34816 25544 4202560 0 0 0 0 0 0 0 0 25 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31143] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31143/stat : 31143 (java) S 31121 31120 25521 34816 25544 4202560 1 0 0 0 0 0 0 0 15 0 12 0 900403626 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31144] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31144/stat : 31144 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 25 0 12 0 900404416 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
[pid=31134/tid=31145] ppid=31121 vsize=878788 CPUtime=0
/proc/31134/task/31145/stat : 31145 (java) S 31121 31120 25521 34816 25544 4202560 4 0 0 0 0 0 0 0 21 0 12 0 900411377 899878912 107020 1283457024 134512640 134550932 4290264128 18446744073709551615 4294960130 0 4 0 16800975 18446612133130958976 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 77.44
Current children cumulated vsize (KiB) 883940

Child status: 0
Real time (s): 78.2038
CPU time (s): 77.5448
CPU user time (s): 77.0088
CPU system time (s): 0.536033
CPU usage (%): 99.1574
Max. virtual memory (cumulated for all children) (KiB): 886948

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 77.0088
system time used= 0.536033
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 120093
page faults= 2
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 2370
involuntary context switches= 3263

runsolver used 0 second user time and 0 second system time

The end