TACC: Starting up job 6245828 TACC: Setting up parallel environment for MVAPICH2+mpispawn. TACC: Starting parallel tasks... Charmrun> started all node programs in 1.673 seconds. Charmrun> scalable start enabled. Charmrun> IBVERBS version of charmrun Converse/Charm++ Commit ID: v6.7.0-0-g46f867c-namd-charm-6.7.0-build-2015-Dec-21-45876 Warning> Randomization of stack pointer is turned on in kernel, thread migration may not work! Run 'echo 0 > /proc/sys/kernel/randomize_va_space' as root to disable it, or try run with '+isomalloc_sync'. Charm++> scheduler running in netpoll mode. CharmLB> Load balancer assumes all CPUs are same. Charm++> cpu affinity enabled. Charm++> cpuaffinity PE-core map : 1-14 Charm++> set comm 0 on node 0 to core #0 Charm++> Running on 1 unique compute nodes (16-way SMP). Charm++> cpu topology info is gathered in 0.011 seconds. Info: Built with CUDA version 6050 Pe 0 physical rank 0 will use CUDA device of pe 8 Pe 3 physical rank 3 will use CUDA device of pe 8 Pe 6 physical rank 6 will use CUDA device of pe 8 Pe 2 physical rank 2 will use CUDA device of pe 8 Pe 10 physical rank 10 will use CUDA device of pe 8 Pe 13 physical rank 13 will use CUDA device of pe 8 Pe 7 physical rank 7 will use CUDA device of pe 8 Pe 5 physical rank 5 will use CUDA device of pe 8 Pe 9 physical rank 9 will use CUDA device of pe 8 Pe 4 physical rank 4 will use CUDA device of pe 8 Pe 11 physical rank 11 will use CUDA device of pe 8 Pe 12 physical rank 12 will use CUDA device of pe 8 Pe 1 physical rank 1 will use CUDA device of pe 8 Pe 8 physical rank 8 binding to CUDA device 0 on c557-103.stampede.tacc.utexas.edu: 'Tesla K20m' Mem: 4799MB Rev: 3.5 Info: NAMD 2.11 for Linux-x86_64-ibverbs-smp-Stampede-CUDA-memopt Warning: Warning: *** EXPERIMENTAL MEMORY OPTIMIZED VERSION *** Warning: Info: Info: Please visit http://www.ks.uiuc.edu/Research/namd/ Info: for updates, documentation, and support information. Info: Info: Please cite Phillips et al., J. Comp. Chem. 26:1781-1802 (2005) Info: in all publications reporting results obtained with NAMD. Info: Info: Based on Charm++/Converse 60700 for net-linux-x86_64-ibverbs-smp-iccstatic Info: Built Mon Dec 21 10:39:37 CST 2015 by tg455591 on login4.stampede.tacc.utexas.edu Info: 1 NAMD 2.11 Linux-x86_64-ibverbs-smp-Stampede-CUDA-memopt 14 c557-103.stampede.tacc.utexas.edu tg455591 Info: Running on 14 processors, 1 nodes, 1 physical nodes. Info: CPU topology information available. Info: Charm++/Converse parallel runtime startup completed at 1.45077 s CkLoopLib is used in SMP with a simple dynamic scheduling (converse-level notification) but not using node-level queue Info: 104.527 MB of memory in use based on /proc/self/stat Info: Configuration file is /work/00288/tg455591/stmv/stmv2fs.namd Info: Changed directory to /work/00288/tg455591/stmv TCL: Suspending until startup complete. Info: SIMULATION PARAMETERS: Info: TIMESTEP 2 Info: NUMBER OF STEPS 1200 Info: STEPS PER CYCLE 24 Info: PERIODIC CELL BASIS 1 216.832 0 0 Info: PERIODIC CELL BASIS 2 0 216.832 0 Info: PERIODIC CELL BASIS 3 0 0 216.832 Info: PERIODIC CELL CENTER 0 0 0 Info: LOAD BALANCER Centralized Info: LOAD BALANCING STRATEGY New Load Balancers -- DEFAULT Info: LDB PERIOD 4800 steps Info: FIRST LDB TIMESTEP 120 Info: LAST LDB TIMESTEP -1 Info: LDB BACKGROUND SCALING 1 Info: HOM BACKGROUND SCALING 1 Info: PME BACKGROUND SCALING 1 Info: MIN ATOMS PER PATCH 40 Info: INITIAL TEMPERATURE 298 Info: CENTER OF MASS MOVING INITIALLY? NO Info: DIELECTRIC 1 Info: EXCLUDE SCALED ONE-FOUR Info: 1-4 ELECTROSTATICS SCALED BY 1 Info: MODIFIED 1-4 VDW PARAMETERS WILL BE USED Info: NO DCD TRAJECTORY OUTPUT Info: NO EXTENDED SYSTEM TRAJECTORY OUTPUT Info: NO VELOCITY DCD OUTPUT Info: NO FORCE DCD OUTPUT Info: OUTPUT FILENAME /scratch/00288/tg455591/stmv-output Info: BINARY OUTPUT FILES WILL BE USED Info: NO RESTART FILE Info: SWITCHING ACTIVE Info: SWITCHING ON 10 Info: SWITCHING OFF 12 Info: PAIRLIST DISTANCE 13.5 Info: PAIRLIST SHRINK RATE 0.01 Info: PAIRLIST GROW RATE 0.01 Info: PAIRLIST TRIGGER 0.3 Info: PAIRLISTS PER CYCLE 4 Info: PAIRLISTS ENABLED Info: MARGIN 0.48 Info: HYDROGEN GROUP CUTOFF 2.5 Info: PATCH DIMENSION 16.48 Info: ENERGY OUTPUT STEPS 120 Info: CROSSTERM ENERGY INCLUDED IN DIHEDRAL Info: TIMING OUTPUT STEPS 120 Info: LANGEVIN DYNAMICS ACTIVE Info: LANGEVIN TEMPERATURE 298 Info: LANGEVIN USING BBK INTEGRATOR Info: LANGEVIN DAMPING COEFFICIENT IS 5 INVERSE PS Info: LANGEVIN DYNAMICS NOT APPLIED TO HYDROGENS Info: LANGEVIN PISTON PRESSURE CONTROL ACTIVE Info: TARGET PRESSURE IS 1.01325 BAR Info: OSCILLATION PERIOD IS 100 FS Info: DECAY TIME IS 50 FS Info: PISTON TEMPERATURE IS 298 K Info: PRESSURE CONTROL IS GROUP-BASED Info: INITIAL STRAIN RATE IS 0 0 0 Info: CELL FLUCTUATION IS ISOTROPIC Info: PARTICLE MESH EWALD (PME) ACTIVE Info: PME TOLERANCE 1e-06 Info: PME EWALD COEFFICIENT 0.257952 Info: PME INTERPOLATION ORDER 4 Info: PME GRID DIMENSIONS 216 216 216 Info: PME MAXIMUM GRID SPACING 1.5 Info: FULL ELECTROSTATIC EVALUATION FREQUENCY 3 Info: USING VERLET I (r-RESPA) MTS SCHEME. Info: C1 SPLITTING OF LONG RANGE ELECTROSTATICS Info: PLACING ATOMS IN PATCHES BY HYDROGEN GROUPS Info: RIGID BONDS TO HYDROGEN : ALL Info: ERROR TOLERANCE : 1e-08 Info: MAX ITERATIONS : 100 Info: RIGID WATER USING SETTLE ALGORITHM Info: RANDOM NUMBER SEED 1450750626 Info: USE HYDROGEN BONDS? NO Info: STRUCTURE FILE stmv.psf.inter Info: PARAMETER file: CHARMM format! Info: PARAMETERS par_all27_prot_na.inp Info: USING ARITHMETIC MEAN TO COMBINE L-J SIGMA PARAMETERS Info: BINARY COORDINATES stmv.coor Info: SUMMARY OF PARAMETERS: Info: 250 BONDS Info: 622 ANGLES Info: 1049 DIHEDRAL Info: 73 IMPROPER Info: 0 CROSSTERM Info: 130 VDW Info: 0 VDW_PAIRS Info: 0 NBTHOLE_PAIRS Info: TIME FOR READING PSF FILE: 0.00806093 Info: Info: Entering startup at 1.53561 s, 119.094 MB of memory in use Info: Startup phase 0 took 0.00107908 s, 119.102 MB of memory in use Warning: an empty exclusion signature with index 709! Info: Startup phase 1 took 0.00268912 s, 119.207 MB of memory in use Info: NONBONDED TABLE R-SQUARED SPACING: 0.0625 Info: NONBONDED TABLE SIZE: 769 POINTS Info: INCONSISTENCY IN FAST TABLE ENERGY VS FORCE: 0.000325096 AT 11.9556 Info: INCONSISTENCY IN SCOR TABLE ENERGY VS FORCE: 0.000324844 AT 11.9556 Info: ABSOLUTE IMPRECISION IN VDWA TABLE ENERGY: 4.59334e-32 AT 11.9974 Info: RELATIVE IMPRECISION IN VDWA TABLE ENERGY: 7.4108e-17 AT 11.9974 Info: INCONSISTENCY IN VDWA TABLE ENERGY VS FORCE: 0.0040507 AT 0.251946 Info: ABSOLUTE IMPRECISION IN VDWB TABLE ENERGY: 1.53481e-26 AT 11.9974 Info: RELATIVE IMPRECISION IN VDWB TABLE ENERGY: 7.96691e-18 AT 11.9974 Info: INCONSISTENCY IN VDWB TABLE ENERGY VS FORCE: 0.00150189 AT 0.251946 Info: Running with 2 input processors. Info: Running with 1 output processors (1 of them will output simultaneously). Info: INPUT PROC LOCATIONS: 4 12 Info: OUTPUT PROC LOCATIONS: 8 Info: Updated CUDA LJ table with 130 x 130 elements. Info: Updated CUDA force table with 4096 elements. Info: Startup phase 2 took 0.157692 s, 343.711 MB of memory in use Info: Startup phase 3 took 0.144566 s, 343.988 MB of memory in use Info: PATCH GRID IS 13 (PERIODIC) BY 13 (PERIODIC) BY 13 (PERIODIC) Info: PATCH GRID IS 1-AWAY BY 1-AWAY BY 1-AWAY Info: LOADED 1810196 TOTAL EXCLUSIONS Info: REMOVING COM VELOCITY -0.0112848 -0.00859764 0.000436358 Info: Startup phase 4 took 0.0333748 s, 457.035 MB of memory in use Info: **************************** Info: STRUCTURE SUMMARY: Info: 1066628 ATOMS Info: 769956 BONDS Info: 605872 ANGLES Info: 450875 DIHEDRALS Info: 24578 IMPROPERS Info: 0 CROSSTERMS Info: 0 EXCLUSIONS Info: 977416 RIGID BONDS Info: 2222468 DEGREES OF FREEDOM Info: 389067 HYDROGEN GROUPS Info: 4 ATOMS IN LARGEST HYDROGEN GROUP Info: 389067 MIGRATION GROUPS Info: 4 ATOMS IN LARGEST MIGRATION GROUP Info: TOTAL MASS = 6.69877e+06 amu Info: TOTAL CHARGE = 0.000168104 e Info: MASS DENSITY = 1.09115 g/cm^3 Info: ATOM DENSITY = 0.104627 atoms/A^3 Info: ***************************** Info: LARGEST PATCH (1044) HAS 541 ATOMS Info: Startup phase 5 took 0.0595481 s, 463.254 MB of memory in use Info: TORUS A SIZE 14 USING 0 Info: TORUS B SIZE 1 USING 0 Info: TORUS C SIZE 1 USING 0 Info: TORUS MINIMAL MESH SIZE IS 1 BY 1 BY 1 Info: Placed 100% of base nodes on same physical node as patch Info: Startup phase 6 took 0.010226 s, 472.359 MB of memory in use Info: PME using 14 and 14 processors for FFT and reciprocal sum. Info: PME GRID LOCATIONS: 0 1 2 3 4 5 6 7 8 9 ... Info: PME TRANS LOCATIONS: 0 1 2 3 4 5 6 7 8 9 ... Info: PME USING 1 GRID NODES AND 1 TRANS NODES Info: Optimizing 4 FFT steps. 1... 2... 3... 4... Done. Info: Startup phase 7 took 0.166282 s, 635.199 MB of memory in use Info: Startup phase 8 took 0.00816512 s, 635.926 MB of memory in use LDB: Central LB being created... Info: Startup phase 9 took 0.00676799 s, 638.18 MB of memory in use Info: CREATING 46235 COMPUTE OBJECTS CUDA device 0 stream priority range 0 -1 Info: Found 333 unique exclusion lists needing 1076 bytes Pe 4 hosts 0 local and 157 remote patches for pe 8 Pe 12 hosts 0 local and 158 remote patches for pe 8 Pe 0 hosts 0 local and 158 remote patches for pe 8 Pe 8 hosts 0 local and 157 remote patches for pe 8 Pe 7 hosts 0 local and 157 remote patches for pe 8 Pe 6 hosts 0 local and 156 remote patches for pe 8 Pe 10 hosts 0 local and 157 remote patches for pe 8 Pe 9 hosts 0 local and 156 remote patches for pe 8 Pe 5 hosts 0 local and 156 remote patches for pe 8 Pe 11 hosts 0 local and 156 remote patches for pe 8 Pe 2 hosts 0 local and 157 remote patches for pe 8 Pe 13 hosts 0 local and 158 remote patches for pe 8 Pe 3 hosts 0 local and 157 remote patches for pe 8 Pe 1 hosts 0 local and 157 remote patches for pe 8 Info: useSync: 0 useProxySync: 0 Info: Startup phase 10 took 0.12837 s, 712.352 MB of memory in use Info: Startup phase 11 took 0.000536203 s, 712.355 MB of memory in use Info: Startup phase 12 took 0.015173 s, 719.93 MB of memory in use Info: Finished startup at 2.27008 s, 720 MB of memory in use Pe 8 has 0 local and 2197 remote patches and 0 local and 30758 remote computes. ETITLE: TS BOND ANGLE DIHED IMPRP ELECT VDW BOUNDARY MISC KINETIC TOTAL TEMP POTENTIAL TOTAL3 TEMPAVG PRESSURE GPRESSURE VOLUME PRESSAVG GPRESSAVG ENERGY: 0 37737.0490 105740.7918 81950.2970 4986.4950 -4134759.2832 375590.1066 0.0000 0.0000 659148.3206 -2869606.2232 298.4957 -3528754.5438 -2867047.7417 298.4957 2254.8871 2342.6810 10194598.5131 2254.8871 2342.6810 LDB: ============= START OF LOAD BALANCING ============== 8.1216 LDB: ============== END OF LOAD BALANCING =============== 8.1295 Info: useSync: 0 useProxySync: 0 LDB: =============== DONE WITH MIGRATION ================ 8.13089 LDB: ============= START OF LOAD BALANCING ============== 28.3661 LDB: Largest compute 40706 load 0.023592 is 0.3% of average load 8.636721 LDB: Average compute 0.002259 is 0.0% of average load 8.636721 LDB: Partitioning computes with target load 0.863672 LDB: Increased migratable compute count from 13182 to 13182 LDB: Largest unpartitionable compute is 0.023592 LDB: ============== END OF LOAD BALANCING =============== 28.384 Info: useSync: 0 useProxySync: 0 LDB: =============== DONE WITH MIGRATION ================ 28.3898 Info: Initial time: 14 CPUs 0.214105 s/step 1.23903 days/ns 2385.43 MB memory TIMING: 120 CPU: 25.4821, 0.208435/step Wall: 26.7236, 0.214383/step, 0.064315 hours remaining, 2385.429688 MB of memory in use. ENERGY: 120 39474.0608 107137.3130 81940.2234 5220.1230 -4026807.4470 295359.6137 0.0000 0.0000 642045.3304 -2855630.7825 290.7506 -3497676.1129 -2853139.7905 290.1670 -49.1629 27.4036 10352110.8534 -6.9922 -5.9571 LDB: ============= START OF LOAD BALANCING ============== 33.5159 LDB: ============== END OF LOAD BALANCING =============== 33.5163 Info: useSync: 0 useProxySync: 0 LDB: =============== DONE WITH MIGRATION ================ 33.5176 LDB: ============= START OF LOAD BALANCING ============== 53.7052 LDB: Largest compute 40706 load 0.023404 is 0.3% of average load 8.620778 LDB: Average compute 0.002259 is 0.0% of average load 8.620778 LDB: TIME 53.7188 LOAD: AVG 8.62078 MAX 9.96057 PROXIES: TOTAL 2249 MAXPE 188 MAXPATCH 3 None MEM: 2406 MB LDB: TIME 53.7246 LOAD: AVG 8.62078 MAX 9.70591 PROXIES: TOTAL 2249 MAXPE 188 MAXPATCH 3 TorusLB MEM: 2406.02 MB LDB: ============== END OF LOAD BALANCING =============== 53.7342 Info: useSync: 0 useProxySync: 0 LDB: =============== DONE WITH MIGRATION ================ 53.746 Info: Initial time: 14 CPUs 0.210942 s/step 1.22073 days/ns 2424.45 MB memory TIMING: 240 CPU: 50.1844, 0.205852/step Wall: 52.0797, 0.211301/step, 0.0563469 hours remaining, 2424.449219 MB of memory in use. ENERGY: 240 39310.7930 107071.3794 82029.4324 5040.7984 -4016432.2804 292567.1689 0.0000 0.0000 644835.6118 -2845577.0964 292.0141 -3490412.7082 -2843040.9843 291.2726 4.2052 80.8726 10343108.4310 2.2182 2.3846 LDB: ============= START OF LOAD BALANCING ============== 79.0651 LDB: Largest compute 40626 load 0.029450 is 0.3% of average load 10.876586 LDB: Average compute 0.002855 is 0.0% of average load 10.876586 LDB: TIME 79.0786 LOAD: AVG 10.8766 MAX 12.2519 PROXIES: TOTAL 2249 MAXPE 188 MAXPATCH 3 None MEM: 2651.12 MB LDB: TIME 79.0801 LOAD: AVG 10.8766 MAX 12.2519 PROXIES: TOTAL 2249 MAXPE 188 MAXPATCH 3 RefineTorusLB MEM: 2651.12 MB LDB: TIME 79.2401 LOAD: AVG 10.8766 MAX 10.9969 PROXIES: TOTAL 2614 MAXPE 316 MAXPATCH 3 RefineTorusLB MEM: 2651.12 MB LDB: ============== END OF LOAD BALANCING =============== 79.2453 Info: useSync: 0 useProxySync: 0 LDB: =============== DONE WITH MIGRATION ================ 79.2535 Info: Initial time: 14 CPUs 0.210995 s/step 1.22104 days/ns 2669.77 MB memory TIMING: 360 CPU: 75.0926, 0.207568/step Wall: 77.5878, 0.212567/step, 0.0495991 hours remaining, 2669.765625 MB of memory in use. ENERGY: 360 39077.0492 107247.5651 82035.0355 5124.5022 -4007023.0946 288992.4244 0.0000 0.0000 646580.3050 -2837966.2132 292.8042 -3484546.5182 -2835460.9957 292.3760 -80.0013 -3.8281 10346711.8777 2.8888 2.8884 LDB: ============= START OF LOAD BALANCING ============== 104.621 LDB: Largest compute 40706 load 0.029617 is 0.3% of average load 11.009410 LDB: Average compute 0.002858 is 0.0% of average load 11.009410 LDB: TIME 104.634 LOAD: AVG 11.0094 MAX 11.0965 PROXIES: TOTAL 2249 MAXPE 188 MAXPATCH 3 None MEM: 2800.51 MB LDB: TIME 104.636 LOAD: AVG 11.0094 MAX 11.0965 PROXIES: TOTAL 2614 MAXPE 316 MAXPATCH 3 RefineTorusLB MEM: 2800.51 MB LDB: TIME 104.636 LOAD: AVG 11.0094 MAX 11.0965 PROXIES: TOTAL 2614 MAXPE 316 MAXPATCH 3 RefineTorusLB MEM: 2800.51 MB LDB: ============== END OF LOAD BALANCING =============== 104.638 Info: useSync: 0 useProxySync: 0 LDB: =============== DONE WITH MIGRATION ================ 104.642 Info: Benchmark time: 14 CPUs 0.211388 s/step 1.22331 days/ns 2808.6 MB memory TIMING: 480 CPU: 100.001, 0.207568/step Wall: 102.976, 0.211572/step, 0.0423145 hours remaining, 2808.601562 MB of memory in use. ENERGY: 480 39391.8475 107670.3705 82085.2872 5091.6597 -4001339.3774 287927.9200 0.0000 0.0000 648728.4621 -2830443.8304 293.7770 -3479172.2925 -2827872.9980 293.4913 -102.0611 -26.0251 10343777.9455 0.8739 0.9870 Info: Benchmark time: 14 CPUs 0.210755 s/step 1.21965 days/ns 2800.6 MB memory TIMING: 600 CPU: 124.821, 0.206835/step Wall: 128.267, 0.210757/step, 0.0351261 hours remaining, 2800.597656 MB of memory in use. ENERGY: 600 39291.0869 107369.5850 81909.1278 5192.0466 -3994389.8697 285433.0942 0.0000 0.0000 650341.5497 -2824853.3795 294.5075 -3475194.9293 -2822231.3350 294.2701 -69.0931 6.1622 10349181.5886 2.4829 2.5141 Info: Benchmark time: 14 CPUs 0.210889 s/step 1.22042 days/ns 2808.87 MB memory TIMING: 720 CPU: 149.657, 0.206969/step Wall: 153.574, 0.210891/step, 0.0281188 hours remaining, 2808.867188 MB of memory in use. ENERGY: 720 39071.9751 107456.2811 82080.3122 5072.3974 -3989980.2361 284012.3172 0.0000 0.0000 651505.9493 -2820781.0037 295.0348 -3472286.9530 -2818208.9897 294.8484 -96.5698 -20.9617 10354673.7702 -0.0095 0.0098 Info: Benchmark time: 14 CPUs 0.21041 s/step 1.21765 days/ns 2817.13 MB memory TIMING: 840 CPU: 174.426, 0.20641/step Wall: 178.823, 0.210411/step, 0.0210411 hours remaining, 2817.128906 MB of memory in use. ENERGY: 840 39123.7085 107662.0040 81846.6035 5121.6889 -3986941.7188 282823.0501 0.0000 0.0000 652775.8802 -2817588.7836 295.6099 -3470364.6638 -2814992.9532 295.3517 -80.1939 -2.2576 10352940.0010 -0.4087 -0.3721 Info: Benchmark time: 14 CPUs 0.209971 s/step 1.21511 days/ns 2820.64 MB memory TIMING: 960 CPU: 199.158, 0.206094/step Wall: 204.02, 0.209972/step, 0.0139982 hours remaining, 2820.636719 MB of memory in use. ENERGY: 960 39212.6050 107284.7456 82004.2300 5102.0942 -3985253.1289 282481.2263 0.0000 0.0000 653528.2939 -2815639.9339 295.9506 -3469168.2278 -2812976.6110 295.5930 -53.1702 20.1311 10357173.9474 3.5492 3.2945 Info: Benchmark time: 14 CPUs 0.210616 s/step 1.21884 days/ns 2834.25 MB memory TIMING: 1080 CPU: 223.961, 0.206694/step Wall: 229.294, 0.210618/step, 0.00702059 hours remaining, 2834.253906 MB of memory in use. ENERGY: 1080 39214.0487 107637.8381 81963.3824 5069.8144 -3984859.9954 283486.5252 0.0000 0.0000 654397.5948 -2813090.7917 296.3443 -3467488.3866 -2810367.8439 295.9093 -47.0129 26.5429 10357435.7647 0.5618 0.6314 TIMING: 1200 CPU: 248.729, 0.206402/step Wall: 254.529, 0.210293/step, 0 hours remaining, 2821.859375 MB of memory in use. ETITLE: TS BOND ANGLE DIHED IMPRP ELECT VDW BOUNDARY MISC KINETIC TOTAL TEMP POTENTIAL TOTAL3 TEMPAVG PRESSURE GPRESSURE VOLUME PRESSAVG GPRESSAVG ENERGY: 1200 39084.9474 107641.3516 82019.3406 5176.2433 -3982090.5850 283187.2352 0.0000 0.0000 653920.7562 -2811060.7107 296.1284 -3464981.4669 -2808553.9362 296.0940 -52.7179 20.0170 10365258.7272 2.3916 2.4420 WRITING EXTENDED SYSTEM TO OUTPUT FILE AT STEP 1200 WRITING COORDINATES TO OUTPUT FILE AT STEP 1200 WRITING VELOCITIES TO OUTPUT FILE AT STEP 1200 The last position output (seq=-2) takes 0.032 seconds(file I/O: 0.032 secs), 2929.594 MB of memory in use The last velocity output (seq=-2) takes 0.057 seconds(file I/O: 0.034 secs), 2929.594 MB of memory in use ==================================================== WallClock: 256.815369 CPUTime: 249.391083 Memory: 2929.593750 MB