root@beastie:/zoo/lz4_compress # iozone -M -e -+u -T -t 8 -r 128k -s128m -i 0 -i 1 -i 2 -i 8 -+p 70 -C Iozone: Performance Test of File I/O Version $Revision: 3.420 $ Compiled for 32 bit mode. Build: freebsd Contributors:William Norcott, Don Capps, Isom Crawford, Kirby Collins Al Slater, Scott Rhine, Mike Wisner, Ken Goss Steve Landherr, Brad Smith, Mark Kelly, Dr. Alain CYR, Randy Dunlap, Mark Montague, Dan Million, Gavin Brebner, Jean-Marc Zucconi, Jeff Blomberg, Benny Halevy, Dave Boone, Erik Habbinga, Kris Strecker, Walter Wong, Joshua Root, Fabrice Bacchella, Zhenghua Xue, Qin Li, Darren Sawyer, Vangel Bojaxhi, Ben England, Vikentsi Lapa. Run began: Fri Feb 5 11:55:47 2016 Machine = FreeBSD beastie.mstride.com 11.0-CURRENT FreeBSD 11.0-CURRENT #4 r28 Include fsync in write timing Include fsync in write timing CPU utilization Resolution = 0.000 seconds. CPU utilization Excel chart enabled Record Size 128 KB File size set to 131072 KB Percent read in mix test is 70 Command line used: iozone -M -e -+u -T -t 8 -r 128k -s128m -i 0 -i 1 -i 2 -i 8 -+p 70 -C Output is in Kbytes/sec Time Resolution = 0.000001 seconds. Processor cache size set to 1024 Kbytes. Processor cache line size set to 32 bytes. File stride size set to 17 * record size. Throughput test with 8 threads Each thread writes a 131072 Kbyte file in 128 Kbyte records Children see throughput for 8 initial writers = 30284.38 KB/sec Parent sees throughput for 8 initial writers = 24551.17 KB/sec Min throughput per thread = 3085.54 KB/sec Max throughput per thread = 4671.07 KB/sec Avg throughput per thread = 3785.55 KB/sec Min xfer = 86656.00 KB CPU Utilization: Wall time 34.634 CPU time 9.854 CPU utilization 28.45 % Child[0] xfer count = 109824.00 KB, Throughput = 3910.50 KB/sec, wall=32.985, cpu= 1.239, %= 3.75 Child[1] xfer count = 95744.00 KB, Throughput = 3409.74 KB/sec, wall=34.604, cpu= 1.292, %= 3.73 Child[2] xfer count = 86656.00 KB, Throughput = 3085.54 KB/sec, wall=34.634, cpu= 1.309, %= 3.78 Child[3] xfer count = 106112.00 KB, Throughput = 3779.47 KB/sec, wall=34.132, cpu= 1.263, %= 3.70 Child[4] xfer count = 107648.00 KB, Throughput = 3833.58 KB/sec, wall=33.353, cpu= 1.240, %= 3.72 Child[5] xfer count = 99200.00 KB, Throughput = 3532.93 KB/sec, wall=33.829, cpu= 1.250, %= 3.70 Child[6] xfer count = 131072.00 KB, Throughput = 4671.07 KB/sec, wall=28.060, cpu= 1.064, %= 3.79 Child[7] xfer count = 114048.00 KB, Throughput = 4061.54 KB/sec, wall=32.045, cpu= 1.196, %= 3.73 Children see throughput for 8 rewriters = 30600.31 KB/sec Parent sees throughput for 8 rewriters = 30419.41 KB/sec Min throughput per thread = 3235.04 KB/sec Max throughput per thread = 4419.01 KB/sec Avg throughput per thread = 3825.04 KB/sec Min xfer = 97152.00 KB CPU utilization: Wall time 30.031 CPU time 9.819 CPU utilization 32.70 % Child[0] xfer count = 111360.00 KB, Throughput = 3736.48 KB/sec, wall=29.803, cpu= 1.227, %= 4.12 Child[1] xfer count = 130432.00 KB, Throughput = 4369.25 KB/sec, wall=29.852, cpu= 1.227, %= 4.11 Child[2] xfer count = 116736.00 KB, Throughput = 3910.42 KB/sec, wall=29.853, cpu= 1.228, %= 4.11 Child[3] xfer count = 104576.00 KB, Throughput = 3486.58 KB/sec, wall=29.994, cpu= 1.228, %= 4.09 Child[4] xfer count = 131072.00 KB, Throughput = 4419.01 KB/sec, wall=29.661, cpu= 1.225, %= 4.13 Child[5] xfer count = 105856.00 KB, Throughput = 3545.97 KB/sec, wall=29.853, cpu= 1.228, %= 4.11 Child[6] xfer count = 97152.00 KB, Throughput = 3235.04 KB/sec, wall=30.031, cpu= 1.229, %= 4.09 Child[7] xfer count = 116352.00 KB, Throughput = 3897.57 KB/sec, wall=29.852, cpu= 1.227, %= 4.11 Children see throughput for 8 readers = 688296.07 KB/sec Parent sees throughput for 8 readers = 688052.62 KB/sec Min throughput per thread = 79124.95 KB/sec Max throughput per thread = 92137.91 KB/sec Avg throughput per thread = 86037.01 KB/sec Min xfer = 112640.00 KB CPU utilization: Wall time 1.424 CPU time 5.777 CPU utilization 405.75 % Child[0] xfer count = 124928.00 KB, Throughput = 87787.48 KB/sec, wall= 1.423, cpu= 0.722, %= 50.74 Child[1] xfer count = 131072.00 KB, Throughput = 92137.91 KB/sec, wall= 1.423, cpu= 0.722, %= 50.74 Child[2] xfer count = 118272.00 KB, Throughput = 83077.02 KB/sec, wall= 1.424, cpu= 0.722, %= 50.74 Child[3] xfer count = 114688.00 KB, Throughput = 80570.55 KB/sec, wall= 1.423, cpu= 0.722, %= 50.72 Child[4] xfer count = 126080.00 KB, Throughput = 88602.67 KB/sec, wall= 1.423, cpu= 0.722, %= 50.74 Child[5] xfer count = 125056.00 KB, Throughput = 87841.31 KB/sec, wall= 1.424, cpu= 0.722, %= 50.74 Child[6] xfer count = 112640.00 KB, Throughput = 79124.95 KB/sec, wall= 1.424, cpu= 0.722, %= 50.73 Child[7] xfer count = 126848.00 KB, Throughput = 89154.16 KB/sec, wall= 1.423, cpu= 0.722, %= 50.72 Children see throughput for 8 re-readers = 605304.10 KB/sec Parent sees throughput for 8 re-readers = 604881.29 KB/sec Min throughput per thread = 71815.50 KB/sec Max throughput per thread = 79051.00 KB/sec Avg throughput per thread = 75663.01 KB/sec Min xfer = 119168.00 KB CPU utilization: Wall time 1.660 CPU time 7.246 CPU utilization 436.48 % Child[0] xfer count = 121472.00 KB, Throughput = 73239.17 KB/sec, wall= 1.659, cpu= 0.906, %= 54.61 Child[1] xfer count = 129408.00 KB, Throughput = 78019.56 KB/sec, wall= 1.659, cpu= 0.906, %= 54.60 Child[2] xfer count = 128128.00 KB, Throughput = 77179.92 KB/sec, wall= 1.660, cpu= 0.906, %= 54.58 Child[3] xfer count = 124160.00 KB, Throughput = 74794.23 KB/sec, wall= 1.660, cpu= 0.906, %= 54.57 Child[4] xfer count = 131072.00 KB, Throughput = 79051.00 KB/sec, wall= 1.658, cpu= 0.905, %= 54.59 Child[5] xfer count = 126208.00 KB, Throughput = 76106.26 KB/sec, wall= 1.658, cpu= 0.905, %= 54.60 Child[6] xfer count = 119168.00 KB, Throughput = 71815.50 KB/sec, wall= 1.659, cpu= 0.906, %= 54.61 Child[7] xfer count = 124672.00 KB, Throughput = 75098.45 KB/sec, wall= 1.660, cpu= 0.906, %= 54.58 Children see throughput for 8 random readers = 67699.27 KB/sec Parent sees throughput for 8 random readers = 67574.11 KB/sec Min throughput per thread = 7195.52 KB/sec Max throughput per thread = 9195.51 KB/sec Avg throughput per thread = 8462.41 KB/sec Min xfer = 102912.00 KB CPU utilization: Wall time 14.316 CPU time 5.599 CPU utilization 39.11 % Child[0] xfer count = 122880.00 KB, Throughput = 8601.01 KB/sec, wall=14.287, cpu= 0.700, %= 4.90 Child[1] xfer count = 127488.00 KB, Throughput = 8932.90 KB/sec, wall=14.272, cpu= 0.700, %= 4.90 Child[2] xfer count = 131072.00 KB, Throughput = 9195.51 KB/sec, wall=14.254, cpu= 0.700, %= 4.91 Child[3] xfer count = 114560.00 KB, Throughput = 8003.52 KB/sec, wall=14.314, cpu= 0.700, %= 4.89 Child[4] xfer count = 118656.00 KB, Throughput = 8288.18 KB/sec, wall=14.316, cpu= 0.700, %= 4.89 Child[5] xfer count = 130432.00 KB, Throughput = 9111.51 KB/sec, wall=14.315, cpu= 0.700, %= 4.89 Child[6] xfer count = 102912.00 KB, Throughput = 7195.52 KB/sec, wall=14.302, cpu= 0.700, %= 4.89 Child[7] xfer count = 119424.00 KB, Throughput = 8371.09 KB/sec, wall=14.266, cpu= 0.700, %= 4.90 Children see throughput for 8 mixed workload = 35763.80 KB/sec Parent sees throughput for 8 mixed workload = 28166.80 KB/sec Min throughput per thread = 2046.01 KB/sec Max throughput per thread = 5573.15 KB/sec Avg throughput per thread = 4470.48 KB/sec Min xfer = 48512.00 KB CPU utilization: Wall time 29.961 CPU time 7.025 CPU utilization 23.45 % Child[0] xfer count = 118656.00 KB, Throughput = 5042.52 KB/sec, wall=23.531, cpu= 0.815, %= 3.46 Child[1] xfer count = 131072.00 KB, Throughput = 5573.15 KB/sec, wall=23.518, cpu= 0.815, %= 3.46 Child[2] xfer count = 123392.00 KB, Throughput = 5243.34 KB/sec, wall=23.533, cpu= 0.815, %= 3.46 Child[3] xfer count = 114304.00 KB, Throughput = 4850.08 KB/sec, wall=23.567, cpu= 0.815, %= 3.46 Child[4] xfer count = 128512.00 KB, Throughput = 5455.62 KB/sec, wall=23.556, cpu= 0.815, %= 3.46 Child[5] xfer count = 109056.00 KB, Throughput = 4590.04 KB/sec, wall=26.625, cpu= 0.908, %= 3.41 Child[6] xfer count = 70400.00 KB, Throughput = 2963.05 KB/sec, wall=29.506, cpu= 1.016, %= 3.45 Child[7] xfer count = 48512.00 KB, Throughput = 2046.01 KB/sec, wall=29.961, cpu= 1.027, %= 3.43 Children see throughput for 8 random writers = 28976.32 KB/sec Parent sees throughput for 8 random writers = 25149.10 KB/sec Min throughput per thread = 2993.87 KB/sec Max throughput per thread = 4206.70 KB/sec Avg throughput per thread = 3622.04 KB/sec Min xfer = 95360.00 KB CPU utilization: Wall time 36.269 CPU time 11.238 CPU utilization 30.98 % Child[0] xfer count = 108672.00 KB, Throughput = 3411.81 KB/sec, wall=36.249, cpu= 1.473, %= 4.06 Child[1] xfer count = 124672.00 KB, Throughput = 3996.08 KB/sec, wall=31.852, cpu= 1.308, %= 4.11 Child[2] xfer count = 117248.00 KB, Throughput = 3758.19 KB/sec, wall=32.442, cpu= 1.337, %= 4.12 Child[3] xfer count = 115584.00 KB, Throughput = 3628.79 KB/sec, wall=35.345, cpu= 1.445, %= 4.09 Child[4] xfer count = 115328.00 KB, Throughput = 3641.18 KB/sec, wall=35.314, cpu= 1.444, %= 4.09 Child[5] xfer count = 104192.00 KB, Throughput = 3339.69 KB/sec, wall=36.057, cpu= 1.467, %= 4.07 Child[6] xfer count = 95360.00 KB, Throughput = 2993.87 KB/sec, wall=36.269, cpu= 1.474, %= 4.06 Child[7] xfer count = 131072.00 KB, Throughput = 4206.70 KB/sec, wall=31.158, cpu= 1.290, %= 4.14 iozone test complete.