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/embedded/real/e599f3fc-360e-11e0-986e-00163e3d3b7c.cudf.log.runsolver /home/competition/p2cudf-basic-1.15/p2cudf-basic-1.15 /home/competition/data/real/e599f3fc-360e-11e0-986e-00163e3d3b7c.cudf /tmp/misc2012/2012-09-02-17:21/basic/p2cudf-basic-1.15/embedded/real/e599f3fc-360e-11e0-986e-00163e3d3b7c.cudf.result -sum(solution,installedsize),-count(removed) 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.26 1.19 1.02 2/59 24361 /proc/meminfo: memFree=454776/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 426 0 0 0 0 0 0 0 20 0 1 0 115996814 9392128 326 18446744073709551615 4194304 5129932 140734188990112 140734188987784 140150927025952 0 0 16781316 65536 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 326 275 229 0 53 0 [startup+0.144535 s] /proc/loadavg: 1.26 1.19 1.02 2/59 24361 /proc/meminfo: memFree=454776/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 9172 [startup+0.200368 s] /proc/loadavg: 1.26 1.19 1.02 2/59 24361 /proc/meminfo: memFree=454776/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 9172 [startup+0.300326 s] /proc/loadavg: 1.26 1.19 1.02 2/59 24361 /proc/meminfo: memFree=454776/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 9172 [startup+0.700256 s] /proc/loadavg: 1.26 1.19 1.02 2/59 24361 /proc/meminfo: memFree=454776/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 9172 [startup+1.50075 s] /proc/loadavg: 1.26 1.19 1.02 4/70 24373 /proc/meminfo: memFree=413140/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=1046420 CPUtime=1.43 /proc/24364/stat : 24364 (java) S 24361 24361 1733 0 -1 4202496 30829 0 0 0 126 17 0 0 20 0 10 0 115996815 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140736506646144 140696719720053 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 261605 27633 2344 9 0 248955 0 [pid=24364/tid=24365] ppid=24361 vsize=1046420 CPUtime=0.66 /proc/24364/task/24365/stat : 24365 (java) R 24361 24361 1733 0 -1 4202560 12644 0 0 0 56 10 0 0 20 0 10 0 115996816 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696726246048 140696624160488 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=24364/tid=24366] ppid=24361 vsize=1046420 CPUtime=0 /proc/24364/task/24366/stat : 24366 (java) S 24361 24361 1733 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 115996819 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696618892416 140696719734347 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24367] ppid=24361 vsize=1046420 CPUtime=0 /proc/24364/task/24367/stat : 24367 (java) S 24361 24361 1733 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 115996819 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696617838608 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24368] ppid=24361 vsize=1046420 CPUtime=0 /proc/24364/task/24368/stat : 24368 (java) S 24361 24361 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 115996819 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696616785824 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24369] ppid=24361 vsize=1046420 CPUtime=0 /proc/24364/task/24369/stat : 24369 (java) S 24361 24361 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115996823 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696615734256 140696719741984 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24370] ppid=24361 vsize=1046420 CPUtime=0.35 /proc/24364/task/24370/stat : 24370 (java) R 24361 24361 1733 0 -1 4202560 7876 0 0 0 33 2 0 0 20 0 10 0 115996823 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696614667416 140696706234515 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=1046420 CPUtime=0.39 /proc/24364/task/24371/stat : 24371 (java) R 24361 24361 1733 0 -1 4202560 9016 0 0 0 35 4 0 0 20 0 10 0 115996823 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696613614440 140696705878560 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24372] ppid=24361 vsize=1046420 CPUtime=0 /proc/24364/task/24372/stat : 24372 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696612576464 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24373] ppid=24361 vsize=1046420 CPUtime=0 /proc/24364/task/24373/stat : 24373 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1071534080 27633 18446744073709551615 4194304 4228012 140736506655120 140696611523968 140696719734347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.43 Current children cumulated vsize (KiB) 1055592 [startup+3.10057 s] /proc/loadavg: 1.26 1.19 1.02 4/70 24373 /proc/meminfo: memFree=317784/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=1049580 CPUtime=3.01 /proc/24364/stat : 24364 (java) S 24361 24361 1733 0 -1 4202496 77624 0 0 0 269 32 0 0 20 0 10 0 115996815 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140736506646144 140696719720053 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 262395 72465 2364 9 0 249745 0 [pid=24364/tid=24365] ppid=24361 vsize=1049580 CPUtime=1.45 /proc/24364/task/24365/stat : 24365 (java) R 24361 24361 1733 0 -1 4202560 47425 0 0 0 123 22 0 0 20 0 10 0 115996816 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696726246080 140696624181737 0 4 0 16800975 0 0 0 -1 0 0 0 5 0 0 [pid=24364/tid=24366] ppid=24361 vsize=1049580 CPUtime=0.14 /proc/24364/task/24366/stat : 24366 (java) S 24361 24361 1733 0 -1 4202560 8258 0 0 0 12 2 0 0 20 0 10 0 115996819 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696618892416 140696719734347 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24367] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24367/stat : 24367 (java) S 24361 24361 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 115996819 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696617838608 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24368] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24368/stat : 24368 (java) S 24361 24361 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 115996819 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696616785824 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24369] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24369/stat : 24369 (java) S 24361 24361 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696615734256 140696719741984 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24370] ppid=24361 vsize=1049580 CPUtime=0.65 /proc/24364/task/24370/stat : 24370 (java) S 24361 24361 1733 0 -1 4202560 9573 0 0 0 62 3 0 0 20 0 10 0 115996823 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696614681616 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=1049580 CPUtime=0.73 /proc/24364/task/24371/stat : 24371 (java) S 24361 24361 1733 0 -1 4202560 11075 0 0 0 69 4 0 0 20 0 10 0 115996823 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696613628944 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24372] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24372/stat : 24372 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696612576464 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24373] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24373/stat : 24373 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 72465 18446744073709551615 4194304 4228012 140736506655120 140696611523968 140696719734347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 3.01 Current children cumulated vsize (KiB) 1058752 [startup+6.30078 s] /proc/loadavg: 1.24 1.19 1.02 4/70 24373 /proc/meminfo: memFree=73008/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=1049580 CPUtime=6.16 /proc/24364/stat : 24364 (java) S 24361 24361 1733 0 -1 4202496 100130 0 0 0 577 39 0 0 20 0 10 0 115996815 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140736506646144 140696719720053 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 262395 94561 2375 9 0 249745 0 [pid=24364/tid=24365] ppid=24361 vsize=1049580 CPUtime=2.82 /proc/24364/task/24365/stat : 24365 (java) R 24361 24361 1733 0 -1 4202560 47739 0 0 0 258 24 0 0 20 0 10 0 115996816 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696726250992 140696704307567 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0 [pid=24364/tid=24366] ppid=24361 vsize=1049580 CPUtime=0.58 /proc/24364/task/24366/stat : 24366 (java) S 24361 24361 1733 0 -1 4202560 30205 0 0 0 51 7 0 0 20 0 10 0 115996819 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696618892416 140696719734347 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24367] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24367/stat : 24367 (java) S 24361 24361 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 115996819 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696617838608 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24368] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24368/stat : 24368 (java) S 24361 24361 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 115996819 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696616785824 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24369] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24369/stat : 24369 (java) S 24361 24361 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696615734256 140696719741984 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24370] ppid=24361 vsize=1049580 CPUtime=1.35 /proc/24364/task/24370/stat : 24370 (java) R 24361 24361 1733 0 -1 4202560 9648 0 0 0 132 3 0 0 20 0 10 0 115996823 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696614681360 140696704024783 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=1049580 CPUtime=1.37 /proc/24364/task/24371/stat : 24371 (java) R 24361 24361 1733 0 -1 4202560 11245 0 0 0 133 4 0 0 20 0 10 0 115996823 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696613628688 140696705447301 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24372] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24372/stat : 24372 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696612576464 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24373] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24373/stat : 24373 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 94561 18446744073709551615 4194304 4228012 140736506655120 140696611523968 140696719734347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 6.16 Current children cumulated vsize (KiB) 1058752 Solver just ended. Dumping a history of the last processes samples [startup+6.40102 s] /proc/loadavg: 1.24 1.19 1.02 4/70 24373 /proc/meminfo: memFree=73008/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=1049580 CPUtime=6.26 /proc/24364/stat : 24364 (java) S 24361 24361 1733 0 -1 4202496 100135 0 0 0 587 39 0 0 20 0 10 0 115996815 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140736506646144 140696719720053 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 262395 94566 2375 9 0 249745 0 [pid=24364/tid=24365] ppid=24361 vsize=1049580 CPUtime=2.85 /proc/24364/task/24365/stat : 24365 (java) R 24361 24361 1733 0 -1 4202560 47741 0 0 0 261 24 0 0 20 0 10 0 115996816 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696726254624 140696623768586 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0 [pid=24364/tid=24366] ppid=24361 vsize=1049580 CPUtime=0.58 /proc/24364/task/24366/stat : 24366 (java) S 24361 24361 1733 0 -1 4202560 30205 0 0 0 51 7 0 0 20 0 10 0 115996819 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696618892416 140696719734347 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24367] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24367/stat : 24367 (java) S 24361 24361 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 115996819 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696617838608 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24368] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24368/stat : 24368 (java) S 24361 24361 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 115996819 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696616785824 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24369] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24369/stat : 24369 (java) S 24361 24361 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696615734256 140696719741984 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24370] ppid=24361 vsize=1049580 CPUtime=1.39 /proc/24364/task/24370/stat : 24370 (java) R 24361 24361 1733 0 -1 4202560 9648 0 0 0 136 3 0 0 20 0 10 0 115996823 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696614681360 140696704024432 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=1049580 CPUtime=1.4 /proc/24364/task/24371/stat : 24371 (java) R 24361 24361 1733 0 -1 4202560 11248 0 0 0 136 4 0 0 20 0 10 0 115996823 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696613628688 140696702567659 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24372] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24372/stat : 24372 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696612576464 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24373] ppid=24361 vsize=1049580 CPUtime=0 /proc/24364/task/24373/stat : 24373 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115996823 1074769920 94566 18446744073709551615 4194304 4228012 140736506655120 140696611523968 140696719734347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 6.26 Current children cumulated vsize (KiB) 1058752 [startup+7.20088 s] /proc/loadavg: 1.24 1.19 1.02 4/70 24373 /proc/meminfo: memFree=72388/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=1051636 CPUtime=6.92 /proc/24364/stat : 24364 (java) S 24361 24361 1733 0 -1 4202496 100263 0 0 0 652 40 0 0 20 0 11 0 115996815 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140736506646144 140696719720053 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 262909 94692 2377 9 0 250259 0 [pid=24364/tid=24365] ppid=24361 vsize=1051636 CPUtime=3.09 /proc/24364/task/24365/stat : 24365 (java) S 24361 24361 1733 0 -1 4202560 47804 0 0 0 285 24 0 0 20 0 11 0 115996816 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696726254512 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0 [pid=24364/tid=24366] ppid=24361 vsize=1051636 CPUtime=0.59 /proc/24364/task/24366/stat : 24366 (java) S 24361 24361 1733 0 -1 4202560 30205 0 0 0 51 8 0 0 20 0 11 0 115996819 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696618892416 140696719734347 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24367] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24367/stat : 24367 (java) S 24361 24361 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115996819 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696617838608 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24368] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24368/stat : 24368 (java) S 24361 24361 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115996819 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696616785824 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24369] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24369/stat : 24369 (java) S 24361 24361 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696615734256 140696719741984 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24370] ppid=24361 vsize=1051636 CPUtime=1.6 /proc/24364/task/24370/stat : 24370 (java) S 24361 24361 1733 0 -1 4202560 9688 0 0 0 157 3 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696614681616 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=1051636 CPUtime=1.6 /proc/24364/task/24371/stat : 24371 (java) S 24361 24361 1733 0 -1 4202560 11261 0 0 0 156 4 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696613628944 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24372] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24372/stat : 24372 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696612576464 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24373] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24373/stat : 24373 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696611523968 140696719734347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 6.92 Current children cumulated vsize (KiB) 1060808 [startup+7.60082 s] /proc/loadavg: 1.24 1.19 1.02 4/70 24373 /proc/meminfo: memFree=72388/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=1051636 CPUtime=6.95 /proc/24364/stat : 24364 (java) S 24361 24361 1733 0 -1 4202496 100263 0 0 0 655 40 0 0 20 0 11 0 115996815 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140736506646144 140696719720053 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 262909 94692 2377 9 0 250259 0 [pid=24364/tid=24365] ppid=24361 vsize=1051636 CPUtime=3.09 /proc/24364/task/24365/stat : 24365 (java) S 24361 24361 1733 0 -1 4202560 47804 0 0 0 285 24 0 0 20 0 11 0 115996816 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696726254512 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0 [pid=24364/tid=24366] ppid=24361 vsize=1051636 CPUtime=0.59 /proc/24364/task/24366/stat : 24366 (java) S 24361 24361 1733 0 -1 4202560 30205 0 0 0 51 8 0 0 20 0 11 0 115996819 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696618892416 140696719734347 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24367] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24367/stat : 24367 (java) S 24361 24361 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115996819 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696617838608 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24368] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24368/stat : 24368 (java) S 24361 24361 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115996819 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696616785824 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24369] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24369/stat : 24369 (java) S 24361 24361 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696615734256 140696719741984 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24370] ppid=24361 vsize=1051636 CPUtime=1.61 /proc/24364/task/24370/stat : 24370 (java) R 24361 24361 1733 0 -1 4202560 9688 0 0 0 158 3 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696614681360 140696701626442 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=1051636 CPUtime=1.62 /proc/24364/task/24371/stat : 24371 (java) R 24361 24361 1733 0 -1 4202560 11261 0 0 0 158 4 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696613628624 140696702998831 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24372] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24372/stat : 24372 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696612576464 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24373] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24373/stat : 24373 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94692 18446744073709551615 4194304 4228012 140736506655120 140696611523968 140696719734347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 6.95 Current children cumulated vsize (KiB) 1060808 [startup+7.80548 s] /proc/loadavg: 1.24 1.19 1.02 2/71 24375 /proc/meminfo: memFree=72008/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=1051636 CPUtime=7.15 /proc/24364/stat : 24364 (java) S 24361 24361 1733 0 -1 4202496 100268 0 0 0 671 44 0 0 20 0 11 0 115996815 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140736506646144 140696719720053 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 262909 94697 2378 9 0 250259 0 [pid=24364/tid=24365] ppid=24361 vsize=1051636 CPUtime=3.09 /proc/24364/task/24365/stat : 24365 (java) S 24361 24361 1733 0 -1 4202560 47804 0 0 0 285 24 0 0 20 0 11 0 115996816 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696726254512 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0 [pid=24364/tid=24366] ppid=24361 vsize=1051636 CPUtime=0.59 /proc/24364/task/24366/stat : 24366 (java) S 24361 24361 1733 0 -1 4202560 30205 0 0 0 51 8 0 0 20 0 11 0 115996819 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696618892416 140696719734347 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24367] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24367/stat : 24367 (java) S 24361 24361 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115996819 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696617838608 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24368] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24368/stat : 24368 (java) S 24361 24361 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115996819 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696616785824 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24369] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24369/stat : 24369 (java) S 24361 24361 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696615734256 140696719741984 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24370] ppid=24361 vsize=1051636 CPUtime=1.65 /proc/24364/task/24370/stat : 24370 (java) R 24361 24361 1733 0 -1 4202560 9688 0 0 0 162 3 0 0 20 0 11 0 115996823 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696614681360 140696702568337 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=1051636 CPUtime=1.64 /proc/24364/task/24371/stat : 24371 (java) R 24361 24361 1733 0 -1 4202560 11262 0 0 0 160 4 0 0 20 0 11 0 115996823 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696613628688 140696703772979 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24372] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24372/stat : 24372 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696612576464 140696719733460 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24373] ppid=24361 vsize=1051636 CPUtime=0 /proc/24364/task/24373/stat : 24373 (java) S 24361 24361 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115996823 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696611523968 140696719734347 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=24364/tid=24375] ppid=24361 vsize=1051636 CPUtime=0.14 /proc/24364/task/24375/stat : 24375 (java) R 24361 24361 1733 0 -1 4202560 10 0 0 0 10 4 0 0 20 0 11 0 115997521 1076875264 94697 18446744073709551615 4194304 4228012 140736506655120 140696609256688 140696623766352 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 7.15 Current children cumulated vsize (KiB) 1060808 [startup+7.90092 s] /proc/loadavg: 1.24 1.19 1.02 2/71 24375 /proc/meminfo: memFree=72008/1022884 swapFree=0/0 [pid=24361] ppid=24360 vsize=9172 CPUtime=0 /proc/24361/stat : 24361 (p2cudf-basic-1.) S 24360 24361 1733 0 -1 4202496 461 290 0 0 0 0 0 0 20 0 1 0 115996814 9392128 331 18446744073709551615 4194304 5129932 140734188990112 140734188988256 140150926881886 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/24361/statm: 2293 331 280 229 0 53 0 [pid=24364] ppid=24361 vsize=0 CPUtime=7.24 /proc/24364/stat : 24364 (java) Z 24361 24361 1733 0 -1 4203532 100279 0 0 0 677 47 0 0 20 0 2 0 115996815 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/24364/statm: 0 0 0 0 0 0 0 [pid=24364/tid=24371] ppid=24361 vsize=0 CPUtime=1.71 /proc/24364/task/24371/stat : 24371 (java) R 24361 24361 1733 0 -1 4203588 11262 0 0 0 164 7 0 0 20 0 2 0 115996823 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) 7.24 Current children cumulated vsize (KiB) 9172 Child status: 0 Real time (s): 7.91076 CPU time (s): 7.26445 CPU user time (s): 6.78042 CPU system time (s): 0.48403 CPU usage (%): 91.83 Max. virtual memory (cumulated for all children) (KiB): 1062184 getrusage(RUSAGE_CHILDREN,...) data: user time used= 6.78042 system time used= 0.48403 maximum resident set size= 378824 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 101042 page faults= 0 swaps= 0 block input operations= 24248 block output operations= 264 messages sent= 0 messages received= 0 signals received= 0 voluntary context switches= 675 involuntary context switches= 2247 runsolver used 0.004 second user time and 0.084005 second system time The end