Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4100 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 19:02:53 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 19:02:53 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Tue Mar 30 19:03:09 2010 Completed. Tue Mar 30 19:03:09 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:03:09 2010 Completed. Tue Mar 30 19:03:09 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:03:09 2010 Received. Tue Mar 30 19:03:09 2010 Initializing test directories. Tue Mar 30 19:03:09 2010 Child 3 will create 167 directories. Tue Mar 30 19:03:09 2010 Child 2 will create 167 directories. Tue Mar 30 19:03:09 2010 Child 0 will create 167 directories. Tue Mar 30 19:03:09 2010 Child 1 will create 167 directories. Tue Mar 30 19:03:11 2010 Child 1 finished creating 167 directories. Tue Mar 30 19:03:11 2010 Child 1 will create 5102 files. Tue Mar 30 19:03:14 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 19:03:14 2010 Child 1 will create 6 symlinks. Tue Mar 30 19:03:14 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 19:03:14 2010 Child 2 finished creating 167 directories. Tue Mar 30 19:03:14 2010 Child 2 will create 5102 files. Tue Mar 30 19:03:16 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 19:03:16 2010 Child 2 will create 6 symlinks. Tue Mar 30 19:03:16 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 19:03:17 2010 Child 0 finished creating 167 directories. Tue Mar 30 19:03:17 2010 Child 0 will create 5102 files. Tue Mar 30 19:03:17 2010 Child 3 finished creating 167 directories. Tue Mar 30 19:03:17 2010 Child 3 will create 5102 files. Tue Mar 30 19:03:18 2010 Child 0 verified 5102 files, created 47 Tue Mar 30 19:03:18 2010 Child 0 will create 6 symlinks. Tue Mar 30 19:03:18 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 19:03:19 2010 Child 3 verified 5102 files, created 50 Tue Mar 30 19:03:19 2010 Child 3 will create 6 symlinks. Tue Mar 30 19:03:19 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 19:03:19 2010 Completed. Tue Mar 30 19:03:19 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:03:19 2010 Completed. Tue Mar 30 19:03:19 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:03:20 2010 Received. Tue Mar 30 19:03:20 2010 Performing 300 seconds pretest warmup. Child 1 - 50 aborted ops Child 0 - 50 aborted ops Child 1 - 100 aborted ops Child 2 - 50 aborted ops Child 2 - 100 aborted ops Child 0 - 100 aborted ops Child 1 - 150 aborted ops Child 2 - 150 aborted ops Child 1 - 200 aborted ops Child 2 - 200 aborted ops Child 3 - 50 aborted ops Child 0 - 150 aborted ops Child 1 - 250 aborted ops Child 2 - 250 aborted ops Child 1 - 300 aborted ops Child 2 - 300 aborted ops Child 0 - 200 aborted ops Child 1 - 350 aborted ops Child 2 - 350 aborted ops Child 0 - 250 aborted ops Child 3 - 100 aborted ops Child 0 - 300 aborted ops Child 2 - 400 aborted ops Child 0 - 350 aborted ops Child 3 - 150 aborted ops Child 1 - 400 aborted ops Child 0 - 400 aborted ops Child 3 - 200 aborted ops Child 2 - 450 aborted ops Child 1 - 450 aborted ops Child 0 - 450 aborted ops Child 3 - 250 aborted ops Child 0 - 500 aborted ops Child 2 - 500 aborted ops Child 3 - 300 aborted ops Child 1 - 500 aborted ops Child 3 - 350 aborted ops Child 0 - 550 aborted ops Child 3 - 400 aborted ops Child 1 - 550 aborted ops Child 0 - 600 aborted ops Child 2 - 550 aborted ops Child 0 - 650 aborted ops Child 0 - 700 aborted ops Child 2 - 600 aborted ops Child 1 - 600 aborted ops Child 0 - 750 aborted ops Child 3 - 450 aborted ops Child 0 - 800 aborted ops Child 2 - 650 aborted ops Child 3 - 500 aborted ops Child 0 - 850 aborted ops Child 3 - 550 aborted ops Child 0 - 900 aborted ops Child 2 - 700 aborted ops Child 1 - 650 aborted ops Child 0 - 950 aborted ops Child 3 - 600 aborted ops Child 1 - 700 aborted ops Child 3 - 650 aborted ops Child 0 - 1000 aborted ops Child 2 - 750 aborted ops Child 1 - 750 aborted ops Child 1 - 800 aborted ops Child 3 - 700 aborted ops Child 0 - 1050 aborted ops Child 2 - 800 aborted ops Child 3 - 750 aborted ops Child 1 - 850 aborted ops Child 3 - 800 aborted ops Child 0 - 1100 aborted ops Child 3 - 850 aborted ops Child 1 - 900 aborted ops Child 2 - 850 aborted ops Child 3 - 900 aborted ops Child 0 - 1150 aborted ops Child 1 - 950 aborted ops Child 1 - 1000 aborted ops Child 2 - 900 aborted ops Child 3 - 950 aborted ops Child 1 - 1050 aborted ops Child 3 - 1000 aborted ops Child 3 - 1050 aborted ops Child 1 - 1100 aborted ops Child 0 - 1200 aborted ops Child 2 - 950 aborted ops Child 3 - 1100 aborted ops Child 1 - 1150 aborted ops Child 2 - 1000 aborted ops Child 0 - 1250 aborted ops Child 2 - 1050 aborted ops Child 3 - 1150 aborted ops Child 0 - 1300 aborted ops Tue Mar 30 19:08:20 2010 Completed. Tue Mar 30 19:08:20 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:08:20 2010 Completed. Tue Mar 30 19:08:20 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:08:21 2010 Received. Tue Mar 30 19:08:21 2010 Starting 300 seconds test run. Child 2 - 1100 aborted ops Child 3 - 1200 aborted ops Child 3 - 1250 aborted ops Child 2 - 1150 aborted ops Child 0 - 1350 aborted ops Child 1 - 1200 aborted ops Child 0 - 1400 aborted ops Child 0 - 1450 aborted ops Child 1 - 1250 aborted ops Child 2 - 1200 aborted ops Child 2 - 1250 aborted ops Child 2 - 1300 aborted ops Child 3 - 1300 aborted ops Child 1 - 1300 aborted ops Child 0 - 1500 aborted ops Child 1 - 1350 aborted ops Child 3 - 1350 aborted ops Child 0 - 1550 aborted ops Child 1 - 1400 aborted ops Child 0 - 1600 aborted ops Child 3 - 1400 aborted ops Child 1 - 1450 aborted ops Child 0 - 1650 aborted ops Child 2 - 1350 aborted ops Child 0 - 1700 aborted ops Child 1 - 1500 aborted ops Child 0 - 1750 aborted ops Child 2 - 1400 aborted ops Child 1 - 1550 aborted ops Child 3 - 1450 aborted ops Child 3 - 1500 aborted ops Child 3 - 1550 aborted ops Child 2 - 1450 aborted ops Child 2 - 1500 aborted ops Child 0 - 1800 aborted ops Child 1 - 1600 aborted ops Child 0 - 1850 aborted ops Child 1 - 1650 aborted ops Child 0 - 1900 aborted ops Child 1 - 1700 aborted ops Child 0 - 1950 aborted ops Child 3 - 1600 aborted ops Child 2 - 1550 aborted ops Child 2 - 1600 aborted ops Child 3 - 1650 aborted ops Child 1 - 1750 aborted ops Child 2 - 1650 aborted ops Child 0 - 2000 aborted ops Child 3 - 1700 aborted ops Child 1 - 1800 aborted ops Child 1 - 1850 aborted ops Child 2 - 1700 aborted ops Child 0 - 2050 aborted ops Child 3 - 1750 aborted ops Child 1 - 1900 aborted ops Child 2 - 1750 aborted ops Child 0 - 2100 aborted ops Child 1 - 1950 aborted ops Child 2 - 1800 aborted ops Child 0 - 2150 aborted ops Child 2 - 1850 aborted ops Child 3 - 1800 aborted ops Child 2 - 1900 aborted ops Child 1 - 2000 aborted ops Child 3 - 1850 aborted ops Child 0 - 2200 aborted ops Child 2 - 1950 aborted ops Child 1 - 2050 aborted ops Child 2 - 2000 aborted ops Child 2 - 2050 aborted ops Child 0 - 2250 aborted ops Child 2 - 2100 aborted ops Child 1 - 2100 aborted ops Child 3 - 1900 aborted ops Child 2 - 2150 aborted ops Child 0 - 2300 aborted ops Child 1 - 2150 aborted ops Child 1 - 2200 aborted ops Child 0 - 2350 aborted ops Child 3 - 1950 aborted ops Child 1 - 2250 aborted ops Child 1 - 2300 aborted ops Child 0 - 2400 aborted ops Child 1 - 2350 aborted ops Child 2 - 2200 aborted ops Child 3 - 2000 aborted ops Child 2 - 2250 aborted ops Child 1 - 2400 aborted ops Child 3 - 2050 aborted ops Child 2 - 2300 aborted ops Child 0 - 2450 aborted ops Child 1 - 2450 aborted ops Child 3 - 2100 aborted ops Child 2 - 2350 aborted ops Child 0 - 2500 aborted ops Child 2 - 2400 aborted ops Child 3 - 2150 aborted ops Child 2 - 2450 aborted ops Child 0 - 2550 aborted ops Child 3 - 2200 aborted ops Child 1 - 2500 aborted ops Child 0 - 2600 aborted ops Child 3 - 2250 aborted ops Child 0 - 2650 aborted ops Child 3 - 2300 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 19:13:32 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 318994 318994 0 0.18 6.83 0.01 5.5% setattr 4.0% 4.0% 49259 49259 0 0.19 0.61 0.01 0.9% lookup 24.0% 24.1% 294376 294376 0 0.18 1.01 0.00 5.0% readlink 1.0% 1.0% 12266 12266 0 0.17 0.11 0.01 0.2% read 18.0% 18.1% 220939 271430 0 0.51 0.79 0.00 10.7% write 10.0% 10.0% 122771 148250 0 5.75 94.17 0.05 67.0% create 1.0% 1.0% 12481 12481 0 3.59 83.73 0.16 4.3% remove 1.0% 0.6% 7133 7133 0 0.20 0.25 0.01 0.1% readdir 1.0% 1.0% 12332 12332 0 0.48 0.44 0.01 0.6% fsstat 1.0% 1.0% 12196 12196 0 0.18 0.53 0.01 0.2% access 11.0% 11.1% 135744 135744 0 0.17 0.26 0.00 2.2% commit 0.0% 0.0% 0 73918 0 0.00 0.00 0.00 1.2% readdirplus 2.0% 2.0% 24527 24527 0 0.88 0.51 0.01 2.0% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4063.18 Ops/Sec AVG. RESPONSE TIME: 0.86 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4100 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1223018 TEST TIME: 301 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1372906 PHYSICAL NFS V3 THROUGHPUT: 4561.14 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3536395.0 KB (100.00% to 110.92% of Base) ------------------------------------------------------------------------ Tue Mar 30 19:13:32 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4100 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 19:13:32 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:13:32 2010 Completed. Tue Mar 30 19:13:32 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 19:13:33 2010 Received. Tue Mar 30 19:13:33 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 19:13:33 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4200 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 19:13:35 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 19:13:35 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 19:13:46 2010 Completed. Tue Mar 30 19:13:46 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:13:46 2010 Completed. Tue Mar 30 19:13:46 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:13:51 2010 Received. Tue Mar 30 19:13:51 2010 Initializing test directories. Tue Mar 30 19:13:51 2010 Child 0 will create 167 directories. Tue Mar 30 19:13:51 2010 Child 1 will create 167 directories. Tue Mar 30 19:13:51 2010 Child 2 will create 167 directories. Tue Mar 30 19:13:51 2010 Child 3 will create 167 directories. Tue Mar 30 19:13:58 2010 Child 1 finished creating 167 directories. Tue Mar 30 19:13:58 2010 Child 1 will create 5102 files. Tue Mar 30 19:14:01 2010 Child 2 finished creating 167 directories. Tue Mar 30 19:14:01 2010 Child 2 will create 5102 files. Tue Mar 30 19:14:04 2010 Child 3 finished creating 167 directories. Tue Mar 30 19:14:04 2010 Child 3 will create 5102 files. Tue Mar 30 19:14:05 2010 Child 0 finished creating 167 directories. Tue Mar 30 19:14:05 2010 Child 0 will create 5102 files. Tue Mar 30 19:14:05 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 19:14:05 2010 Child 2 will create 6 symlinks. Tue Mar 30 19:14:05 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 19:14:10 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 19:14:10 2010 Child 1 will create 6 symlinks. Tue Mar 30 19:14:10 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 19:14:14 2010 Child 3 verified 5102 files, created 47 Tue Mar 30 19:14:14 2010 Child 3 will create 6 symlinks. Tue Mar 30 19:14:14 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 19:14:23 2010 Child 0 verified 5102 files, created 42 Tue Mar 30 19:14:23 2010 Child 0 will create 6 symlinks. Tue Mar 30 19:14:23 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 19:14:24 2010 Completed. Tue Mar 30 19:14:24 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:14:24 2010 Completed. Tue Mar 30 19:14:24 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:14:25 2010 Received. Tue Mar 30 19:14:25 2010 Performing 300 seconds pretest warmup. Child 3 - 50 aborted ops Child 3 - 100 aborted ops Child 1 - 50 aborted ops Child 1 - 100 aborted ops Child 3 - 150 aborted ops Child 0 - 50 aborted ops Child 2 - 50 aborted ops Child 1 - 150 aborted ops Child 3 - 200 aborted ops Child 1 - 200 aborted ops Child 2 - 100 aborted ops Child 0 - 100 aborted ops Child 3 - 250 aborted ops Child 2 - 150 aborted ops Child 3 - 300 aborted ops Child 1 - 250 aborted ops Child 0 - 150 aborted ops Child 2 - 200 aborted ops Child 3 - 350 aborted ops Child 2 - 250 aborted ops Child 0 - 200 aborted ops Child 3 - 400 aborted ops Child 2 - 300 aborted ops Child 1 - 300 aborted ops Child 1 - 350 aborted ops Child 2 - 350 aborted ops Child 0 - 250 aborted ops Child 3 - 450 aborted ops Child 3 - 500 aborted ops Child 1 - 400 aborted ops Child 0 - 300 aborted ops Child 2 - 400 aborted ops Child 0 - 350 aborted ops Child 1 - 450 aborted ops Child 2 - 450 aborted ops Child 3 - 550 aborted ops Child 2 - 500 aborted ops Child 1 - 500 aborted ops Child 0 - 400 aborted ops Child 3 - 600 aborted ops Child 2 - 550 aborted ops Child 1 - 550 aborted ops Child 0 - 450 aborted ops Child 3 - 650 aborted ops Child 2 - 600 aborted ops Child 2 - 650 aborted ops Child 1 - 600 aborted ops Tue Mar 30 19:19:25 2010 Completed. Tue Mar 30 19:19:25 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:19:25 2010 Completed. Tue Mar 30 19:19:25 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:19:26 2010 Received. Tue Mar 30 19:19:26 2010 Starting 300 seconds test run. Child 0 - 500 aborted ops Child 3 - 700 aborted ops Child 2 - 700 aborted ops Child 0 - 550 aborted ops Child 3 - 750 aborted ops Child 1 - 650 aborted ops Child 0 - 600 aborted ops Child 0 - 650 aborted ops Child 1 - 700 aborted ops Child 2 - 750 aborted ops Child 1 - 750 aborted ops Child 3 - 800 aborted ops Child 2 - 800 aborted ops Child 3 - 850 aborted ops Child 2 - 850 aborted ops Child 1 - 800 aborted ops Child 0 - 700 aborted ops Child 0 - 750 aborted ops Child 1 - 850 aborted ops Child 0 - 800 aborted ops Child 1 - 900 aborted ops Child 0 - 850 aborted ops Child 2 - 900 aborted ops Child 3 - 900 aborted ops Child 2 - 950 aborted ops Child 3 - 950 aborted ops Child 2 - 1000 aborted ops Child 3 - 1000 aborted ops Child 1 - 950 aborted ops Child 1 - 1000 aborted ops Child 1 - 1050 aborted ops Child 2 - 1050 aborted ops Child 0 - 900 aborted ops Child 0 - 950 aborted ops Child 2 - 1100 aborted ops Child 0 - 1000 aborted ops Child 2 - 1150 aborted ops Child 3 - 1050 aborted ops Child 1 - 1100 aborted ops Child 3 - 1100 aborted ops Child 0 - 1050 aborted ops Child 2 - 1200 aborted ops Child 1 - 1150 aborted ops Child 2 - 1250 aborted ops Child 0 - 1100 aborted ops Child 2 - 1300 aborted ops Child 1 - 1200 aborted ops Child 0 - 1150 aborted ops Child 2 - 1350 aborted ops Child 3 - 1150 aborted ops Child 0 - 1200 aborted ops Child 1 - 1250 aborted ops Child 3 - 1200 aborted ops Child 0 - 1250 aborted ops Child 1 - 1300 aborted ops Child 2 - 1400 aborted ops Child 0 - 1300 aborted ops Child 3 - 1250 aborted ops Child 1 - 1350 aborted ops Child 0 - 1350 aborted ops Child 2 - 1450 aborted ops Child 3 - 1300 aborted ops Child 1 - 1400 aborted ops Child 0 - 1400 aborted ops Child 3 - 1350 aborted ops Child 2 - 1500 aborted ops Child 1 - 1450 aborted ops Child 0 - 1450 aborted ops Child 3 - 1400 aborted ops Child 0 - 1500 aborted ops Child 3 - 1450 aborted ops Child 1 - 1500 aborted ops Child 2 - 1550 aborted ops Child 3 - 1500 aborted ops Child 2 - 1600 aborted ops Child 1 - 1550 aborted ops Child 3 - 1550 aborted ops Child 1 - 1600 aborted ops Child 2 - 1650 aborted ops Child 0 - 1550 aborted ops Child 3 - 1600 aborted ops Child 1 - 1650 aborted ops Child 0 - 1600 aborted ops Child 2 - 1700 aborted ops Child 1 - 1700 aborted ops Child 2 - 1750 aborted ops Child 2 - 1800 aborted ops Child 3 - 1650 aborted ops Child 0 - 1650 aborted ops Child 3 - 1700 aborted ops Child 1 - 1750 aborted ops Child 0 - 1700 aborted ops Child 2 - 1850 aborted ops Child 2 - 1900 aborted ops Child 1 - 1800 aborted ops Child 0 - 1750 aborted ops Child 1 - 1850 aborted ops Child 3 - 1750 aborted ops Child 0 - 1800 aborted ops Child 3 - 1800 aborted ops Child 1 - 1900 aborted ops Child 1 - 1950 aborted ops Child 2 - 1950 aborted ops Child 2 - 2000 aborted ops Child 1 - 2000 aborted ops Child 1 - 2050 aborted ops Child 0 - 1850 aborted ops Child 2 - 2050 aborted ops Child 0 - 1900 aborted ops Child 3 - 1850 aborted ops Child 0 - 1950 aborted ops Child 3 - 1900 aborted ops Child 3 - 1950 aborted ops Child 2 - 2100 aborted ops Child 2 - 2150 aborted ops Child 2 - 2200 aborted ops Child 2 - 2250 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 19:25:17 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 316219 316219 0 0.17 0.22 0.00 6.1% setattr 4.0% 4.0% 48333 48333 0 0.21 4.66 0.02 1.1% lookup 24.0% 24.1% 292562 292562 0 0.18 0.23 0.00 5.9% readlink 1.0% 1.0% 12030 12030 0 0.17 0.08 0.01 0.2% read 18.0% 18.1% 219620 270707 2 0.53 1.16 0.00 13.1% write 10.0% 10.1% 121983 147839 2 4.33 37.30 0.03 60.0% create 1.0% 1.0% 12073 12073 0 4.37 83.72 0.16 6.0% remove 1.0% 0.5% 6420 6420 0 0.20 0.11 0.01 0.1% readdir 1.0% 1.0% 12150 12150 0 0.48 0.15 0.01 0.7% fsstat 1.0% 1.0% 11931 11931 0 0.17 0.12 0.01 0.2% access 11.0% 11.1% 134138 134138 0 0.17 0.25 0.00 2.6% commit 0.0% 0.0% 0 73356 0 0.00 0.00 0.00 1.4% readdirplus 2.0% 2.0% 24217 24217 0 0.87 0.22 0.01 2.4% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 3563.75 Ops/Sec AVG. RESPONSE TIME: 0.72 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4200 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1211676 TEST TIME: 340 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1361975 PHYSICAL NFS V3 THROUGHPUT: 4005.80 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 19:25:17 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4200 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 19:25:17 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:25:17 2010 Completed. Tue Mar 30 19:25:17 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 19:25:18 2010 Received. Tue Mar 30 19:25:18 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 19:25:18 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4300 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 19:25:20 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 19:25:20 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Tue Mar 30 19:25:36 2010 Completed. Tue Mar 30 19:25:36 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:25:36 2010 Completed. Tue Mar 30 19:25:36 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:25:36 2010 Received. Tue Mar 30 19:25:36 2010 Initializing test directories. Tue Mar 30 19:25:36 2010 Child 2 will create 167 directories. Tue Mar 30 19:25:36 2010 Child 1 will create 167 directories. Tue Mar 30 19:25:36 2010 Child 3 will create 167 directories. Tue Mar 30 19:25:36 2010 Child 0 will create 167 directories. Tue Mar 30 19:25:38 2010 Child 3 finished creating 167 directories. Tue Mar 30 19:25:38 2010 Child 3 will create 5102 files. Tue Mar 30 19:26:56 2010 Child 0 finished creating 167 directories. Tue Mar 30 19:26:56 2010 Child 0 will create 5102 files. Tue Mar 30 19:26:59 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 19:26:59 2010 Child 3 will create 6 symlinks. Tue Mar 30 19:26:59 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 19:27:00 2010 Child 1 finished creating 167 directories. Tue Mar 30 19:27:00 2010 Child 1 will create 5102 files. Tue Mar 30 19:27:03 2010 Child 2 finished creating 167 directories. Tue Mar 30 19:27:03 2010 Child 2 will create 5102 files. Tue Mar 30 19:27:08 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 19:27:08 2010 Child 1 will create 6 symlinks. Tue Mar 30 19:27:08 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 19:27:08 2010 Child 0 verified 5102 files, created 49 Tue Mar 30 19:27:08 2010 Child 0 will create 6 symlinks. Tue Mar 30 19:27:08 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 19:27:09 2010 Child 2 verified 5102 files, created 50 Tue Mar 30 19:27:09 2010 Child 2 will create 6 symlinks. Tue Mar 30 19:27:09 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 19:27:09 2010 Completed. Tue Mar 30 19:27:09 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:27:09 2010 Completed. Tue Mar 30 19:27:09 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:27:10 2010 Received. Tue Mar 30 19:27:10 2010 Performing 300 seconds pretest warmup. Child 0 - 50 aborted ops Child 2 - 50 aborted ops Child 1 - 50 aborted ops Child 0 - 100 aborted ops Child 2 - 100 aborted ops Child 3 - 50 aborted ops Child 1 - 100 aborted ops Child 0 - 150 aborted ops Child 3 - 100 aborted ops Child 0 - 200 aborted ops Child 2 - 150 aborted ops Child 1 - 150 aborted ops Child 2 - 200 aborted ops Child 3 - 150 aborted ops Child 1 - 200 aborted ops Child 0 - 250 aborted ops Child 3 - 200 aborted ops Child 0 - 300 aborted ops Child 1 - 250 aborted ops Child 2 - 250 aborted ops Child 3 - 250 aborted ops Child 1 - 300 aborted ops Child 3 - 300 aborted ops Child 2 - 300 aborted ops Child 0 - 350 aborted ops Child 1 - 350 aborted ops Child 3 - 350 aborted ops Child 1 - 400 aborted ops Child 1 - 450 aborted ops Child 0 - 400 aborted ops Child 3 - 400 aborted ops Child 2 - 350 aborted ops Child 1 - 500 aborted ops Child 0 - 450 aborted ops Child 3 - 450 aborted ops Child 2 - 400 aborted ops Child 3 - 500 aborted ops Child 1 - 550 aborted ops Child 2 - 450 aborted ops Child 0 - 500 aborted ops Child 1 - 600 aborted ops Child 3 - 550 aborted ops Child 2 - 500 aborted ops Child 3 - 600 aborted ops Child 1 - 650 aborted ops Child 2 - 550 aborted ops Child 0 - 550 aborted ops Child 3 - 650 aborted ops Child 0 - 600 aborted ops Child 2 - 600 aborted ops Child 1 - 700 aborted ops Child 3 - 700 aborted ops Child 2 - 650 aborted ops Child 0 - 650 aborted ops Child 1 - 750 aborted ops Child 3 - 750 aborted ops Child 2 - 700 aborted ops Child 0 - 700 aborted ops Child 3 - 800 aborted ops Child 1 - 800 aborted ops Child 2 - 750 aborted ops Child 3 - 850 aborted ops Child 0 - 750 aborted ops Child 1 - 850 aborted ops Child 3 - 900 aborted ops Child 2 - 800 aborted ops Child 0 - 800 aborted ops Child 2 - 850 aborted ops Child 3 - 950 aborted ops Child 1 - 900 aborted ops Child 0 - 850 aborted ops Child 2 - 900 aborted ops Child 3 - 1000 aborted ops Child 0 - 900 aborted ops Child 1 - 950 aborted ops Child 2 - 950 aborted ops Child 0 - 950 aborted ops Child 1 - 1000 aborted ops Child 2 - 1000 aborted ops Child 0 - 1000 aborted ops Child 3 - 1050 aborted ops Child 1 - 1050 aborted ops Child 2 - 1050 aborted ops Child 3 - 1100 aborted ops Child 0 - 1050 aborted ops Child 2 - 1100 aborted ops Child 1 - 1100 aborted ops Child 3 - 1150 aborted ops Child 0 - 1100 aborted ops Child 2 - 1150 aborted ops Child 1 - 1150 aborted ops Child 3 - 1200 aborted ops Child 2 - 1200 aborted ops Child 1 - 1200 aborted ops Child 0 - 1150 aborted ops Child 0 - 1200 aborted ops Tue Mar 30 19:32:10 2010 Completed. Tue Mar 30 19:32:10 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:32:10 2010 Completed. Tue Mar 30 19:32:10 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:32:11 2010 Received. Tue Mar 30 19:32:11 2010 Starting 300 seconds test run. Child 1 - 1250 aborted ops Child 3 - 1250 aborted ops Child 2 - 1250 aborted ops Child 0 - 1250 aborted ops Child 2 - 1300 aborted ops Child 1 - 1300 aborted ops Child 3 - 1300 aborted ops Child 2 - 1350 aborted ops Child 1 - 1350 aborted ops Child 3 - 1350 aborted ops Child 2 - 1400 aborted ops Child 0 - 1300 aborted ops Child 1 - 1400 aborted ops Child 2 - 1450 aborted ops Child 3 - 1400 aborted ops Child 2 - 1500 aborted ops Child 1 - 1450 aborted ops Child 0 - 1350 aborted ops Child 3 - 1450 aborted ops Child 2 - 1550 aborted ops Child 1 - 1500 aborted ops Child 0 - 1400 aborted ops Child 3 - 1500 aborted ops Child 2 - 1600 aborted ops Child 1 - 1550 aborted ops Child 3 - 1550 aborted ops Child 2 - 1650 aborted ops Child 0 - 1450 aborted ops Child 3 - 1600 aborted ops Child 1 - 1600 aborted ops Child 2 - 1700 aborted ops Child 0 - 1500 aborted ops Child 3 - 1650 aborted ops Child 2 - 1750 aborted ops Child 3 - 1700 aborted ops Child 1 - 1650 aborted ops Child 0 - 1550 aborted ops Child 2 - 1800 aborted ops Child 3 - 1750 aborted ops Child 1 - 1700 aborted ops Child 0 - 1600 aborted ops Child 1 - 1750 aborted ops Child 3 - 1800 aborted ops Child 0 - 1650 aborted ops Child 1 - 1800 aborted ops Child 2 - 1850 aborted ops Child 3 - 1850 aborted ops Child 0 - 1700 aborted ops Child 1 - 1850 aborted ops Child 2 - 1900 aborted ops Child 3 - 1900 aborted ops Child 1 - 1900 aborted ops Child 1 - 1950 aborted ops Child 3 - 1950 aborted ops Child 2 - 1950 aborted ops Child 1 - 2000 aborted ops Child 0 - 1750 aborted ops Child 0 - 1800 aborted ops Child 2 - 2000 aborted ops Child 1 - 2050 aborted ops Child 3 - 2000 aborted ops Child 2 - 2050 aborted ops Child 0 - 1850 aborted ops Child 0 - 1900 aborted ops Child 2 - 2100 aborted ops Child 0 - 1950 aborted ops Child 1 - 2100 aborted ops Child 2 - 2150 aborted ops Child 1 - 2150 aborted ops Child 3 - 2050 aborted ops Child 0 - 2000 aborted ops Child 0 - 2050 aborted ops Child 3 - 2100 aborted ops Child 2 - 2200 aborted ops Child 2 - 2250 aborted ops Child 1 - 2200 aborted ops Child 3 - 2150 aborted ops Child 3 - 2200 aborted ops Child 0 - 2100 aborted ops Child 1 - 2250 aborted ops Child 3 - 2250 aborted ops Child 2 - 2300 aborted ops Child 0 - 2150 aborted ops Child 1 - 2300 aborted ops Child 2 - 2350 aborted ops Child 2 - 2400 aborted ops Child 1 - 2350 aborted ops Child 3 - 2300 aborted ops Child 0 - 2200 aborted ops Child 1 - 2400 aborted ops Child 0 - 2250 aborted ops Child 0 - 2300 aborted ops Child 2 - 2450 aborted ops Child 3 - 2350 aborted ops Child 0 - 2350 aborted ops Child 2 - 2500 aborted ops Child 1 - 2450 aborted ops Child 1 - 2500 aborted ops Child 3 - 2400 aborted ops Child 1 - 2550 aborted ops Child 3 - 2450 aborted ops Child 2 - 2550 aborted ops Child 2 - 2600 aborted ops Child 0 - 2400 aborted ops Child 2 - 2650 aborted ops Child 3 - 2500 aborted ops Child 0 - 2450 aborted ops Child 1 - 2600 aborted ops Child 3 - 2550 aborted ops Child 1 - 2650 aborted ops Child 3 - 2600 aborted ops Child 3 - 2650 aborted ops Child 2 - 2700 aborted ops Child 0 - 2500 aborted ops Child 0 - 2550 aborted ops Child 2 - 2750 aborted ops Child 1 - 2700 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 19:37:21 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.2% 342475 342475 0 0.18 0.32 0.00 5.3% setattr 4.0% 4.0% 52432 52432 0 0.24 9.67 0.03 1.1% lookup 24.0% 24.1% 315914 315914 0 0.19 1.46 0.00 5.1% readlink 1.0% 1.0% 12889 12889 0 0.18 0.13 0.01 0.2% read 18.0% 18.1% 236300 290794 0 0.52 1.20 0.00 10.8% write 10.0% 10.0% 131422 159007 0 5.89 100.98 0.05 67.7% create 1.0% 1.0% 12854 12854 0 2.96 82.17 0.16 3.3% remove 1.0% 0.6% 7288 7288 0 0.22 0.82 0.02 0.1% readdir 1.0% 1.0% 13074 13074 0 0.49 0.35 0.01 0.6% fsstat 1.0% 1.0% 13230 13230 0 0.18 0.36 0.01 0.2% access 11.0% 11.0% 144566 144566 0 0.18 0.64 0.00 2.2% commit 0.0% 0.0% 0 79160 0 0.00 0.00 0.00 1.2% readdirplus 2.0% 2.0% 26462 26462 0 0.89 0.46 0.01 2.1% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4377.61 Ops/Sec AVG. RESPONSE TIME: 0.87 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4300 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1308906 TEST TIME: 299 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1470145 PHYSICAL NFS V3 THROUGHPUT: 4916.87 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3519490.0 KB (100.00% to 110.39% of Base) ------------------------------------------------------------------------ Tue Mar 30 19:37:21 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4300 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 19:37:21 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:37:21 2010 Completed. Tue Mar 30 19:37:21 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 19:37:22 2010 Received. Tue Mar 30 19:37:22 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 19:37:22 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4400 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 19:37:24 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 19:37:24 2010 Mounting 4 remote test directories. Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Child[000]: NFS negotiated block size 32768 Tue Mar 30 19:37:40 2010 Completed. Tue Mar 30 19:37:40 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:37:40 2010 Completed. Tue Mar 30 19:37:40 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:37:40 2010 Received. Tue Mar 30 19:37:40 2010 Initializing test directories. Tue Mar 30 19:37:40 2010 Child 1 will create 167 directories. Tue Mar 30 19:37:40 2010 Child 2 will create 167 directories. Tue Mar 30 19:37:40 2010 Child 0 will create 167 directories. Tue Mar 30 19:37:40 2010 Child 3 will create 167 directories. Tue Mar 30 19:37:41 2010 Child 1 finished creating 167 directories. Tue Mar 30 19:37:41 2010 Child 1 will create 5102 files. Tue Mar 30 19:37:42 2010 Child 0 finished creating 167 directories. Tue Mar 30 19:37:42 2010 Child 0 will create 5102 files. Tue Mar 30 19:37:44 2010 Child 2 finished creating 167 directories. Tue Mar 30 19:37:44 2010 Child 2 will create 5102 files. Tue Mar 30 19:37:47 2010 Child 3 finished creating 167 directories. Tue Mar 30 19:37:47 2010 Child 3 will create 5102 files. Tue Mar 30 19:37:59 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 19:37:59 2010 Child 1 will create 6 symlinks. Tue Mar 30 19:37:59 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 19:38:01 2010 Child 0 verified 5102 files, created 47 Tue Mar 30 19:38:01 2010 Child 0 will create 6 symlinks. Tue Mar 30 19:38:01 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 19:38:09 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 19:38:09 2010 Child 2 will create 6 symlinks. Tue Mar 30 19:38:09 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 19:38:13 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 19:38:13 2010 Child 3 will create 6 symlinks. Tue Mar 30 19:38:13 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 19:38:14 2010 Completed. Tue Mar 30 19:38:14 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:38:14 2010 Completed. Tue Mar 30 19:38:14 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:38:15 2010 Received. Tue Mar 30 19:38:15 2010 Performing 300 seconds pretest warmup. Child 2 - 50 aborted ops Child 3 - 50 aborted ops Child 2 - 100 aborted ops Child 3 - 100 aborted ops Child 1 - 50 aborted ops Child 0 - 50 aborted ops Child 0 - 100 aborted ops Child 2 - 150 aborted ops Child 3 - 150 aborted ops Child 1 - 100 aborted ops Child 2 - 200 aborted ops Child 3 - 200 aborted ops Child 1 - 150 aborted ops Child 0 - 150 aborted ops Child 2 - 250 aborted ops Child 3 - 250 aborted ops Child 0 - 200 aborted ops Child 1 - 200 aborted ops Child 0 - 250 aborted ops Child 2 - 300 aborted ops Child 3 - 300 aborted ops Child 1 - 250 aborted ops Child 0 - 300 aborted ops Child 3 - 350 aborted ops Child 2 - 350 aborted ops Child 1 - 300 aborted ops Child 1 - 350 aborted ops Child 0 - 350 aborted ops Child 2 - 400 aborted ops Child 3 - 400 aborted ops Child 0 - 400 aborted ops Child 1 - 400 aborted ops Child 3 - 450 aborted ops Child 2 - 450 aborted ops Child 0 - 450 aborted ops Child 3 - 500 aborted ops Child 1 - 450 aborted ops Child 2 - 500 aborted ops Child 3 - 550 aborted ops Child 0 - 500 aborted ops Child 1 - 500 aborted ops Child 2 - 550 aborted ops Child 0 - 550 aborted ops Child 3 - 600 aborted ops Child 1 - 550 aborted ops Child 2 - 600 aborted ops Child 0 - 600 aborted ops Child 3 - 650 aborted ops Child 1 - 600 aborted ops Child 0 - 650 aborted ops Child 2 - 650 aborted ops Child 3 - 700 aborted ops Child 1 - 650 aborted ops Child 2 - 700 aborted ops Child 0 - 700 aborted ops Child 3 - 750 aborted ops Child 1 - 700 aborted ops Child 2 - 750 aborted ops Child 0 - 750 aborted ops Child 3 - 800 aborted ops Child 1 - 750 aborted ops Child 2 - 800 aborted ops Child 3 - 850 aborted ops Child 0 - 800 aborted ops Tue Mar 30 19:43:15 2010 Completed. Tue Mar 30 19:43:15 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:43:15 2010 Completed. Tue Mar 30 19:43:15 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:43:16 2010 Received. Tue Mar 30 19:43:16 2010 Starting 300 seconds test run. Child 1 - 800 aborted ops Child 2 - 850 aborted ops Child 3 - 900 aborted ops Child 2 - 900 aborted ops Child 1 - 850 aborted ops Child 0 - 850 aborted ops Child 1 - 900 aborted ops Child 3 - 950 aborted ops Child 2 - 950 aborted ops Child 1 - 950 aborted ops Child 0 - 900 aborted ops Child 2 - 1000 aborted ops Child 0 - 950 aborted ops Child 1 - 1000 aborted ops Child 3 - 1000 aborted ops Child 1 - 1050 aborted ops Child 0 - 1000 aborted ops Child 2 - 1050 aborted ops Child 3 - 1050 aborted ops Child 2 - 1100 aborted ops Child 1 - 1100 aborted ops Child 2 - 1150 aborted ops Child 0 - 1050 aborted ops Child 1 - 1150 aborted ops Child 3 - 1100 aborted ops Child 2 - 1200 aborted ops Child 1 - 1200 aborted ops Child 0 - 1100 aborted ops Child 2 - 1250 aborted ops Child 3 - 1150 aborted ops Child 1 - 1250 aborted ops Child 1 - 1300 aborted ops Child 0 - 1150 aborted ops Child 3 - 1200 aborted ops Child 0 - 1200 aborted ops Child 3 - 1250 aborted ops Child 2 - 1300 aborted ops Child 1 - 1350 aborted ops Child 3 - 1300 aborted ops Child 0 - 1250 aborted ops Child 2 - 1350 aborted ops Child 1 - 1400 aborted ops Child 3 - 1350 aborted ops Child 1 - 1450 aborted ops Child 2 - 1400 aborted ops Child 0 - 1300 aborted ops Child 3 - 1400 aborted ops Child 2 - 1450 aborted ops Child 0 - 1350 aborted ops Child 3 - 1450 aborted ops Child 1 - 1500 aborted ops Child 2 - 1500 aborted ops Child 0 - 1400 aborted ops Child 3 - 1500 aborted ops Child 2 - 1550 aborted ops Child 1 - 1550 aborted ops Child 0 - 1450 aborted ops Child 3 - 1550 aborted ops Child 0 - 1500 aborted ops Child 1 - 1600 aborted ops Child 2 - 1600 aborted ops Child 3 - 1600 aborted ops Child 1 - 1650 aborted ops Child 3 - 1650 aborted ops Child 0 - 1550 aborted ops Child 2 - 1650 aborted ops Child 1 - 1700 aborted ops Child 0 - 1600 aborted ops Child 3 - 1700 aborted ops Child 2 - 1700 aborted ops Child 1 - 1750 aborted ops Child 3 - 1750 aborted ops Child 0 - 1650 aborted ops Child 2 - 1750 aborted ops Child 3 - 1800 aborted ops Child 1 - 1800 aborted ops Child 2 - 1800 aborted ops Child 0 - 1700 aborted ops Child 1 - 1850 aborted ops Child 0 - 1750 aborted ops Child 0 - 1800 aborted ops Child 2 - 1850 aborted ops Child 0 - 1850 aborted ops Child 1 - 1900 aborted ops Child 0 - 1900 aborted ops Child 2 - 1900 aborted ops Child 1 - 1950 aborted ops Child 0 - 1950 aborted ops Child 2 - 1950 aborted ops Child 0 - 2000 aborted ops Child 3 - 1850 aborted ops Child 1 - 2000 aborted ops Child 2 - 2000 aborted ops Child 0 - 2050 aborted ops Child 2 - 2050 aborted ops Child 0 - 2100 aborted ops Child 2 - 2100 aborted ops Child 2 - 2150 aborted ops Child 2 - 2200 aborted ops Child 3 - 1900 aborted ops Child 3 - 1950 aborted ops Child 0 - 2150 aborted ops Child 3 - 2000 aborted ops Child 0 - 2200 aborted ops Child 1 - 2050 aborted ops Child 2 - 2250 aborted ops Child 1 - 2100 aborted ops Child 2 - 2300 aborted ops Child 1 - 2150 aborted ops Child 2 - 2350 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 19:48:26 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 311454 311454 0 0.36 82.18 0.03 11.0% setattr 4.0% 4.1% 48534 48534 0 0.35 25.75 0.05 1.6% lookup 24.0% 24.1% 286886 286886 0 0.34 83.36 0.03 9.7% readlink 1.0% 1.0% 11913 11913 0 0.19 0.11 0.01 0.2% read 18.0% 18.1% 215869 266178 0 0.53 1.70 0.01 11.3% write 10.0% 10.0% 119394 144175 0 4.15 41.78 0.04 48.4% create 1.0% 1.0% 11948 11948 0 5.83 93.18 0.17 6.8% remove 1.0% 0.6% 6642 6642 0 0.22 0.10 0.01 0.1% readdir 1.0% 1.0% 11873 11873 0 0.49 0.10 0.01 0.6% fsstat 1.0% 1.0% 12015 12015 0 0.18 0.17 0.01 0.2% access 11.0% 11.1% 131794 131794 0 0.52 122.99 0.06 6.7% commit 0.0% 0.0% 0 71902 0 0.00 0.00 0.00 1.3% readdirplus 2.0% 2.0% 23895 23895 0 0.89 0.12 0.00 2.1% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4498.93 Ops/Sec AVG. RESPONSE TIME: 0.85 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4400 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1192217 TEST TIME: 265 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1339209 PHYSICAL NFS V3 THROUGHPUT: 5053.61 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 19:48:26 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4400 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 19:48:26 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:48:26 2010 Completed. Tue Mar 30 19:48:26 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 19:48:27 2010 Received. Tue Mar 30 19:48:27 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 19:48:27 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4500 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 19:48:29 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 19:48:29 2010 Mounting 4 remote test directories. Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Child[000]: NFS negotiated block size 32768 Tue Mar 30 19:48:45 2010 Completed. Tue Mar 30 19:48:45 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:48:45 2010 Completed. Tue Mar 30 19:48:45 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:48:45 2010 Received. Tue Mar 30 19:48:45 2010 Initializing test directories. Tue Mar 30 19:48:45 2010 Child 0 will create 167 directories. Tue Mar 30 19:48:45 2010 Child 2 will create 167 directories. Tue Mar 30 19:48:45 2010 Child 1 will create 167 directories. Tue Mar 30 19:48:45 2010 Child 3 will create 167 directories. Tue Mar 30 19:48:51 2010 Child 1 finished creating 167 directories. Tue Mar 30 19:48:51 2010 Child 1 will create 5102 files. Tue Mar 30 19:48:54 2010 Child 2 finished creating 167 directories. Tue Mar 30 19:48:54 2010 Child 2 will create 5102 files. Tue Mar 30 19:48:57 2010 Child 3 finished creating 167 directories. Tue Mar 30 19:48:57 2010 Child 3 will create 5102 files. Tue Mar 30 19:49:01 2010 Child 0 finished creating 167 directories. Tue Mar 30 19:49:01 2010 Child 0 will create 5102 files. Tue Mar 30 19:49:11 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 19:49:11 2010 Child 2 will create 6 symlinks. Tue Mar 30 19:49:11 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 19:49:11 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 19:49:11 2010 Child 1 will create 6 symlinks. Tue Mar 30 19:49:11 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 19:49:12 2010 Child 3 verified 5102 files, created 50 Tue Mar 30 19:49:12 2010 Child 3 will create 6 symlinks. Tue Mar 30 19:49:12 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 19:49:20 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 19:49:20 2010 Child 0 will create 6 symlinks. Tue Mar 30 19:49:20 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 19:49:21 2010 Completed. Tue Mar 30 19:49:21 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:49:21 2010 Completed. Tue Mar 30 19:49:21 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:49:22 2010 Received. Tue Mar 30 19:49:22 2010 Performing 300 seconds pretest warmup. Child 2 - 50 aborted ops Child 2 - 100 aborted ops Child 1 - 50 aborted ops Child 0 - 50 aborted ops Child 1 - 100 aborted ops Child 0 - 100 aborted ops Child 3 - 50 aborted ops Child 1 - 150 aborted ops Child 0 - 150 aborted ops Child 1 - 200 aborted ops Child 3 - 100 aborted ops Child 2 - 150 aborted ops Child 0 - 200 aborted ops Child 1 - 250 aborted ops Child 3 - 150 aborted ops Child 2 - 200 aborted ops Child 0 - 250 aborted ops Child 1 - 300 aborted ops Child 3 - 200 aborted ops Child 1 - 350 aborted ops Child 2 - 250 aborted ops Child 3 - 250 aborted ops Child 0 - 300 aborted ops Child 1 - 400 aborted ops Child 2 - 300 aborted ops Child 0 - 350 aborted ops Child 1 - 450 aborted ops Child 3 - 300 aborted ops Child 2 - 350 aborted ops Child 1 - 500 aborted ops Child 3 - 350 aborted ops Child 0 - 400 aborted ops Child 2 - 400 aborted ops Child 1 - 550 aborted ops Child 3 - 400 aborted ops Child 0 - 450 aborted ops Child 2 - 450 aborted ops Child 1 - 600 aborted ops Child 0 - 500 aborted ops Child 2 - 500 aborted ops Child 1 - 650 aborted ops Child 3 - 450 aborted ops Child 0 - 550 aborted ops Child 2 - 550 aborted ops Child 3 - 500 aborted ops Child 2 - 600 aborted ops Child 1 - 700 aborted ops Child 0 - 600 aborted ops Child 2 - 650 aborted ops Child 1 - 750 aborted ops Child 0 - 650 aborted ops Child 3 - 550 aborted ops Child 2 - 700 aborted ops Child 1 - 800 aborted ops Child 3 - 600 aborted ops Child 2 - 750 aborted ops Child 0 - 700 aborted ops Child 1 - 850 aborted ops Child 3 - 650 aborted ops Child 2 - 800 aborted ops Child 0 - 750 aborted ops Child 1 - 900 aborted ops Child 3 - 700 aborted ops Child 1 - 950 aborted ops Child 2 - 850 aborted ops Child 0 - 800 aborted ops Child 3 - 750 aborted ops Child 1 - 1000 aborted ops Child 3 - 800 aborted ops Child 2 - 900 aborted ops Child 0 - 850 aborted ops Child 3 - 850 aborted ops Child 1 - 1050 aborted ops Child 2 - 950 aborted ops Child 1 - 1100 aborted ops Child 3 - 900 aborted ops Child 0 - 900 aborted ops Child 1 - 1150 aborted ops Child 2 - 1000 aborted ops Child 3 - 950 aborted ops Child 2 - 1050 aborted ops Child 1 - 1200 aborted ops Child 0 - 950 aborted ops Child 2 - 1100 aborted ops Child 0 - 1000 aborted ops Child 3 - 1000 aborted ops Child 1 - 1250 aborted ops Child 3 - 1050 aborted ops Child 0 - 1050 aborted ops Child 2 - 1150 aborted ops Child 3 - 1100 aborted ops Child 0 - 1100 aborted ops Child 3 - 1150 aborted ops Child 1 - 1300 aborted ops Child 1 - 1350 aborted ops Child 0 - 1150 aborted ops Child 3 - 1200 aborted ops Child 2 - 1200 aborted ops Child 0 - 1200 aborted ops Child 0 - 1250 aborted ops Child 1 - 1400 aborted ops Child 2 - 1250 aborted ops Child 3 - 1250 aborted ops Child 0 - 1300 aborted ops Child 2 - 1300 aborted ops Child 1 - 1450 aborted ops Child 3 - 1300 aborted ops Child 2 - 1350 aborted ops Child 1 - 1500 aborted ops Child 1 - 1550 aborted ops Tue Mar 30 19:54:22 2010 Completed. Tue Mar 30 19:54:22 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:54:22 2010 Completed. Tue Mar 30 19:54:22 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 19:54:23 2010 Received. Tue Mar 30 19:54:23 2010 Starting 300 seconds test run. Child 2 - 1400 aborted ops Child 1 - 1600 aborted ops Child 0 - 1350 aborted ops Child 3 - 1350 aborted ops Child 2 - 1450 aborted ops Child 0 - 1400 aborted ops Child 1 - 1650 aborted ops Child 0 - 1450 aborted ops Child 1 - 1700 aborted ops Child 3 - 1400 aborted ops Child 2 - 1500 aborted ops Child 3 - 1450 aborted ops Child 3 - 1500 aborted ops Child 1 - 1750 aborted ops Child 2 - 1550 aborted ops Child 3 - 1550 aborted ops Child 0 - 1500 aborted ops Child 1 - 1800 aborted ops Child 2 - 1600 aborted ops Child 3 - 1600 aborted ops Child 3 - 1650 aborted ops Child 0 - 1550 aborted ops Child 2 - 1650 aborted ops Child 3 - 1700 aborted ops Child 2 - 1700 aborted ops Child 0 - 1600 aborted ops Child 1 - 1850 aborted ops Child 3 - 1750 aborted ops Child 2 - 1750 aborted ops Child 0 - 1650 aborted ops Child 3 - 1800 aborted ops Child 0 - 1700 aborted ops Child 2 - 1800 aborted ops Child 0 - 1750 aborted ops Child 1 - 1900 aborted ops Child 3 - 1850 aborted ops Child 2 - 1850 aborted ops Child 0 - 1800 aborted ops Child 2 - 1900 aborted ops Child 1 - 1950 aborted ops Child 0 - 1850 aborted ops Child 1 - 2000 aborted ops Child 2 - 1950 aborted ops Child 0 - 1900 aborted ops Child 3 - 1900 aborted ops Child 2 - 2000 aborted ops Child 1 - 2050 aborted ops Child 0 - 1950 aborted ops Child 2 - 2050 aborted ops Child 3 - 1950 aborted ops Child 0 - 2000 aborted ops Child 2 - 2100 aborted ops Child 1 - 2100 aborted ops Child 3 - 2000 aborted ops Child 2 - 2150 aborted ops Child 1 - 2150 aborted ops Child 0 - 2050 aborted ops Child 1 - 2200 aborted ops Child 3 - 2050 aborted ops Child 0 - 2100 aborted ops Child 0 - 2150 aborted ops Child 0 - 2200 aborted ops Child 2 - 2200 aborted ops Child 3 - 2100 aborted ops Child 1 - 2250 aborted ops Child 1 - 2300 aborted ops Child 2 - 2250 aborted ops Child 0 - 2250 aborted ops Child 2 - 2300 aborted ops Child 3 - 2150 aborted ops Child 0 - 2300 aborted ops Child 2 - 2350 aborted ops Child 1 - 2350 aborted ops Child 3 - 2200 aborted ops Child 2 - 2400 aborted ops Child 0 - 2350 aborted ops Child 3 - 2250 aborted ops Child 2 - 2450 aborted ops Child 1 - 2400 aborted ops Child 0 - 2400 aborted ops Child 1 - 2450 aborted ops Child 3 - 2300 aborted ops Child 3 - 2350 aborted ops Child 0 - 2450 aborted ops Child 1 - 2500 aborted ops Child 3 - 2400 aborted ops Child 1 - 2550 aborted ops Child 3 - 2450 aborted ops Child 2 - 2500 aborted ops Child 0 - 2500 aborted ops Child 1 - 2600 aborted ops Child 0 - 2550 aborted ops Child 3 - 2500 aborted ops Child 2 - 2550 aborted ops Child 3 - 2550 aborted ops Child 3 - 2600 aborted ops Child 2 - 2600 aborted ops Child 1 - 2650 aborted ops Child 3 - 2650 aborted ops Child 0 - 2600 aborted ops Child 0 - 2650 aborted ops Child 1 - 2700 aborted ops Child 2 - 2650 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 20:00:33 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 294508 294508 0 0.19 0.34 0.00 5.2% setattr 4.0% 4.1% 45827 45827 0 0.21 0.72 0.01 0.9% lookup 24.0% 24.1% 271535 271535 0 0.22 10.80 0.01 5.5% readlink 1.0% 1.0% 11296 11296 0 0.20 0.19 0.01 0.2% read 18.0% 18.1% 203600 250304 1 0.72 3.57 0.01 13.6% write 10.0% 10.1% 114033 137542 2 6.30 166.99 0.07 66.5% create 1.0% 1.0% 11370 11370 0 1.63 40.44 0.12 1.7% remove 1.0% 0.6% 6341 6341 0 0.22 0.13 0.01 0.1% readdir 1.0% 1.0% 11375 11375 0 0.50 0.25 0.01 0.5% fsstat 1.0% 1.0% 11250 11250 0 0.19 0.15 0.01 0.2% access 11.0% 11.0% 124273 124273 0 0.21 5.60 0.01 2.4% commit 0.0% 0.0% 0 68633 0 0.00 0.00 0.00 1.2% readdirplus 2.0% 2.0% 22513 22513 1 0.91 0.66 0.01 1.9% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 3569.37 Ops/Sec AVG. RESPONSE TIME: 0.95 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4500 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1127921 TEST TIME: 316 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1266767 PHYSICAL NFS V3 THROUGHPUT: 4008.75 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3511395.0 KB (100.00% to 110.14% of Base) ------------------------------------------------------------------------ Tue Mar 30 20:00:33 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4500 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 20:00:33 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:00:33 2010 Completed. Tue Mar 30 20:00:33 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 20:00:34 2010 Received. Tue Mar 30 20:00:34 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 20:00:34 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4600 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 20:00:36 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 20:00:36 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 20:00:47 2010 Completed. Tue Mar 30 20:00:47 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:00:47 2010 Completed. Tue Mar 30 20:00:47 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:00:52 2010 Received. Tue Mar 30 20:00:52 2010 Initializing test directories. Tue Mar 30 20:00:52 2010 Child 0 will create 167 directories. Tue Mar 30 20:00:52 2010 Child 2 will create 167 directories. Tue Mar 30 20:00:52 2010 Child 1 will create 167 directories. Tue Mar 30 20:00:52 2010 Child 3 will create 167 directories. Tue Mar 30 20:01:26 2010 Child 0 finished creating 167 directories. Tue Mar 30 20:01:26 2010 Child 0 will create 5102 files. Tue Mar 30 20:01:26 2010 Child 3 finished creating 167 directories. Tue Mar 30 20:01:26 2010 Child 3 will create 5102 files. Tue Mar 30 20:01:28 2010 Child 1 finished creating 167 directories. Tue Mar 30 20:01:28 2010 Child 1 will create 5102 files. Tue Mar 30 20:01:35 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 20:01:35 2010 Child 0 will create 6 symlinks. Tue Mar 30 20:01:35 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 20:01:38 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 20:01:38 2010 Child 1 will create 6 symlinks. Tue Mar 30 20:01:38 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 20:01:40 2010 Child 2 finished creating 167 directories. Tue Mar 30 20:01:40 2010 Child 2 will create 5102 files. Tue Mar 30 20:01:46 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 20:01:46 2010 Child 3 will create 6 symlinks. Tue Mar 30 20:01:46 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 20:02:02 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 20:02:02 2010 Child 2 will create 6 symlinks. Tue Mar 30 20:02:02 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 20:02:02 2010 Completed. Tue Mar 30 20:02:02 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:02:02 2010 Completed. Tue Mar 30 20:02:02 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:02:02 2010 Received. Tue Mar 30 20:02:02 2010 Performing 300 seconds pretest warmup. Child 1 - 50 aborted ops Child 2 - 50 aborted ops Child 1 - 100 aborted ops Child 2 - 100 aborted ops Child 0 - 50 aborted ops Child 3 - 50 aborted ops Child 2 - 150 aborted ops Child 1 - 150 aborted ops Child 0 - 100 aborted ops Child 2 - 200 aborted ops Child 3 - 100 aborted ops Child 1 - 200 aborted ops Child 3 - 150 aborted ops Child 2 - 250 aborted ops Child 1 - 250 aborted ops Child 0 - 150 aborted ops Child 2 - 300 aborted ops Child 1 - 300 aborted ops Child 3 - 200 aborted ops Child 2 - 350 aborted ops Child 3 - 250 aborted ops Child 0 - 200 aborted ops Child 1 - 350 aborted ops Child 2 - 400 aborted ops Child 0 - 250 aborted ops Child 2 - 450 aborted ops Child 3 - 300 aborted ops Child 1 - 400 aborted ops Child 0 - 300 aborted ops Child 2 - 500 aborted ops Child 3 - 350 aborted ops Child 2 - 550 aborted ops Child 1 - 450 aborted ops Child 3 - 400 aborted ops Child 0 - 350 aborted ops Child 3 - 450 aborted ops Child 1 - 500 aborted ops Child 0 - 400 aborted ops Child 2 - 600 aborted ops Child 3 - 500 aborted ops Child 2 - 650 aborted ops Child 0 - 450 aborted ops Child 3 - 550 aborted ops Child 1 - 550 aborted ops Child 0 - 500 aborted ops Child 2 - 700 aborted ops Child 3 - 600 aborted ops Child 1 - 600 aborted ops Child 0 - 550 aborted ops Child 3 - 650 aborted ops Child 0 - 600 aborted ops Child 2 - 750 aborted ops Child 3 - 700 aborted ops Child 0 - 650 aborted ops Child 2 - 800 aborted ops Child 1 - 650 aborted ops Child 3 - 750 aborted ops Child 0 - 700 aborted ops Child 2 - 850 aborted ops Child 3 - 800 aborted ops Child 0 - 750 aborted ops Child 1 - 700 aborted ops Child 2 - 900 aborted ops Child 3 - 850 aborted ops Child 0 - 800 aborted ops Child 3 - 900 aborted ops Child 2 - 950 aborted ops Child 0 - 850 aborted ops Child 1 - 750 aborted ops Child 3 - 950 aborted ops Child 2 - 1000 aborted ops Child 0 - 900 aborted ops Child 1 - 800 aborted ops Child 1 - 850 aborted ops Child 0 - 950 aborted ops Child 3 - 1000 aborted ops Child 1 - 900 aborted ops Tue Mar 30 20:07:02 2010 Completed. Tue Mar 30 20:07:02 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:07:02 2010 Completed. Tue Mar 30 20:07:02 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:07:03 2010 Received. Tue Mar 30 20:07:03 2010 Starting 300 seconds test run. Child 3 - 1050 aborted ops Child 0 - 1000 aborted ops Child 1 - 950 aborted ops Child 2 - 1050 aborted ops Child 0 - 1050 aborted ops Child 3 - 1100 aborted ops Child 1 - 1000 aborted ops Child 2 - 1100 aborted ops Child 0 - 1100 aborted ops Child 1 - 1050 aborted ops Child 1 - 1100 aborted ops Child 3 - 1150 aborted ops Child 2 - 1150 aborted ops Child 0 - 1150 aborted ops Child 3 - 1200 aborted ops Child 0 - 1200 aborted ops Child 2 - 1200 aborted ops Child 1 - 1150 aborted ops Child 3 - 1250 aborted ops Child 0 - 1250 aborted ops Child 1 - 1200 aborted ops Child 3 - 1300 aborted ops Child 2 - 1250 aborted ops Child 0 - 1300 aborted ops Child 3 - 1350 aborted ops Child 0 - 1350 aborted ops Child 1 - 1250 aborted ops Child 3 - 1400 aborted ops Child 0 - 1400 aborted ops Child 1 - 1300 aborted ops Child 2 - 1300 aborted ops Child 0 - 1450 aborted ops Child 1 - 1350 aborted ops Child 2 - 1350 aborted ops Child 3 - 1450 aborted ops Child 1 - 1400 aborted ops Child 3 - 1500 aborted ops Child 2 - 1400 aborted ops Child 1 - 1450 aborted ops Child 0 - 1500 aborted ops Child 3 - 1550 aborted ops Child 2 - 1450 aborted ops Child 3 - 1600 aborted ops Child 0 - 1550 aborted ops Child 2 - 1500 aborted ops Child 0 - 1600 aborted ops Child 2 - 1550 aborted ops Child 1 - 1500 aborted ops Child 2 - 1600 aborted ops Child 1 - 1550 aborted ops Child 3 - 1650 aborted ops Child 3 - 1700 aborted ops Child 3 - 1750 aborted ops Child 1 - 1600 aborted ops Child 0 - 1650 aborted ops Child 2 - 1650 aborted ops Child 1 - 1650 aborted ops Child 0 - 1700 aborted ops Child 1 - 1700 aborted ops Child 2 - 1700 aborted ops Child 3 - 1800 aborted ops Child 0 - 1750 aborted ops Child 2 - 1750 aborted ops Child 1 - 1750 aborted ops Child 2 - 1800 aborted ops Child 0 - 1800 aborted ops Child 3 - 1850 aborted ops Child 1 - 1800 aborted ops Child 3 - 1900 aborted ops Child 2 - 1850 aborted ops Child 1 - 1850 aborted ops Child 2 - 1900 aborted ops Child 3 - 1950 aborted ops Child 1 - 1900 aborted ops Child 3 - 2000 aborted ops Child 0 - 1850 aborted ops Child 1 - 1950 aborted ops Child 0 - 1900 aborted ops Child 2 - 1950 aborted ops Child 0 - 1950 aborted ops Child 3 - 2050 aborted ops Child 3 - 2100 aborted ops Child 0 - 2000 aborted ops Child 3 - 2150 aborted ops Child 2 - 2000 aborted ops Child 1 - 2000 aborted ops Child 1 - 2050 aborted ops Child 2 - 2050 aborted ops Child 1 - 2100 aborted ops Child 0 - 2050 aborted ops Child 0 - 2100 aborted ops Child 3 - 2200 aborted ops Child 3 - 2250 aborted ops Child 3 - 2300 aborted ops Child 2 - 2100 aborted ops Child 1 - 2150 aborted ops Child 2 - 2150 aborted ops Child 0 - 2150 aborted ops Child 1 - 2200 aborted ops Child 2 - 2200 aborted ops Child 1 - 2250 aborted ops Child 3 - 2350 aborted ops Child 0 - 2200 aborted ops Child 2 - 2250 aborted ops Child 1 - 2300 aborted ops Child 3 - 2400 aborted ops Child 2 - 2300 aborted ops Child 0 - 2250 aborted ops Child 1 - 2350 aborted ops Child 3 - 2450 aborted ops Child 0 - 2300 aborted ops Child 1 - 2400 aborted ops Child 2 - 2350 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 20:12:21 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.2% 332915 332915 0 0.17 0.24 0.00 5.4% setattr 4.0% 4.0% 51177 51177 0 0.22 7.92 0.02 1.1% lookup 24.0% 24.1% 306525 306525 0 0.18 0.31 0.00 5.2% readlink 1.0% 1.0% 12678 12678 0 0.18 0.13 0.01 0.2% read 18.0% 18.1% 229945 282873 0 0.51 0.89 0.00 11.1% write 10.0% 10.0% 127030 152817 0 5.54 68.97 0.05 66.2% create 1.0% 1.0% 12842 12842 0 3.53 75.60 0.15 4.3% remove 1.0% 0.6% 7205 7205 0 0.21 0.68 0.02 0.1% readdir 1.0% 1.0% 12695 12695 0 0.48 0.10 0.01 0.6% fsstat 1.0% 1.0% 12725 12725 0 0.17 0.20 0.01 0.2% access 11.0% 11.0% 139742 139742 0 0.17 0.32 0.00 2.3% commit 0.0% 0.0% 0 76471 0 0.00 0.00 0.00 1.3% readdirplus 2.0% 2.0% 25550 25550 0 0.88 0.23 0.01 2.1% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4167.30 Ops/Sec AVG. RESPONSE TIME: 0.83 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4600 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1271029 TEST TIME: 305 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1426215 PHYSICAL NFS V3 THROUGHPUT: 4676.11 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 20:12:21 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4600 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 20:12:21 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:12:21 2010 Completed. Tue Mar 30 20:12:21 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 20:12:21 2010 Received. Tue Mar 30 20:12:21 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 20:12:21 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4700 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 20:12:23 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 20:12:23 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 20:12:34 2010 Completed. Tue Mar 30 20:12:34 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:12:34 2010 Completed. Tue Mar 30 20:12:34 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:12:39 2010 Received. Tue Mar 30 20:12:39 2010 Initializing test directories. Tue Mar 30 20:12:39 2010 Child 0 will create 167 directories. Tue Mar 30 20:12:39 2010 Child 2 will create 167 directories. Tue Mar 30 20:12:39 2010 Child 1 will create 167 directories. Tue Mar 30 20:12:39 2010 Child 3 will create 167 directories. Tue Mar 30 20:12:44 2010 Child 0 finished creating 167 directories. Tue Mar 30 20:12:44 2010 Child 0 will create 5102 files. Tue Mar 30 20:12:45 2010 Child 3 finished creating 167 directories. Tue Mar 30 20:12:45 2010 Child 3 will create 5102 files. Tue Mar 30 20:12:47 2010 Child 1 finished creating 167 directories. Tue Mar 30 20:12:47 2010 Child 1 will create 5102 files. Tue Mar 30 20:12:50 2010 Child 2 finished creating 167 directories. Tue Mar 30 20:12:50 2010 Child 2 will create 5102 files. Tue Mar 30 20:12:58 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 20:12:58 2010 Child 3 will create 6 symlinks. Tue Mar 30 20:12:58 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 20:12:59 2010 Child 0 verified 5102 files, created 49 Tue Mar 30 20:12:59 2010 Child 0 will create 6 symlinks. Tue Mar 30 20:12:59 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 20:13:00 2010 Child 2 verified 5102 files, created 50 Tue Mar 30 20:13:00 2010 Child 2 will create 6 symlinks. Tue Mar 30 20:13:00 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 20:13:05 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 20:13:05 2010 Child 1 will create 6 symlinks. Tue Mar 30 20:13:05 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 20:13:06 2010 Completed. Tue Mar 30 20:13:06 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:13:06 2010 Completed. Tue Mar 30 20:13:06 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:13:06 2010 Received. Tue Mar 30 20:13:06 2010 Performing 300 seconds pretest warmup. Child 2 - 50 aborted ops Child 2 - 100 aborted ops Child 0 - 50 aborted ops Child 3 - 50 aborted ops Child 1 - 50 aborted ops Child 2 - 150 aborted ops Child 3 - 100 aborted ops Child 0 - 100 aborted ops Child 1 - 100 aborted ops Child 2 - 200 aborted ops Child 3 - 150 aborted ops Child 0 - 150 aborted ops Child 1 - 150 aborted ops Child 2 - 250 aborted ops Child 1 - 200 aborted ops Child 0 - 200 aborted ops Child 3 - 200 aborted ops Child 0 - 250 aborted ops Child 3 - 250 aborted ops Child 2 - 300 aborted ops Child 0 - 300 aborted ops Child 1 - 250 aborted ops Child 3 - 300 aborted ops Child 2 - 350 aborted ops Child 0 - 350 aborted ops Child 1 - 300 aborted ops Child 3 - 350 aborted ops Child 0 - 400 aborted ops Child 2 - 400 aborted ops Child 1 - 350 aborted ops Child 3 - 400 aborted ops Child 0 - 450 aborted ops Child 1 - 400 aborted ops Child 2 - 450 aborted ops Child 3 - 450 aborted ops Child 0 - 500 aborted ops Child 1 - 450 aborted ops Child 3 - 500 aborted ops Child 2 - 500 aborted ops Child 0 - 550 aborted ops Child 2 - 550 aborted ops Child 1 - 500 aborted ops Child 2 - 600 aborted ops Child 3 - 550 aborted ops Child 0 - 600 aborted ops Child 3 - 600 aborted ops Child 1 - 550 aborted ops Child 2 - 650 aborted ops Tue Mar 30 20:18:06 2010 Completed. Tue Mar 30 20:18:06 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:18:06 2010 Completed. Tue Mar 30 20:18:06 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:18:07 2010 Received. Tue Mar 30 20:18:07 2010 Starting 300 seconds test run. Child 1 - 600 aborted ops Child 3 - 650 aborted ops Child 0 - 650 aborted ops Child 2 - 700 aborted ops Child 3 - 700 aborted ops Child 1 - 650 aborted ops Child 0 - 700 aborted ops Child 2 - 750 aborted ops Child 2 - 800 aborted ops Child 3 - 750 aborted ops Child 1 - 700 aborted ops Child 2 - 850 aborted ops Child 0 - 750 aborted ops Child 3 - 800 aborted ops Child 2 - 900 aborted ops Child 2 - 950 aborted ops Child 3 - 850 aborted ops Child 1 - 750 aborted ops Child 0 - 800 aborted ops Child 2 - 1000 aborted ops Child 3 - 900 aborted ops Child 2 - 1050 aborted ops Child 3 - 950 aborted ops Child 1 - 800 aborted ops Child 0 - 850 aborted ops Child 1 - 850 aborted ops Child 0 - 900 aborted ops Child 1 - 900 aborted ops Child 0 - 950 aborted ops Child 1 - 950 aborted ops Child 3 - 1000 aborted ops Child 1 - 1000 aborted ops Child 2 - 1100 aborted ops Child 3 - 1050 aborted ops Child 0 - 1000 aborted ops Child 2 - 1150 aborted ops Child 1 - 1050 aborted ops Child 3 - 1100 aborted ops Child 0 - 1050 aborted ops Child 1 - 1100 aborted ops Child 2 - 1200 aborted ops Child 3 - 1150 aborted ops Child 0 - 1100 aborted ops Child 1 - 1150 aborted ops Child 2 - 1250 aborted ops Child 1 - 1200 aborted ops Child 3 - 1200 aborted ops Child 0 - 1150 aborted ops Child 2 - 1300 aborted ops Child 3 - 1250 aborted ops Child 1 - 1250 aborted ops Child 0 - 1200 aborted ops Child 1 - 1300 aborted ops Child 0 - 1250 aborted ops Child 1 - 1350 aborted ops Child 3 - 1300 aborted ops Child 2 - 1350 aborted ops Child 1 - 1400 aborted ops Child 3 - 1350 aborted ops Child 2 - 1400 aborted ops Child 1 - 1450 aborted ops Child 0 - 1300 aborted ops Child 3 - 1400 aborted ops Child 2 - 1450 aborted ops Child 1 - 1500 aborted ops Child 2 - 1500 aborted ops Child 3 - 1450 aborted ops Child 0 - 1350 aborted ops Child 2 - 1550 aborted ops Child 2 - 1600 aborted ops Child 3 - 1500 aborted ops Child 0 - 1400 aborted ops Child 0 - 1450 aborted ops Child 2 - 1650 aborted ops Child 1 - 1550 aborted ops Child 0 - 1500 aborted ops Child 3 - 1550 aborted ops Child 2 - 1700 aborted ops Child 0 - 1550 aborted ops Child 3 - 1600 aborted ops Child 2 - 1750 aborted ops Child 1 - 1600 aborted ops Child 0 - 1600 aborted ops Child 1 - 1650 aborted ops Child 0 - 1650 aborted ops Child 3 - 1650 aborted ops Child 0 - 1700 aborted ops Child 2 - 1800 aborted ops Child 3 - 1700 aborted ops Child 2 - 1850 aborted ops Child 1 - 1700 aborted ops Child 0 - 1750 aborted ops Child 0 - 1800 aborted ops Child 3 - 1750 aborted ops Child 1 - 1750 aborted ops Child 2 - 1900 aborted ops Child 1 - 1800 aborted ops Child 3 - 1800 aborted ops Child 2 - 1950 aborted ops Child 3 - 1850 aborted ops Child 2 - 2000 aborted ops Child 0 - 1850 aborted ops Child 1 - 1850 aborted ops Child 3 - 1900 aborted ops Child 0 - 1900 aborted ops Child 3 - 1950 aborted ops Child 1 - 1900 aborted ops Child 0 - 1950 aborted ops Child 3 - 2000 aborted ops Child 2 - 2050 aborted ops Child 2 - 2100 aborted ops Child 0 - 2000 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 20:23:17 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 327289 327289 0 0.18 0.17 0.00 6.1% setattr 4.0% 4.0% 50566 50566 0 0.22 2.80 0.01 1.1% lookup 24.0% 24.1% 302161 302161 0 0.19 0.21 0.00 5.8% readlink 1.0% 1.0% 12783 12783 0 0.18 0.11 0.01 0.2% read 18.0% 18.1% 227238 279780 0 0.57 1.72 0.01 13.5% write 10.0% 10.1% 126412 152962 0 4.52 49.94 0.04 59.3% create 1.0% 1.0% 12686 12686 0 4.83 89.94 0.16 6.4% remove 1.0% 0.5% 6894 6894 0 0.21 0.15 0.01 0.2% readdir 1.0% 1.0% 12521 12521 0 0.49 0.16 0.01 0.6% fsstat 1.0% 1.0% 12547 12547 0 0.18 0.19 0.01 0.2% access 11.0% 11.1% 138792 138792 0 0.18 0.20 0.00 2.6% commit 0.0% 0.0% 0 76020 0 0.00 0.00 0.00 1.5% readdirplus 2.0% 2.0% 25338 25338 0 0.91 0.41 0.01 2.4% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4827.79 Ops/Sec AVG. RESPONSE TIME: 0.76 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4700 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1255227 TEST TIME: 260 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1410339 PHYSICAL NFS V3 THROUGHPUT: 5424.38 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 20:23:17 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4700 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 20:23:17 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:23:17 2010 Completed. Tue Mar 30 20:23:17 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 20:23:18 2010 Received. Tue Mar 30 20:23:18 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 20:23:18 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4800 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 20:23:20 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 20:23:20 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 20:23:31 2010 Completed. Tue Mar 30 20:23:31 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:23:31 2010 Completed. Tue Mar 30 20:23:31 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:23:36 2010 Received. Tue Mar 30 20:23:36 2010 Initializing test directories. Tue Mar 30 20:23:36 2010 Child 0 will create 167 directories. Tue Mar 30 20:23:36 2010 Child 3 will create 167 directories. Tue Mar 30 20:23:36 2010 Child 2 will create 167 directories. Tue Mar 30 20:23:36 2010 Child 1 will create 167 directories. Tue Mar 30 20:23:37 2010 Child 0 finished creating 167 directories. Tue Mar 30 20:23:37 2010 Child 0 will create 5102 files. Tue Mar 30 20:23:38 2010 Child 3 finished creating 167 directories. Tue Mar 30 20:23:38 2010 Child 3 will create 5102 files. Tue Mar 30 20:23:49 2010 Child 1 finished creating 167 directories. Tue Mar 30 20:23:49 2010 Child 1 will create 5102 files. Tue Mar 30 20:23:52 2010 Child 2 finished creating 167 directories. Tue Mar 30 20:23:52 2010 Child 2 will create 5102 files. Tue Mar 30 20:23:55 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 20:23:55 2010 Child 3 will create 6 symlinks. Tue Mar 30 20:23:55 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 20:23:57 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 20:23:57 2010 Child 0 will create 6 symlinks. Tue Mar 30 20:23:57 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 20:24:13 2010 Child 2 verified 5102 files, created 50 Tue Mar 30 20:24:13 2010 Child 2 will create 6 symlinks. Tue Mar 30 20:24:13 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 20:24:15 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 20:24:15 2010 Child 1 will create 6 symlinks. Tue Mar 30 20:24:15 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 20:24:16 2010 Completed. Tue Mar 30 20:24:16 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:24:16 2010 Completed. Tue Mar 30 20:24:16 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:24:17 2010 Received. Tue Mar 30 20:24:17 2010 Performing 300 seconds pretest warmup. Child 3 - 50 aborted ops Child 2 - 50 aborted ops Child 2 - 100 aborted ops Child 2 - 150 aborted ops Child 2 - 200 aborted ops Child 1 - 50 aborted ops Child 1 - 100 aborted ops Child 3 - 100 aborted ops Child 0 - 50 aborted ops Child 2 - 250 aborted ops Child 0 - 100 aborted ops Child 1 - 150 aborted ops Child 3 - 150 aborted ops Child 1 - 200 aborted ops Child 2 - 300 aborted ops Child 0 - 150 aborted ops Child 1 - 250 aborted ops Child 3 - 200 aborted ops Child 0 - 200 aborted ops Child 1 - 300 aborted ops Child 2 - 350 aborted ops Child 3 - 250 aborted ops Child 0 - 250 aborted ops Child 1 - 350 aborted ops Child 2 - 400 aborted ops Child 3 - 300 aborted ops Child 0 - 300 aborted ops Child 1 - 400 aborted ops Child 2 - 450 aborted ops Child 3 - 350 aborted ops Child 0 - 350 aborted ops Child 2 - 500 aborted ops Child 1 - 450 aborted ops Child 0 - 400 aborted ops Child 3 - 400 aborted ops Child 1 - 500 aborted ops Child 2 - 550 aborted ops Child 0 - 450 aborted ops Child 3 - 450 aborted ops Child 1 - 550 aborted ops Child 2 - 600 aborted ops Child 3 - 500 aborted ops Child 0 - 500 aborted ops Child 1 - 600 aborted ops Child 2 - 650 aborted ops Child 1 - 650 aborted ops Child 0 - 550 aborted ops Child 3 - 550 aborted ops Child 2 - 700 aborted ops Child 0 - 600 aborted ops Child 3 - 600 aborted ops Child 1 - 700 aborted ops Child 2 - 750 aborted ops Child 2 - 800 aborted ops Child 0 - 650 aborted ops Child 1 - 750 aborted ops Child 3 - 650 aborted ops Child 1 - 800 aborted ops Child 2 - 850 aborted ops Child 0 - 700 aborted ops Child 3 - 700 aborted ops Child 0 - 750 aborted ops Child 1 - 850 aborted ops Child 3 - 750 aborted ops Child 2 - 900 aborted ops Child 1 - 900 aborted ops Child 0 - 800 aborted ops Child 2 - 950 aborted ops Child 3 - 800 aborted ops Child 1 - 950 aborted ops Child 2 - 1000 aborted ops Child 1 - 1000 aborted ops Child 0 - 850 aborted ops Child 3 - 850 aborted ops Child 1 - 1050 aborted ops Child 2 - 1050 aborted ops Child 0 - 900 aborted ops Child 3 - 900 aborted ops Child 1 - 1100 aborted ops Child 0 - 950 aborted ops Child 2 - 1100 aborted ops Child 3 - 950 aborted ops Child 0 - 1000 aborted ops Child 1 - 1150 aborted ops Child 2 - 1150 aborted ops Child 3 - 1000 aborted ops Child 0 - 1050 aborted ops Child 3 - 1050 aborted ops Child 1 - 1200 aborted ops Child 0 - 1100 aborted ops Child 2 - 1200 aborted ops Child 1 - 1250 aborted ops Child 3 - 1100 aborted ops Child 0 - 1150 aborted ops Child 3 - 1150 aborted ops Child 0 - 1200 aborted ops Child 2 - 1250 aborted ops Child 1 - 1300 aborted ops Child 0 - 1250 aborted ops Child 2 - 1300 aborted ops Child 3 - 1200 aborted ops Child 1 - 1350 aborted ops Child 3 - 1250 aborted ops Child 0 - 1300 aborted ops Child 2 - 1350 aborted ops Tue Mar 30 20:29:17 2010 Completed. Tue Mar 30 20:29:17 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:29:17 2010 Completed. Tue Mar 30 20:29:17 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:29:18 2010 Received. Tue Mar 30 20:29:18 2010 Starting 300 seconds test run. Child 2 - 1400 aborted ops Child 1 - 1400 aborted ops Child 0 - 1350 aborted ops Child 1 - 1450 aborted ops Child 3 - 1300 aborted ops Child 2 - 1450 aborted ops Child 0 - 1400 aborted ops Child 2 - 1500 aborted ops Child 3 - 1350 aborted ops Child 1 - 1500 aborted ops Child 0 - 1450 aborted ops Child 1 - 1550 aborted ops Child 3 - 1400 aborted ops Child 2 - 1550 aborted ops Child 0 - 1500 aborted ops Child 1 - 1600 aborted ops Child 2 - 1600 aborted ops Child 3 - 1450 aborted ops Child 0 - 1550 aborted ops Child 1 - 1650 aborted ops Child 3 - 1500 aborted ops Child 0 - 1600 aborted ops Child 0 - 1650 aborted ops Child 1 - 1700 aborted ops Child 2 - 1650 aborted ops Child 0 - 1700 aborted ops Child 0 - 1750 aborted ops Child 2 - 1700 aborted ops Child 3 - 1550 aborted ops Child 2 - 1750 aborted ops Child 0 - 1800 aborted ops Child 1 - 1750 aborted ops Child 2 - 1800 aborted ops Child 2 - 1850 aborted ops Child 1 - 1800 aborted ops Child 3 - 1600 aborted ops Child 0 - 1850 aborted ops Child 2 - 1900 aborted ops Child 2 - 1950 aborted ops Child 1 - 1850 aborted ops Child 3 - 1650 aborted ops Child 0 - 1900 aborted ops Child 2 - 2000 aborted ops Child 3 - 1700 aborted ops Child 2 - 2050 aborted ops Child 1 - 1900 aborted ops Child 1 - 1950 aborted ops Child 1 - 2000 aborted ops Child 3 - 1750 aborted ops Child 0 - 1950 aborted ops Child 3 - 1800 aborted ops Child 1 - 2050 aborted ops Child 3 - 1850 aborted ops Child 0 - 2000 aborted ops Child 0 - 2050 aborted ops Child 0 - 2100 aborted ops Child 2 - 2100 aborted ops Child 3 - 1900 aborted ops Child 0 - 2150 aborted ops Child 2 - 2150 aborted ops Child 1 - 2100 aborted ops Child 3 - 1950 aborted ops Child 1 - 2150 aborted ops Child 3 - 2000 aborted ops Child 2 - 2200 aborted ops Child 3 - 2050 aborted ops Child 1 - 2200 aborted ops Child 3 - 2100 aborted ops Child 2 - 2250 aborted ops Child 3 - 2150 aborted ops Child 0 - 2200 aborted ops Child 1 - 2250 aborted ops Child 3 - 2200 aborted ops Child 1 - 2300 aborted ops Child 2 - 2300 aborted ops Child 0 - 2250 aborted ops Child 1 - 2350 aborted ops Child 3 - 2250 aborted ops Child 0 - 2300 aborted ops Child 3 - 2300 aborted ops Child 1 - 2400 aborted ops Child 2 - 2350 aborted ops Child 0 - 2350 aborted ops Child 1 - 2450 aborted ops Child 3 - 2350 aborted ops Child 0 - 2400 aborted ops Child 3 - 2400 aborted ops Child 1 - 2500 aborted ops Child 3 - 2450 aborted ops Child 1 - 2550 aborted ops Child 2 - 2400 aborted ops Child 3 - 2500 aborted ops Child 0 - 2450 aborted ops Child 3 - 2550 aborted ops Child 1 - 2600 aborted ops Child 0 - 2500 aborted ops Child 3 - 2600 aborted ops Child 0 - 2550 aborted ops Child 1 - 2650 aborted ops Child 3 - 2650 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 20:34:31 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 288579 288579 0 0.19 7.89 0.01 3.9% setattr 4.0% 4.0% 44669 44669 0 0.20 0.96 0.01 0.6% lookup 24.0% 24.1% 266256 266256 0 0.18 0.44 0.00 3.4% readlink 1.0% 1.0% 11166 11166 0 0.18 0.22 0.01 0.1% read 18.0% 18.1% 200293 245987 0 0.58 2.69 0.01 8.0% write 10.0% 10.0% 110935 134020 0 10.18 223.87 0.09 78.3% create 1.0% 1.0% 11098 11098 0 1.63 44.86 0.12 1.3% remove 1.0% 0.6% 6245 6245 0 0.21 0.15 0.01 0.1% readdir 1.0% 1.0% 11207 11207 0 0.49 0.82 0.02 0.4% fsstat 1.0% 1.0% 11043 11043 0 0.18 0.35 0.01 0.1% access 11.0% 11.0% 122171 122171 0 0.18 0.43 0.00 1.5% commit 0.0% 0.0% 0 66740 0 0.00 0.00 0.00 0.8% readdirplus 2.0% 2.0% 22037 22037 0 0.89 0.59 0.01 1.4% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 3735.46 Ops/Sec AVG. RESPONSE TIME: 1.30 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4800 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1105699 TEST TIME: 296 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1241218 PHYSICAL NFS V3 THROUGHPUT: 4193.30 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 20:34:31 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4800 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 20:34:31 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:34:31 2010 Completed. Tue Mar 30 20:34:31 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 20:34:32 2010 Received. Tue Mar 30 20:34:32 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 20:34:32 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4900 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 20:34:34 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 20:34:34 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 20:34:45 2010 Completed. Tue Mar 30 20:34:45 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:34:45 2010 Completed. Tue Mar 30 20:34:45 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:34:50 2010 Received. Tue Mar 30 20:34:50 2010 Initializing test directories. Tue Mar 30 20:34:50 2010 Child 3 will create 167 directories. Tue Mar 30 20:34:50 2010 Child 0 will create 167 directories. Tue Mar 30 20:34:50 2010 Child 1 will create 167 directories. Tue Mar 30 20:34:50 2010 Child 2 will create 167 directories. Tue Mar 30 20:34:52 2010 Child 1 finished creating 167 directories. Tue Mar 30 20:34:52 2010 Child 1 will create 5102 files. Tue Mar 30 20:34:54 2010 Child 2 finished creating 167 directories. Tue Mar 30 20:34:54 2010 Child 2 will create 5102 files. Tue Mar 30 20:34:56 2010 Child 0 finished creating 167 directories. Tue Mar 30 20:34:56 2010 Child 0 will create 5102 files. Tue Mar 30 20:34:57 2010 Child 3 finished creating 167 directories. Tue Mar 30 20:34:57 2010 Child 3 will create 5102 files. Tue Mar 30 20:37:13 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 20:37:13 2010 Child 1 will create 6 symlinks. Tue Mar 30 20:37:13 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 20:37:14 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 20:37:14 2010 Child 3 will create 6 symlinks. Tue Mar 30 20:37:14 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 20:37:17 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 20:37:17 2010 Child 2 will create 6 symlinks. Tue Mar 30 20:37:17 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 20:37:25 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 20:37:25 2010 Child 0 will create 6 symlinks. Tue Mar 30 20:37:25 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 20:37:25 2010 Completed. Tue Mar 30 20:37:25 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:37:25 2010 Completed. Tue Mar 30 20:37:25 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:37:26 2010 Received. Tue Mar 30 20:37:26 2010 Performing 300 seconds pretest warmup. Child 1 - 50 aborted ops Child 1 - 100 aborted ops Child 0 - 50 aborted ops Child 1 - 150 aborted ops Child 2 - 50 aborted ops Child 0 - 100 aborted ops Child 1 - 200 aborted ops Child 0 - 150 aborted ops Child 2 - 100 aborted ops Child 2 - 150 aborted ops Child 1 - 250 aborted ops Child 0 - 200 aborted ops Child 0 - 250 aborted ops Child 0 - 300 aborted ops Child 1 - 300 aborted ops Child 2 - 200 aborted ops Child 0 - 350 aborted ops Child 2 - 250 aborted ops Child 0 - 400 aborted ops Child 2 - 300 aborted ops Child 0 - 450 aborted ops Child 2 - 350 aborted ops Child 1 - 350 aborted ops Child 0 - 500 aborted ops Child 2 - 400 aborted ops Child 1 - 400 aborted ops Child 2 - 450 aborted ops Child 0 - 550 aborted ops Child 2 - 500 aborted ops Child 1 - 450 aborted ops Child 0 - 600 aborted ops Child 2 - 550 aborted ops Child 0 - 650 aborted ops Child 2 - 600 aborted ops Child 1 - 500 aborted ops Child 0 - 700 aborted ops Child 2 - 650 aborted ops Child 1 - 550 aborted ops Child 0 - 750 aborted ops Child 2 - 700 aborted ops Child 1 - 600 aborted ops Child 0 - 800 aborted ops Child 2 - 750 aborted ops Child 1 - 650 aborted ops Child 0 - 850 aborted ops Child 2 - 800 aborted ops Tue Mar 30 20:42:26 2010 Completed. Tue Mar 30 20:42:26 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:42:26 2010 Completed. Tue Mar 30 20:42:26 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:42:27 2010 Received. Tue Mar 30 20:42:27 2010 Starting 300 seconds test run. Child 0 - 900 aborted ops Child 2 - 850 aborted ops Child 1 - 700 aborted ops Child 2 - 900 aborted ops Child 0 - 950 aborted ops Child 2 - 950 aborted ops Child 1 - 750 aborted ops Child 1 - 800 aborted ops Child 0 - 1000 aborted ops Child 0 - 1050 aborted ops Child 0 - 1100 aborted ops Child 2 - 1000 aborted ops Child 1 - 850 aborted ops Child 2 - 1050 aborted ops Child 1 - 900 aborted ops Child 2 - 1100 aborted ops Child 1 - 950 aborted ops Child 0 - 1150 aborted ops Child 1 - 1000 aborted ops Child 2 - 1150 aborted ops Child 0 - 1200 aborted ops Child 1 - 1050 aborted ops Child 2 - 1200 aborted ops Child 0 - 1250 aborted ops Child 1 - 1100 aborted ops Child 2 - 1250 aborted ops Child 2 - 1300 aborted ops Child 0 - 1300 aborted ops Child 1 - 1150 aborted ops Child 2 - 1350 aborted ops Child 0 - 1350 aborted ops Child 2 - 1400 aborted ops Child 1 - 1200 aborted ops Child 1 - 1250 aborted ops Child 2 - 1450 aborted ops Child 0 - 1400 aborted ops Child 1 - 1300 aborted ops Child 2 - 1500 aborted ops Child 0 - 1450 aborted ops Child 1 - 1350 aborted ops Child 2 - 1550 aborted ops Child 0 - 1500 aborted ops Child 2 - 1600 aborted ops Child 0 - 1550 aborted ops Child 1 - 1400 aborted ops Child 2 - 1650 aborted ops Child 0 - 1600 aborted ops Child 2 - 1700 aborted ops Child 1 - 1450 aborted ops Child 0 - 1650 aborted ops Child 1 - 1500 aborted ops Child 2 - 1750 aborted ops Child 1 - 1550 aborted ops Child 2 - 1800 aborted ops Child 0 - 1700 aborted ops Child 1 - 1600 aborted ops Child 1 - 1650 aborted ops Child 0 - 1750 aborted ops Child 2 - 1850 aborted ops Child 1 - 1700 aborted ops Child 0 - 1800 aborted ops Child 2 - 1900 aborted ops Child 0 - 1850 aborted ops Child 0 - 1900 aborted ops Child 2 - 1950 aborted ops Child 0 - 1950 aborted ops Child 1 - 1750 aborted ops Child 1 - 1800 aborted ops Child 2 - 2000 aborted ops Child 0 - 2000 aborted ops Child 1 - 1850 aborted ops Child 2 - 2050 aborted ops Child 0 - 2050 aborted ops Child 0 - 2100 aborted ops Child 2 - 2100 aborted ops Child 2 - 2150 aborted ops Child 0 - 2150 aborted ops Child 1 - 1900 aborted ops Child 1 - 1950 aborted ops Child 2 - 2200 aborted ops Child 0 - 2200 aborted ops Child 0 - 2250 aborted ops Child 0 - 2300 aborted ops Child 1 - 2000 aborted ops Child 2 - 2250 aborted ops Child 0 - 2350 aborted ops Child 1 - 2050 aborted ops Child 2 - 2300 aborted ops Child 0 - 2400 aborted ops Child 0 - 2450 aborted ops Child 2 - 2350 aborted ops Child 1 - 2100 aborted ops Child 2 - 2400 aborted ops Child 1 - 2150 aborted ops Child 2 - 2450 aborted ops Child 1 - 2200 aborted ops Child 0 - 2500 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 20:47:37 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 393407 393407 0 0.18 0.59 0.00 6.6% setattr 4.0% 4.0% 60628 60628 0 0.22 5.25 0.02 1.2% lookup 24.0% 24.1% 363480 363480 0 0.19 0.24 0.00 6.3% readlink 1.0% 1.0% 15243 15243 0 0.18 0.17 0.01 0.3% read 18.0% 18.1% 272491 334748 0 0.52 1.00 0.00 13.3% write 10.0% 10.0% 151516 183403 0 4.21 64.22 0.04 59.5% create 1.0% 1.0% 15272 15272 0 3.29 74.69 0.14 4.7% remove 1.0% 0.7% 10383 10383 0 0.21 0.19 0.01 0.2% readdir 1.0% 1.0% 15323 15323 0 0.49 0.12 0.01 0.7% fsstat 1.0% 1.0% 15166 15166 0 0.18 0.13 0.01 0.3% access 11.0% 11.0% 166176 166176 0 0.18 0.21 0.00 2.8% commit 0.0% 0.0% 0 91133 0 0.00 0.00 0.00 1.6% readdirplus 2.0% 2.0% 30254 30254 0 0.89 0.15 0.00 2.5% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 5047.95 Ops/Sec AVG. RESPONSE TIME: 0.71 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 4900 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1509339 TEST TIME: 299 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1694616 PHYSICAL NFS V3 THROUGHPUT: 5667.61 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3560798.0 KB (100.00% to 111.69% of Base) ------------------------------------------------------------------------ Tue Mar 30 20:47:37 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 4900 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 20:47:37 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:47:37 2010 Completed. Tue Mar 30 20:47:37 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 20:47:38 2010 Received. Tue Mar 30 20:47:38 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 20:47:38 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5000 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 20:47:40 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 20:47:40 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 20:47:51 2010 Completed. Tue Mar 30 20:47:51 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:47:51 2010 Completed. Tue Mar 30 20:47:51 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:47:56 2010 Received. Tue Mar 30 20:47:56 2010 Initializing test directories. Tue Mar 30 20:47:56 2010 Child 2 will create 167 directories. Tue Mar 30 20:47:56 2010 Child 0 will create 167 directories. Tue Mar 30 20:47:56 2010 Child 1 will create 167 directories. Tue Mar 30 20:47:56 2010 Child 3 will create 167 directories. Tue Mar 30 20:47:57 2010 Child 0 finished creating 167 directories. Tue Mar 30 20:47:57 2010 Child 0 will create 5102 files. Tue Mar 30 20:48:03 2010 Child 1 finished creating 167 directories. Tue Mar 30 20:48:03 2010 Child 1 will create 5102 files. Tue Mar 30 20:48:06 2010 Child 2 finished creating 167 directories. Tue Mar 30 20:48:06 2010 Child 2 will create 5102 files. Tue Mar 30 20:48:09 2010 Child 3 finished creating 167 directories. Tue Mar 30 20:48:09 2010 Child 3 will create 5102 files. Tue Mar 30 20:50:49 2010 Child 3 verified 5102 files, created 49 Tue Mar 30 20:50:49 2010 Child 3 will create 6 symlinks. Tue Mar 30 20:50:49 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 20:50:49 2010 Child 2 verified 5102 files, created 48 Tue Mar 30 20:50:49 2010 Child 2 will create 6 symlinks. Tue Mar 30 20:50:49 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 20:50:53 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 20:50:53 2010 Child 1 will create 6 symlinks. Tue Mar 30 20:50:53 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 20:50:54 2010 Child 0 verified 5102 files, created 44 Tue Mar 30 20:50:54 2010 Child 0 will create 6 symlinks. Tue Mar 30 20:50:54 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 20:50:54 2010 Completed. Tue Mar 30 20:50:54 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:50:54 2010 Completed. Tue Mar 30 20:50:54 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:50:55 2010 Received. Tue Mar 30 20:50:55 2010 Performing 300 seconds pretest warmup. Child 1 - 50 aborted ops Child 3 - 50 aborted ops Child 0 - 50 aborted ops Child 2 - 50 aborted ops Child 3 - 100 aborted ops Child 1 - 100 aborted ops Child 0 - 100 aborted ops Child 3 - 150 aborted ops Child 1 - 150 aborted ops Child 2 - 100 aborted ops Child 0 - 150 aborted ops Child 1 - 200 aborted ops Child 2 - 150 aborted ops Child 3 - 200 aborted ops Child 0 - 200 aborted ops Child 2 - 200 aborted ops Child 1 - 250 aborted ops Child 3 - 250 aborted ops Child 0 - 250 aborted ops Child 3 - 300 aborted ops Child 0 - 300 aborted ops Child 2 - 250 aborted ops Child 1 - 300 aborted ops Child 3 - 350 aborted ops Child 0 - 350 aborted ops Child 1 - 350 aborted ops Child 0 - 400 aborted ops Child 3 - 400 aborted ops Child 1 - 400 aborted ops Child 2 - 300 aborted ops Child 0 - 450 aborted ops Child 3 - 450 aborted ops Child 1 - 450 aborted ops Child 0 - 500 aborted ops Child 2 - 350 aborted ops Child 3 - 500 aborted ops Child 0 - 550 aborted ops Child 1 - 500 aborted ops Child 3 - 550 aborted ops Child 1 - 550 aborted ops Child 2 - 400 aborted ops Child 3 - 600 aborted ops Child 1 - 600 aborted ops Child 0 - 600 aborted ops Child 2 - 450 aborted ops Child 3 - 650 aborted ops Child 2 - 500 aborted ops Child 1 - 650 aborted ops Child 0 - 650 aborted ops Child 3 - 700 aborted ops Child 1 - 700 aborted ops Child 0 - 700 aborted ops Child 3 - 750 aborted ops Child 2 - 550 aborted ops Child 1 - 750 aborted ops Child 0 - 750 aborted ops Child 3 - 800 aborted ops Child 0 - 800 aborted ops Child 1 - 800 aborted ops Child 3 - 850 aborted ops Child 2 - 600 aborted ops Child 1 - 850 aborted ops Child 0 - 850 aborted ops Child 3 - 900 aborted ops Child 0 - 900 aborted ops Child 2 - 650 aborted ops Child 3 - 950 aborted ops Child 1 - 900 aborted ops Child 3 - 1000 aborted ops Child 2 - 700 aborted ops Child 1 - 950 aborted ops Child 2 - 750 aborted ops Child 0 - 950 aborted ops Child 2 - 800 aborted ops Child 0 - 1000 aborted ops Child 2 - 850 aborted ops Child 3 - 1050 aborted ops Child 2 - 900 aborted ops Child 1 - 1000 aborted ops Child 2 - 950 aborted ops Child 0 - 1050 aborted ops Child 3 - 1100 aborted ops Child 0 - 1100 aborted ops Child 1 - 1050 aborted ops Child 2 - 1000 aborted ops Child 3 - 1150 aborted ops Child 0 - 1150 aborted ops Child 2 - 1050 aborted ops Child 1 - 1100 aborted ops Child 2 - 1100 aborted ops Child 3 - 1200 aborted ops Child 0 - 1200 aborted ops Child 2 - 1150 aborted ops Child 3 - 1250 aborted ops Child 0 - 1250 aborted ops Child 1 - 1150 aborted ops Child 2 - 1200 aborted ops Child 3 - 1300 aborted ops Child 0 - 1300 aborted ops Child 1 - 1200 aborted ops Child 2 - 1250 aborted ops Child 1 - 1250 aborted ops Child 2 - 1300 aborted ops Child 3 - 1350 aborted ops Child 0 - 1350 aborted ops Tue Mar 30 20:55:55 2010 Completed. Tue Mar 30 20:55:55 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:55:55 2010 Completed. Tue Mar 30 20:55:55 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 20:55:56 2010 Received. Tue Mar 30 20:55:56 2010 Starting 300 seconds test run. Child 1 - 1300 aborted ops Child 0 - 1400 aborted ops Child 2 - 1350 aborted ops Child 1 - 1350 aborted ops Child 3 - 1400 aborted ops Child 0 - 1450 aborted ops Child 1 - 1400 aborted ops Child 2 - 1400 aborted ops Child 1 - 1450 aborted ops Child 0 - 1500 aborted ops Child 3 - 1450 aborted ops Child 2 - 1450 aborted ops Child 1 - 1500 aborted ops Child 3 - 1500 aborted ops Child 0 - 1550 aborted ops Child 1 - 1550 aborted ops Child 3 - 1550 aborted ops Child 2 - 1500 aborted ops Child 0 - 1600 aborted ops Child 2 - 1550 aborted ops Child 1 - 1600 aborted ops Child 0 - 1650 aborted ops Child 2 - 1600 aborted ops Child 1 - 1650 aborted ops Child 2 - 1650 aborted ops Child 3 - 1600 aborted ops Child 0 - 1700 aborted ops Child 3 - 1650 aborted ops Child 1 - 1700 aborted ops Child 2 - 1700 aborted ops Child 3 - 1700 aborted ops Child 0 - 1750 aborted ops Child 3 - 1750 aborted ops Child 2 - 1750 aborted ops Child 1 - 1750 aborted ops Child 2 - 1800 aborted ops Child 3 - 1800 aborted ops Child 3 - 1850 aborted ops Child 2 - 1850 aborted ops Child 1 - 1800 aborted ops Child 3 - 1900 aborted ops Child 2 - 1900 aborted ops Child 0 - 1800 aborted ops Child 0 - 1850 aborted ops Child 1 - 1850 aborted ops Child 0 - 1900 aborted ops Child 2 - 1950 aborted ops Child 1 - 1900 aborted ops Child 0 - 1950 aborted ops Child 3 - 1950 aborted ops Child 2 - 2000 aborted ops Child 1 - 1950 aborted ops Child 2 - 2050 aborted ops Child 3 - 2000 aborted ops Child 0 - 2000 aborted ops Child 3 - 2050 aborted ops Child 0 - 2050 aborted ops Child 0 - 2100 aborted ops Child 1 - 2000 aborted ops Child 0 - 2150 aborted ops Child 3 - 2100 aborted ops Child 2 - 2100 aborted ops Child 0 - 2200 aborted ops Child 2 - 2150 aborted ops Child 1 - 2050 aborted ops Child 1 - 2100 aborted ops Child 2 - 2200 aborted ops Child 1 - 2150 aborted ops Child 3 - 2150 aborted ops Child 0 - 2250 aborted ops Child 1 - 2200 aborted ops Child 1 - 2250 aborted ops Child 2 - 2250 aborted ops Child 0 - 2300 aborted ops Child 3 - 2200 aborted ops Child 2 - 2300 aborted ops Child 3 - 2250 aborted ops Child 1 - 2300 aborted ops Child 3 - 2300 aborted ops Child 0 - 2350 aborted ops Child 2 - 2350 aborted ops Child 3 - 2350 aborted ops Child 1 - 2350 aborted ops Child 0 - 2400 aborted ops Child 2 - 2400 aborted ops Child 1 - 2400 aborted ops Child 2 - 2450 aborted ops Child 1 - 2450 aborted ops Child 1 - 2500 aborted ops Child 0 - 2450 aborted ops Child 0 - 2500 aborted ops Child 2 - 2500 aborted ops Child 3 - 2400 aborted ops Child 2 - 2550 aborted ops Child 3 - 2450 aborted ops Child 3 - 2500 aborted ops Child 1 - 2550 aborted ops Child 2 - 2600 aborted ops Child 1 - 2600 aborted ops Child 0 - 2550 aborted ops Child 1 - 2650 aborted ops Child 2 - 2650 aborted ops Child 0 - 2600 aborted ops Child 3 - 2550 aborted ops Child 1 - 2700 aborted ops Child 2 - 2700 aborted ops Child 0 - 2650 aborted ops Child 3 - 2600 aborted ops Child 1 - 2750 aborted ops Child 0 - 2700 aborted ops Child 1 - 2800 aborted ops Child 3 - 2650 aborted ops Child 0 - 2750 aborted ops Child 0 - 2800 aborted ops Child 2 - 2750 aborted ops Child 3 - 2700 aborted ops Child 2 - 2800 aborted ops Child 0 - 2850 aborted ops Child 3 - 2750 aborted ops Child 1 - 2850 aborted ops Child 0 - 2900 aborted ops Child 3 - 2800 aborted ops Child 2 - 2850 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 21:01:10 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 362042 362042 0 0.18 0.85 0.00 5.5% setattr 4.0% 4.0% 55657 55657 0 0.20 1.52 0.01 0.9% lookup 24.0% 24.1% 334796 334796 0 0.19 0.30 0.00 5.3% readlink 1.0% 1.0% 14003 14003 0 0.18 0.28 0.01 0.2% read 18.0% 18.1% 250972 309967 0 0.57 1.65 0.01 12.1% write 10.0% 10.0% 139115 168660 0 5.72 110.77 0.06 67.3% create 1.0% 1.0% 13927 13927 0 1.74 37.97 0.10 2.1% remove 1.0% 0.6% 7913 7913 0 0.21 0.18 0.01 0.1% readdir 1.0% 1.0% 13924 13924 0 0.49 0.16 0.01 0.6% fsstat 1.0% 1.0% 14013 14013 0 0.20 2.59 0.03 0.2% access 11.0% 11.1% 153358 153358 0 0.18 0.28 0.00 2.3% commit 0.0% 0.0% 0 83760 0 0.00 0.00 0.00 1.3% readdirplus 2.0% 2.0% 27752 27752 0 0.89 0.17 0.00 2.1% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4609.54 Ops/Sec AVG. RESPONSE TIME: 0.85 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5000 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1387472 TEST TIME: 301 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1559772 PHYSICAL NFS V3 THROUGHPUT: 5181.96 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 21:01:10 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5000 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 21:01:10 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:01:10 2010 Completed. Tue Mar 30 21:01:10 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 21:01:11 2010 Received. Tue Mar 30 21:01:11 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 21:01:11 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5100 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 21:01:13 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 21:01:13 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 21:01:29 2010 Completed. Tue Mar 30 21:01:29 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:01:29 2010 Completed. Tue Mar 30 21:01:29 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:01:29 2010 Received. Tue Mar 30 21:01:29 2010 Initializing test directories. Tue Mar 30 21:01:29 2010 Child 3 will create 167 directories. Tue Mar 30 21:01:29 2010 Child 2 will create 167 directories. Tue Mar 30 21:01:29 2010 Child 1 will create 167 directories. Tue Mar 30 21:01:29 2010 Child 0 will create 167 directories. Tue Mar 30 21:01:30 2010 Child 3 finished creating 167 directories. Tue Mar 30 21:01:30 2010 Child 3 will create 5102 files. Tue Mar 30 21:01:41 2010 Child 1 finished creating 167 directories. Tue Mar 30 21:01:41 2010 Child 1 will create 5102 files. Tue Mar 30 21:01:43 2010 Child 0 finished creating 167 directories. Tue Mar 30 21:01:43 2010 Child 0 will create 5102 files. Tue Mar 30 21:01:44 2010 Child 2 finished creating 167 directories. Tue Mar 30 21:01:44 2010 Child 2 will create 5102 files. Tue Mar 30 21:01:50 2010 Child 3 verified 5102 files, created 50 Tue Mar 30 21:01:50 2010 Child 3 will create 6 symlinks. Tue Mar 30 21:01:50 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 21:01:54 2010 Child 0 verified 5102 files, created 47 Tue Mar 30 21:01:54 2010 Child 0 will create 6 symlinks. Tue Mar 30 21:01:54 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 21:01:55 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 21:01:55 2010 Child 1 will create 6 symlinks. Tue Mar 30 21:01:55 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 21:02:08 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 21:02:08 2010 Child 2 will create 6 symlinks. Tue Mar 30 21:02:08 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 21:02:08 2010 Completed. Tue Mar 30 21:02:08 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:02:08 2010 Completed. Tue Mar 30 21:02:08 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:02:09 2010 Received. Tue Mar 30 21:02:09 2010 Performing 300 seconds pretest warmup. Child 2 - 50 aborted ops Child 1 - 50 aborted ops Child 0 - 50 aborted ops Child 3 - 50 aborted ops Child 2 - 100 aborted ops Child 1 - 100 aborted ops Child 0 - 100 aborted ops Child 2 - 150 aborted ops Child 1 - 150 aborted ops Child 3 - 100 aborted ops Child 0 - 150 aborted ops Child 2 - 200 aborted ops Child 1 - 200 aborted ops Child 0 - 200 aborted ops Child 3 - 150 aborted ops Child 2 - 250 aborted ops Child 1 - 250 aborted ops Child 3 - 200 aborted ops Child 2 - 300 aborted ops Child 0 - 250 aborted ops Child 1 - 300 aborted ops Child 0 - 300 aborted ops Child 3 - 250 aborted ops Child 2 - 350 aborted ops Child 1 - 350 aborted ops Child 3 - 300 aborted ops Child 0 - 350 aborted ops Child 2 - 400 aborted ops Child 1 - 400 aborted ops Child 3 - 350 aborted ops Child 0 - 400 aborted ops Child 2 - 450 aborted ops Child 1 - 450 aborted ops Child 0 - 450 aborted ops Child 2 - 500 aborted ops Child 3 - 400 aborted ops Child 1 - 500 aborted ops Child 0 - 500 aborted ops Child 2 - 550 aborted ops Child 1 - 550 aborted ops Child 3 - 450 aborted ops Child 0 - 550 aborted ops Child 1 - 600 aborted ops Child 2 - 600 aborted ops Child 3 - 500 aborted ops Child 0 - 600 aborted ops Child 1 - 650 aborted ops Child 0 - 650 aborted ops Child 3 - 550 aborted ops Child 2 - 650 aborted ops Child 1 - 700 aborted ops Child 3 - 600 aborted ops Child 0 - 700 aborted ops Child 2 - 700 aborted ops Child 1 - 750 aborted ops Child 1 - 800 aborted ops Child 3 - 650 aborted ops Child 0 - 750 aborted ops Child 2 - 750 aborted ops Child 3 - 700 aborted ops Child 1 - 850 aborted ops Child 0 - 800 aborted ops Child 2 - 800 aborted ops Child 3 - 750 aborted ops Child 1 - 900 aborted ops Child 3 - 800 aborted ops Child 0 - 850 aborted ops Child 2 - 850 aborted ops Child 1 - 950 aborted ops Child 3 - 850 aborted ops Child 0 - 900 aborted ops Child 2 - 900 aborted ops Child 3 - 900 aborted ops Child 1 - 1000 aborted ops Child 3 - 950 aborted ops Child 2 - 950 aborted ops Child 1 - 1050 aborted ops Tue Mar 30 21:07:09 2010 Completed. Tue Mar 30 21:07:09 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:07:09 2010 Completed. Tue Mar 30 21:07:09 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:07:10 2010 Received. Tue Mar 30 21:07:10 2010 Starting 300 seconds test run. Child 0 - 950 aborted ops Child 3 - 1000 aborted ops Child 1 - 1100 aborted ops Child 3 - 1050 aborted ops Child 0 - 1000 aborted ops Child 2 - 1000 aborted ops Child 0 - 1050 aborted ops Child 2 - 1050 aborted ops Child 1 - 1150 aborted ops Child 0 - 1100 aborted ops Child 3 - 1100 aborted ops Child 2 - 1100 aborted ops Child 2 - 1150 aborted ops Child 1 - 1200 aborted ops Child 0 - 1150 aborted ops Child 3 - 1150 aborted ops Child 1 - 1250 aborted ops Child 2 - 1200 aborted ops Child 0 - 1200 aborted ops Child 1 - 1300 aborted ops Child 2 - 1250 aborted ops Child 2 - 1300 aborted ops Child 0 - 1250 aborted ops Child 1 - 1350 aborted ops Child 3 - 1200 aborted ops Child 2 - 1350 aborted ops Child 1 - 1400 aborted ops Child 2 - 1400 aborted ops Child 1 - 1450 aborted ops Child 0 - 1300 aborted ops Child 2 - 1450 aborted ops Child 3 - 1250 aborted ops Child 1 - 1500 aborted ops Child 0 - 1350 aborted ops Child 2 - 1500 aborted ops Child 2 - 1550 aborted ops Child 2 - 1600 aborted ops Child 1 - 1550 aborted ops Child 3 - 1300 aborted ops Child 0 - 1400 aborted ops Child 1 - 1600 aborted ops Child 3 - 1350 aborted ops Child 2 - 1650 aborted ops Child 0 - 1450 aborted ops Child 1 - 1650 aborted ops Child 0 - 1500 aborted ops Child 2 - 1700 aborted ops Child 0 - 1550 aborted ops Child 3 - 1400 aborted ops Child 1 - 1700 aborted ops Child 2 - 1750 aborted ops Child 0 - 1600 aborted ops Child 2 - 1800 aborted ops Child 3 - 1450 aborted ops Child 0 - 1650 aborted ops Child 1 - 1750 aborted ops Child 1 - 1800 aborted ops Child 0 - 1700 aborted ops Child 2 - 1850 aborted ops Child 0 - 1750 aborted ops Child 3 - 1500 aborted ops Child 2 - 1900 aborted ops Child 1 - 1850 aborted ops Child 0 - 1800 aborted ops Child 3 - 1550 aborted ops Child 1 - 1900 aborted ops Child 2 - 1950 aborted ops Child 0 - 1850 aborted ops Child 3 - 1600 aborted ops Child 1 - 1950 aborted ops Child 0 - 1900 aborted ops Child 2 - 2000 aborted ops Child 3 - 1650 aborted ops Child 1 - 2000 aborted ops Child 3 - 1700 aborted ops Child 1 - 2050 aborted ops Child 2 - 2050 aborted ops Child 3 - 1750 aborted ops Child 0 - 1950 aborted ops Child 1 - 2100 aborted ops Child 0 - 2000 aborted ops Child 3 - 1800 aborted ops Child 2 - 2100 aborted ops Child 0 - 2050 aborted ops Child 0 - 2100 aborted ops Child 3 - 1850 aborted ops Child 2 - 2150 aborted ops Child 1 - 2150 aborted ops Child 3 - 1900 aborted ops Child 0 - 2150 aborted ops Child 2 - 2200 aborted ops Child 1 - 2200 aborted ops Child 0 - 2200 aborted ops Child 3 - 1950 aborted ops Child 2 - 2250 aborted ops Child 1 - 2250 aborted ops Child 2 - 2300 aborted ops Child 0 - 2250 aborted ops Child 1 - 2300 aborted ops Child 3 - 2000 aborted ops Child 1 - 2350 aborted ops Child 3 - 2050 aborted ops Child 0 - 2300 aborted ops Child 2 - 2350 aborted ops Child 1 - 2400 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 21:12:20 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 307610 307610 0 0.19 0.21 0.00 5.6% setattr 4.0% 4.0% 47450 47450 0 0.21 1.13 0.01 1.0% lookup 24.0% 24.1% 283694 283694 0 0.23 16.86 0.02 6.3% readlink 1.0% 1.0% 11651 11651 0 0.20 0.11 0.01 0.2% read 18.0% 18.1% 213197 262486 1 0.54 0.93 0.00 11.0% write 10.0% 10.1% 118433 142790 0 5.36 152.89 0.07 60.8% create 1.0% 1.0% 11763 11763 0 4.40 70.12 0.15 5.0% remove 1.0% 0.6% 6506 6506 0 0.23 0.14 0.01 0.1% readdir 1.0% 1.0% 11959 11959 0 0.51 0.27 0.01 0.6% fsstat 1.0% 1.0% 11983 11983 0 0.19 0.11 0.01 0.2% access 11.0% 11.1% 130301 130301 0 0.19 0.20 0.00 2.4% commit 0.0% 0.0% 0 71214 0 0.00 0.00 0.00 1.3% readdirplus 2.0% 2.0% 23520 23520 0 2.39 227.51 0.19 5.4% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4750.27 Ops/Sec AVG. RESPONSE TIME: 0.88 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5100 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1178067 TEST TIME: 248 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1322927 PHYSICAL NFS V3 THROUGHPUT: 5334.38 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 21:12:20 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5100 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 21:12:20 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:12:20 2010 Completed. Tue Mar 30 21:12:20 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 21:12:21 2010 Received. Tue Mar 30 21:12:21 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 21:12:21 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5200 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 21:12:23 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 21:12:23 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 21:12:34 2010 Completed. Tue Mar 30 21:12:34 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:12:34 2010 Completed. Tue Mar 30 21:12:34 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:12:39 2010 Received. Tue Mar 30 21:12:39 2010 Initializing test directories. Tue Mar 30 21:12:39 2010 Child 3 will create 167 directories. Tue Mar 30 21:12:39 2010 Child 1 will create 167 directories. Tue Mar 30 21:12:39 2010 Child 0 will create 167 directories. Tue Mar 30 21:12:39 2010 Child 2 will create 167 directories. Tue Mar 30 21:12:40 2010 Child 1 finished creating 167 directories. Tue Mar 30 21:12:40 2010 Child 1 will create 5102 files. Tue Mar 30 21:12:42 2010 Child 2 finished creating 167 directories. Tue Mar 30 21:12:42 2010 Child 2 will create 5102 files. Tue Mar 30 21:12:45 2010 Child 3 finished creating 167 directories. Tue Mar 30 21:12:45 2010 Child 3 will create 5102 files. Tue Mar 30 21:12:46 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 21:12:46 2010 Child 1 will create 6 symlinks. Tue Mar 30 21:12:46 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 21:12:49 2010 Child 0 finished creating 167 directories. Tue Mar 30 21:12:49 2010 Child 0 will create 5102 files. Tue Mar 30 21:12:57 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 21:12:57 2010 Child 3 will create 6 symlinks. Tue Mar 30 21:12:57 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 21:13:03 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 21:13:03 2010 Child 2 will create 6 symlinks. Tue Mar 30 21:13:03 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 21:13:17 2010 Child 0 verified 5102 files, created 50 Tue Mar 30 21:13:17 2010 Child 0 will create 6 symlinks. Tue Mar 30 21:13:17 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 21:13:17 2010 Completed. Tue Mar 30 21:13:17 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:13:17 2010 Completed. Tue Mar 30 21:13:17 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:13:18 2010 Received. Tue Mar 30 21:13:18 2010 Performing 300 seconds pretest warmup. Child 3 - 50 aborted ops Child 1 - 50 aborted ops Child 2 - 50 aborted ops Child 0 - 50 aborted ops Child 3 - 100 aborted ops Child 0 - 100 aborted ops Child 2 - 100 aborted ops Child 1 - 100 aborted ops Child 0 - 150 aborted ops Child 3 - 150 aborted ops Child 1 - 150 aborted ops Child 2 - 150 aborted ops Child 3 - 200 aborted ops Child 0 - 200 aborted ops Child 1 - 200 aborted ops Child 3 - 250 aborted ops Child 0 - 250 aborted ops Child 2 - 200 aborted ops Child 3 - 300 aborted ops Child 1 - 250 aborted ops Child 2 - 250 aborted ops Child 0 - 300 aborted ops Child 1 - 300 aborted ops Child 3 - 350 aborted ops Child 2 - 300 aborted ops Child 0 - 350 aborted ops Child 1 - 350 aborted ops Child 1 - 400 aborted ops Child 3 - 400 aborted ops Child 2 - 350 aborted ops Child 0 - 400 aborted ops Child 1 - 450 aborted ops Child 3 - 450 aborted ops Child 0 - 450 aborted ops Child 2 - 400 aborted ops Child 1 - 500 aborted ops Child 3 - 500 aborted ops Child 2 - 450 aborted ops Child 0 - 500 aborted ops Child 1 - 550 aborted ops Child 3 - 550 aborted ops Child 2 - 500 aborted ops Child 1 - 600 aborted ops Child 3 - 600 aborted ops Child 0 - 550 aborted ops Child 2 - 550 aborted ops Child 1 - 650 aborted ops Child 2 - 600 aborted ops Tue Mar 30 21:18:18 2010 Completed. Tue Mar 30 21:18:18 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:18:18 2010 Completed. Tue Mar 30 21:18:18 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Child 0 - 600 aborted ops Tue Mar 30 21:18:19 2010 Received. Tue Mar 30 21:18:19 2010 Starting 300 seconds test run. Child 2 - 650 aborted ops Child 1 - 700 aborted ops Child 3 - 650 aborted ops Child 0 - 650 aborted ops Child 2 - 700 aborted ops Child 1 - 750 aborted ops Child 0 - 700 aborted ops Child 3 - 700 aborted ops Child 2 - 750 aborted ops Child 1 - 800 aborted ops Child 0 - 750 aborted ops Child 1 - 850 aborted ops Child 3 - 750 aborted ops Child 0 - 800 aborted ops Child 1 - 900 aborted ops Child 3 - 800 aborted ops Child 0 - 850 aborted ops Child 2 - 800 aborted ops Child 1 - 950 aborted ops Child 0 - 900 aborted ops Child 3 - 850 aborted ops Child 2 - 850 aborted ops Child 0 - 950 aborted ops Child 1 - 1000 aborted ops Child 0 - 1000 aborted ops Child 3 - 900 aborted ops Child 2 - 900 aborted ops Child 0 - 1050 aborted ops Child 3 - 950 aborted ops Child 1 - 1050 aborted ops Child 2 - 950 aborted ops Child 0 - 1100 aborted ops Child 3 - 1000 aborted ops Child 1 - 1100 aborted ops Child 0 - 1150 aborted ops Child 2 - 1000 aborted ops Child 3 - 1050 aborted ops Child 0 - 1200 aborted ops Child 2 - 1050 aborted ops Child 3 - 1100 aborted ops Child 1 - 1150 aborted ops Child 0 - 1250 aborted ops Child 2 - 1100 aborted ops Child 1 - 1200 aborted ops Child 2 - 1150 aborted ops Child 3 - 1150 aborted ops Child 0 - 1300 aborted ops Child 1 - 1250 aborted ops Child 0 - 1350 aborted ops Child 3 - 1200 aborted ops Child 1 - 1300 aborted ops Child 0 - 1400 aborted ops Child 2 - 1200 aborted ops Child 1 - 1350 aborted ops Child 3 - 1250 aborted ops Child 0 - 1450 aborted ops Child 2 - 1250 aborted ops Child 1 - 1400 aborted ops Child 3 - 1300 aborted ops Child 0 - 1500 aborted ops Child 1 - 1450 aborted ops Child 3 - 1350 aborted ops Child 0 - 1550 aborted ops Child 3 - 1400 aborted ops Child 2 - 1300 aborted ops Child 1 - 1500 aborted ops Child 1 - 1550 aborted ops Child 3 - 1450 aborted ops Child 0 - 1600 aborted ops Child 3 - 1500 aborted ops Child 2 - 1350 aborted ops Child 1 - 1600 aborted ops Child 3 - 1550 aborted ops Child 0 - 1650 aborted ops Child 2 - 1400 aborted ops Child 1 - 1650 aborted ops Child 3 - 1600 aborted ops Child 0 - 1700 aborted ops Child 3 - 1650 aborted ops Child 2 - 1450 aborted ops Child 1 - 1700 aborted ops Child 1 - 1750 aborted ops Child 0 - 1750 aborted ops Child 2 - 1500 aborted ops Child 3 - 1700 aborted ops Child 1 - 1800 aborted ops Child 3 - 1750 aborted ops Child 2 - 1550 aborted ops Child 1 - 1850 aborted ops Child 3 - 1800 aborted ops Child 0 - 1800 aborted ops Child 2 - 1600 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 21:23:29 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 246283 246283 0 0.18 0.24 0.00 4.1% setattr 4.0% 4.0% 37979 37979 2 0.21 2.85 0.02 0.7% lookup 24.0% 24.1% 227777 227777 0 0.38 92.09 0.04 8.0% readlink 1.0% 1.0% 9613 9613 0 0.19 0.20 0.01 0.2% read 18.0% 18.0% 169956 209054 2 0.79 106.62 0.05 12.4% write 10.0% 10.1% 95162 115422 0 7.24 253.46 0.10 63.9% create 1.0% 1.0% 9479 9479 0 6.35 99.26 0.20 5.6% remove 1.0% 0.5% 4937 4937 0 0.21 0.10 0.01 0.1% readdir 1.0% 1.0% 9469 9469 0 0.50 0.19 0.01 0.4% fsstat 1.0% 1.0% 9604 9604 0 0.18 0.29 0.01 0.2% access 11.0% 11.1% 104592 104592 0 0.18 0.17 0.00 1.8% commit 0.0% 0.0% 0 57310 0 0.00 0.00 0.00 1.0% readdirplus 2.0% 2.0% 18769 18769 0 0.90 0.23 0.01 1.6% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 3155.91 Ops/Sec AVG. RESPONSE TIME: 1.14 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5200 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 943620 TEST TIME: 299 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1060288 PHYSICAL NFS V3 THROUGHPUT: 3546.11 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 21:23:29 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5200 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 21:23:29 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:23:29 2010 Completed. Tue Mar 30 21:23:29 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 21:23:30 2010 Received. Tue Mar 30 21:23:30 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 21:23:30 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5300 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 21:23:32 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 21:23:32 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 21:23:43 2010 Completed. Tue Mar 30 21:23:43 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:23:43 2010 Completed. Tue Mar 30 21:23:43 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:23:48 2010 Received. Tue Mar 30 21:23:48 2010 Initializing test directories. Tue Mar 30 21:23:48 2010 Child 0 will create 167 directories. Tue Mar 30 21:23:48 2010 Child 3 will create 167 directories. Tue Mar 30 21:23:48 2010 Child 1 will create 167 directories. Tue Mar 30 21:23:48 2010 Child 2 will create 167 directories. Tue Mar 30 21:23:54 2010 Child 1 finished creating 167 directories. Tue Mar 30 21:23:54 2010 Child 1 will create 5102 files. Tue Mar 30 21:23:57 2010 Child 2 finished creating 167 directories. Tue Mar 30 21:23:57 2010 Child 2 will create 5102 files. Tue Mar 30 21:23:59 2010 Child 3 finished creating 167 directories. Tue Mar 30 21:23:59 2010 Child 3 will create 5102 files. Tue Mar 30 21:24:01 2010 Child 1 verified 5102 files, created 47 Tue Mar 30 21:24:01 2010 Child 1 will create 6 symlinks. Tue Mar 30 21:24:01 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 21:24:04 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 21:24:04 2010 Child 2 will create 6 symlinks. Tue Mar 30 21:24:04 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 21:24:04 2010 Child 0 finished creating 167 directories. Tue Mar 30 21:24:04 2010 Child 0 will create 5102 files. Tue Mar 30 21:24:14 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 21:24:14 2010 Child 0 will create 6 symlinks. Tue Mar 30 21:24:14 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 21:24:14 2010 Child 3 verified 5102 files, created 50 Tue Mar 30 21:24:14 2010 Child 3 will create 6 symlinks. Tue Mar 30 21:24:14 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 21:24:15 2010 Completed. Tue Mar 30 21:24:15 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:24:15 2010 Completed. Tue Mar 30 21:24:15 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:24:16 2010 Received. Tue Mar 30 21:24:16 2010 Performing 300 seconds pretest warmup. Child 0 - 50 aborted ops Child 3 - 50 aborted ops Child 3 - 100 aborted ops Child 0 - 100 aborted ops Child 3 - 150 aborted ops Child 0 - 150 aborted ops Child 1 - 50 aborted ops Child 3 - 200 aborted ops Child 0 - 200 aborted ops Child 2 - 50 aborted ops Child 1 - 100 aborted ops Child 3 - 250 aborted ops Child 2 - 100 aborted ops Child 1 - 150 aborted ops Child 0 - 250 aborted ops Child 3 - 300 aborted ops Child 2 - 150 aborted ops Child 1 - 200 aborted ops Child 0 - 300 aborted ops Child 2 - 200 aborted ops Child 1 - 250 aborted ops Child 3 - 350 aborted ops Child 1 - 300 aborted ops Child 2 - 250 aborted ops Child 0 - 350 aborted ops Child 1 - 350 aborted ops Child 2 - 300 aborted ops Child 2 - 350 aborted ops Child 3 - 400 aborted ops Child 0 - 400 aborted ops Child 1 - 400 aborted ops Child 1 - 450 aborted ops Child 2 - 400 aborted ops Child 0 - 450 aborted ops Child 1 - 500 aborted ops Child 3 - 450 aborted ops Child 1 - 550 aborted ops Child 3 - 500 aborted ops Child 2 - 450 aborted ops Child 0 - 500 aborted ops Child 1 - 600 aborted ops Child 3 - 550 aborted ops Child 1 - 650 aborted ops Child 0 - 550 aborted ops Child 2 - 500 aborted ops Child 2 - 550 aborted ops Child 1 - 700 aborted ops Child 3 - 600 aborted ops Child 1 - 750 aborted ops Child 2 - 600 aborted ops Child 0 - 600 aborted ops Child 3 - 650 aborted ops Child 0 - 650 aborted ops Child 3 - 700 aborted ops Child 2 - 650 aborted ops Child 1 - 800 aborted ops Child 0 - 700 aborted ops Child 1 - 850 aborted ops Child 3 - 750 aborted ops Child 2 - 700 aborted ops Child 1 - 900 aborted ops Child 0 - 750 aborted ops Child 2 - 750 aborted ops Child 3 - 800 aborted ops Child 0 - 800 aborted ops Child 2 - 800 aborted ops Child 0 - 850 aborted ops Child 2 - 850 aborted ops Child 1 - 950 aborted ops Child 3 - 850 aborted ops Child 0 - 900 aborted ops Child 0 - 950 aborted ops Child 1 - 1000 aborted ops Child 2 - 900 aborted ops Child 3 - 900 aborted ops Child 1 - 1050 aborted ops Child 2 - 950 aborted ops Child 0 - 1000 aborted ops Child 1 - 1100 aborted ops Child 2 - 1000 aborted ops Child 3 - 950 aborted ops Child 0 - 1050 aborted ops Child 3 - 1000 aborted ops Child 2 - 1050 aborted ops Child 0 - 1100 aborted ops Child 1 - 1150 aborted ops Child 3 - 1050 aborted ops Child 0 - 1150 aborted ops Child 2 - 1100 aborted ops Child 1 - 1200 aborted ops Child 3 - 1100 aborted ops Child 1 - 1250 aborted ops Child 0 - 1200 aborted ops Child 3 - 1150 aborted ops Child 2 - 1150 aborted ops Child 0 - 1250 aborted ops Child 1 - 1300 aborted ops Child 2 - 1200 aborted ops Child 3 - 1200 aborted ops Child 1 - 1350 aborted ops Child 0 - 1300 aborted ops Child 2 - 1250 aborted ops Child 1 - 1400 aborted ops Child 3 - 1250 aborted ops Child 2 - 1300 aborted ops Child 0 - 1350 aborted ops Child 3 - 1300 aborted ops Child 1 - 1450 aborted ops Child 3 - 1350 aborted ops Child 1 - 1500 aborted ops Child 2 - 1350 aborted ops Child 1 - 1550 aborted ops Child 3 - 1400 aborted ops Child 0 - 1400 aborted ops Child 0 - 1450 aborted ops Child 1 - 1600 aborted ops Child 2 - 1400 aborted ops Tue Mar 30 21:29:16 2010 Completed. Tue Mar 30 21:29:16 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:29:16 2010 Completed. Tue Mar 30 21:29:16 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:29:17 2010 Received. Tue Mar 30 21:29:17 2010 Starting 300 seconds test run. Child 1 - 1650 aborted ops Child 1 - 1700 aborted ops Child 3 - 1450 aborted ops Child 2 - 1450 aborted ops Child 1 - 1750 aborted ops Child 0 - 1500 aborted ops Child 3 - 1500 aborted ops Child 2 - 1500 aborted ops Child 0 - 1550 aborted ops Child 1 - 1800 aborted ops Child 3 - 1550 aborted ops Child 0 - 1600 aborted ops Child 3 - 1600 aborted ops Child 2 - 1550 aborted ops Child 1 - 1850 aborted ops Child 3 - 1650 aborted ops Child 1 - 1900 aborted ops Child 2 - 1600 aborted ops Child 2 - 1650 aborted ops Child 3 - 1700 aborted ops Child 1 - 1950 aborted ops Child 1 - 2000 aborted ops Child 1 - 2050 aborted ops Child 0 - 1650 aborted ops Child 1 - 2100 aborted ops Child 2 - 1700 aborted ops Child 3 - 1750 aborted ops Child 3 - 1800 aborted ops Child 0 - 1700 aborted ops Child 0 - 1750 aborted ops Child 2 - 1750 aborted ops Child 1 - 2150 aborted ops Child 3 - 1850 aborted ops Child 0 - 1800 aborted ops Child 2 - 1800 aborted ops Child 0 - 1850 aborted ops Child 1 - 2200 aborted ops Child 3 - 1900 aborted ops Child 2 - 1850 aborted ops Child 1 - 2250 aborted ops Child 3 - 1950 aborted ops Child 2 - 1900 aborted ops Child 3 - 2000 aborted ops Child 0 - 1900 aborted ops Child 1 - 2300 aborted ops Child 3 - 2050 aborted ops Child 2 - 1950 aborted ops Child 0 - 1950 aborted ops Child 3 - 2100 aborted ops Child 2 - 2000 aborted ops Child 1 - 2350 aborted ops Child 0 - 2000 aborted ops Child 3 - 2150 aborted ops Child 1 - 2400 aborted ops Child 2 - 2050 aborted ops Child 0 - 2050 aborted ops Child 3 - 2200 aborted ops Child 1 - 2450 aborted ops Child 3 - 2250 aborted ops Child 2 - 2100 aborted ops Child 0 - 2100 aborted ops Child 1 - 2500 aborted ops Child 2 - 2150 aborted ops Child 1 - 2550 aborted ops Child 0 - 2150 aborted ops Child 3 - 2300 aborted ops Child 2 - 2200 aborted ops Child 1 - 2600 aborted ops Child 2 - 2250 aborted ops Child 0 - 2200 aborted ops Child 3 - 2350 aborted ops Child 1 - 2650 aborted ops Child 2 - 2300 aborted ops Child 0 - 2250 aborted ops Child 2 - 2350 aborted ops Child 3 - 2400 aborted ops Child 0 - 2300 aborted ops Child 1 - 2700 aborted ops Child 2 - 2400 aborted ops Child 1 - 2750 aborted ops Child 1 - 2800 aborted ops Child 3 - 2450 aborted ops Child 0 - 2350 aborted ops Child 2 - 2450 aborted ops Child 0 - 2400 aborted ops Child 3 - 2500 aborted ops Child 0 - 2450 aborted ops Child 1 - 2850 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 21:35:27 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.0% 258352 258352 1 0.20 0.22 0.00 6.3% setattr 4.0% 4.0% 39920 39920 0 0.21 0.51 0.01 1.1% lookup 24.0% 24.1% 239324 239324 2 0.21 1.04 0.00 6.1% readlink 1.0% 1.0% 9959 9959 0 0.20 0.21 0.01 0.3% read 18.0% 18.1% 179750 221764 2 0.65 2.54 0.01 14.5% write 10.0% 10.0% 99665 120844 3 5.01 134.30 0.07 62.1% create 1.0% 1.0% 9947 9947 0 1.75 43.53 0.13 2.2% remove 1.0% 0.6% 5603 5603 0 0.23 0.12 0.01 0.2% readdir 1.0% 1.0% 10190 10190 0 0.51 0.11 0.01 0.6% fsstat 1.0% 1.0% 9907 9907 0 0.19 0.11 0.01 0.2% access 11.0% 11.0% 109472 109472 0 0.20 0.13 0.00 2.7% commit 0.0% 0.0% 0 59922 0 0.00 0.00 0.00 1.5% readdirplus 2.0% 2.0% 19903 19903 0 0.92 0.47 0.01 2.3% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 2883.69 Ops/Sec AVG. RESPONSE TIME: 0.81 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5300 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 991992 TEST TIME: 344 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1115107 PHYSICAL NFS V3 THROUGHPUT: 3241.59 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 21:35:27 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5300 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 21:35:27 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:35:27 2010 Completed. Tue Mar 30 21:35:27 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 21:35:28 2010 Received. Tue Mar 30 21:35:28 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 21:35:28 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5400 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 21:35:30 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 21:35:30 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 21:35:52 2010 Completed. Tue Mar 30 21:35:52 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:35:52 2010 Completed. Tue Mar 30 21:35:52 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:35:52 2010 Received. Tue Mar 30 21:35:52 2010 Initializing test directories. Tue Mar 30 21:35:52 2010 Child 0 will create 167 directories. Tue Mar 30 21:35:52 2010 Child 2 will create 167 directories. Tue Mar 30 21:35:52 2010 Child 3 will create 167 directories. Tue Mar 30 21:35:52 2010 Child 1 will create 167 directories. Tue Mar 30 21:35:54 2010 Child 0 finished creating 167 directories. Tue Mar 30 21:35:54 2010 Child 0 will create 5102 files. Tue Mar 30 21:36:03 2010 Child 1 finished creating 167 directories. Tue Mar 30 21:36:03 2010 Child 1 will create 5102 files. Tue Mar 30 21:36:04 2010 Child 0 verified 5102 files, created 48 Tue Mar 30 21:36:04 2010 Child 0 will create 6 symlinks. Tue Mar 30 21:36:04 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 21:36:06 2010 Child 2 finished creating 167 directories. Tue Mar 30 21:36:06 2010 Child 2 will create 5102 files. Tue Mar 30 21:36:09 2010 Child 3 finished creating 167 directories. Tue Mar 30 21:36:09 2010 Child 3 will create 5102 files. Tue Mar 30 21:36:12 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 21:36:12 2010 Child 3 will create 6 symlinks. Tue Mar 30 21:36:12 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 21:36:12 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 21:36:12 2010 Child 2 will create 6 symlinks. Tue Mar 30 21:36:12 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 21:36:15 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 21:36:15 2010 Child 1 will create 6 symlinks. Tue Mar 30 21:36:15 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 21:36:16 2010 Completed. Tue Mar 30 21:36:16 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:36:16 2010 Completed. Tue Mar 30 21:36:16 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:36:17 2010 Received. Tue Mar 30 21:36:17 2010 Performing 300 seconds pretest warmup. Child 1 - 50 aborted ops Child 1 - 100 aborted ops Child 3 - 50 aborted ops Child 1 - 150 aborted ops Child 3 - 100 aborted ops Child 1 - 200 aborted ops Child 0 - 50 aborted ops Child 1 - 250 aborted ops Child 2 - 50 aborted ops Child 3 - 150 aborted ops Child 0 - 100 aborted ops Child 2 - 100 aborted ops Child 3 - 200 aborted ops Child 2 - 150 aborted ops Child 2 - 200 aborted ops Child 1 - 300 aborted ops Child 3 - 250 aborted ops Child 0 - 150 aborted ops Child 2 - 250 aborted ops Child 1 - 350 aborted ops Child 3 - 300 aborted ops Child 2 - 300 aborted ops Child 0 - 200 aborted ops Child 1 - 400 aborted ops Child 3 - 350 aborted ops Child 2 - 350 aborted ops Child 3 - 400 aborted ops Child 1 - 450 aborted ops Child 0 - 250 aborted ops Child 2 - 400 aborted ops Child 3 - 450 aborted ops Child 0 - 300 aborted ops Child 1 - 500 aborted ops Child 2 - 450 aborted ops Child 3 - 500 aborted ops Child 1 - 550 aborted ops Child 2 - 500 aborted ops Child 3 - 550 aborted ops Child 0 - 350 aborted ops Child 1 - 600 aborted ops Child 3 - 600 aborted ops Child 2 - 550 aborted ops Child 3 - 650 aborted ops Child 1 - 650 aborted ops Child 0 - 400 aborted ops Child 2 - 600 aborted ops Child 1 - 700 aborted ops Child 3 - 700 aborted ops Child 0 - 450 aborted ops Child 2 - 650 aborted ops Child 1 - 750 aborted ops Child 3 - 750 aborted ops Child 0 - 500 aborted ops Child 2 - 700 aborted ops Child 3 - 800 aborted ops Child 1 - 800 aborted ops Child 1 - 850 aborted ops Child 2 - 750 aborted ops Child 0 - 550 aborted ops Child 3 - 850 aborted ops Child 1 - 900 aborted ops Child 2 - 800 aborted ops Child 3 - 900 aborted ops Child 0 - 600 aborted ops Child 3 - 950 aborted ops Child 2 - 850 aborted ops Child 3 - 1000 aborted ops Child 1 - 950 aborted ops Child 0 - 650 aborted ops Child 1 - 1000 aborted ops Child 3 - 1050 aborted ops Child 2 - 900 aborted ops Child 0 - 700 aborted ops Child 1 - 1050 aborted ops Child 3 - 1100 aborted ops Child 2 - 950 aborted ops Child 3 - 1150 aborted ops Child 1 - 1100 aborted ops Child 0 - 750 aborted ops Child 2 - 1000 aborted ops Child 3 - 1200 aborted ops Child 2 - 1050 aborted ops Child 0 - 800 aborted ops Child 1 - 1150 aborted ops Child 3 - 1250 aborted ops Child 0 - 850 aborted ops Child 1 - 1200 aborted ops Child 2 - 1100 aborted ops Child 0 - 900 aborted ops Child 3 - 1300 aborted ops Child 0 - 950 aborted ops Child 1 - 1250 aborted ops Child 2 - 1150 aborted ops Child 0 - 1000 aborted ops Child 1 - 1300 aborted ops Child 3 - 1350 aborted ops Child 2 - 1200 aborted ops Child 0 - 1050 aborted ops Child 1 - 1350 aborted ops Child 3 - 1400 aborted ops Child 0 - 1100 aborted ops Child 2 - 1250 aborted ops Child 3 - 1450 aborted ops Child 1 - 1400 aborted ops Child 0 - 1150 aborted ops Child 0 - 1200 aborted ops Child 2 - 1300 aborted ops Child 1 - 1450 aborted ops Child 3 - 1500 aborted ops Child 0 - 1250 aborted ops Child 1 - 1500 aborted ops Child 3 - 1550 aborted ops Child 2 - 1350 aborted ops Child 0 - 1300 aborted ops Child 1 - 1550 aborted ops Child 2 - 1400 aborted ops Child 3 - 1600 aborted ops Child 1 - 1600 aborted ops Child 1 - 1650 aborted ops Child 3 - 1650 aborted ops Child 2 - 1450 aborted ops Tue Mar 30 21:41:17 2010 Completed. Tue Mar 30 21:41:17 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:41:17 2010 Completed. Tue Mar 30 21:41:17 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:41:18 2010 Received. Tue Mar 30 21:41:18 2010 Starting 300 seconds test run. Child 0 - 1350 aborted ops Child 3 - 1700 aborted ops Child 1 - 1700 aborted ops Child 2 - 1500 aborted ops Child 3 - 1750 aborted ops Child 1 - 1750 aborted ops Child 2 - 1550 aborted ops Child 3 - 1800 aborted ops Child 0 - 1400 aborted ops Child 2 - 1600 aborted ops Child 3 - 1850 aborted ops Child 1 - 1800 aborted ops Child 3 - 1900 aborted ops Child 2 - 1650 aborted ops Child 0 - 1450 aborted ops Child 1 - 1850 aborted ops Child 1 - 1900 aborted ops Child 3 - 1950 aborted ops Child 2 - 1700 aborted ops Child 0 - 1500 aborted ops Child 1 - 1950 aborted ops Child 3 - 2000 aborted ops Child 2 - 1750 aborted ops Child 1 - 2000 aborted ops Child 3 - 2050 aborted ops Child 0 - 1550 aborted ops Child 2 - 1800 aborted ops Child 3 - 2100 aborted ops Child 1 - 2050 aborted ops Child 2 - 1850 aborted ops Child 3 - 2150 aborted ops Child 3 - 2200 aborted ops Child 2 - 1900 aborted ops Child 3 - 2250 aborted ops Child 1 - 2100 aborted ops Child 2 - 1950 aborted ops Child 0 - 1600 aborted ops Child 0 - 1650 aborted ops Child 3 - 2300 aborted ops Child 3 - 2350 aborted ops Child 0 - 1700 aborted ops Child 3 - 2400 aborted ops Child 1 - 2150 aborted ops Child 2 - 2000 aborted ops Child 3 - 2450 aborted ops Child 0 - 1750 aborted ops Child 2 - 2050 aborted ops Child 2 - 2100 aborted ops Child 0 - 1800 aborted ops Child 3 - 2500 aborted ops Child 1 - 2200 aborted ops Child 3 - 2550 aborted ops Child 2 - 2150 aborted ops Child 0 - 1850 aborted ops Child 3 - 2600 aborted ops Child 1 - 2250 aborted ops Child 0 - 1900 aborted ops Child 3 - 2650 aborted ops Child 2 - 2200 aborted ops Child 2 - 2250 aborted ops Child 0 - 1950 aborted ops Child 2 - 2300 aborted ops Child 3 - 2700 aborted ops Child 0 - 2000 aborted ops Child 3 - 2750 aborted ops Child 2 - 2350 aborted ops Child 1 - 2300 aborted ops Child 0 - 2050 aborted ops Child 3 - 2800 aborted ops Child 1 - 2350 aborted ops Child 2 - 2400 aborted ops Child 3 - 2850 aborted ops Child 0 - 2100 aborted ops Child 1 - 2400 aborted ops Child 2 - 2450 aborted ops Child 0 - 2150 aborted ops Child 2 - 2500 aborted ops Child 3 - 2900 aborted ops Child 1 - 2450 aborted ops Child 3 - 2950 aborted ops Child 2 - 2550 aborted ops Child 2 - 2600 aborted ops Child 1 - 2500 aborted ops Child 0 - 2200 aborted ops Child 1 - 2550 aborted ops Child 3 - 3000 aborted ops Child 1 - 2600 aborted ops Child 2 - 2650 aborted ops Child 1 - 2650 aborted ops Child 3 - 3050 aborted ops Child 2 - 2700 aborted ops Child 0 - 2250 aborted ops Child 1 - 2700 aborted ops Child 0 - 2300 aborted ops Child 3 - 3100 aborted ops Child 0 - 2350 aborted ops Child 2 - 2750 aborted ops Child 1 - 2750 aborted ops Child 0 - 2400 aborted ops Child 3 - 3150 aborted ops Child 2 - 2800 aborted ops Child 1 - 2800 aborted ops Child 3 - 3200 aborted ops Child 0 - 2450 aborted ops Child 0 - 2500 aborted ops Child 0 - 2550 aborted ops Child 3 - 3250 aborted ops Child 1 - 2850 aborted ops Child 2 - 2850 aborted ops Child 0 - 2600 aborted ops Child 1 - 2900 aborted ops Child 3 - 3300 aborted ops Child 2 - 2900 aborted ops Child 0 - 2650 aborted ops Child 2 - 2950 aborted ops Child 3 - 3350 aborted ops Child 1 - 2950 aborted ops Child 0 - 2700 aborted ops Child 2 - 3000 aborted ops Child 2 - 3050 aborted ops Child 0 - 2750 aborted ops Child 1 - 3000 aborted ops Child 3 - 3400 aborted ops Child 1 - 3050 aborted ops Child 0 - 2800 aborted ops Child 2 - 3100 aborted ops Child 3 - 3450 aborted ops Child 1 - 3100 aborted ops Child 2 - 3150 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 21:46:32 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 389191 389191 0 0.19 0.37 0.00 5.4% setattr 4.0% 4.0% 59822 59822 0 0.21 1.14 0.01 0.9% lookup 24.0% 24.1% 358932 358932 0 0.20 0.91 0.00 5.2% readlink 1.0% 1.0% 14923 14923 0 0.19 0.19 0.01 0.2% read 18.0% 18.0% 268626 330333 0 0.72 4.72 0.01 14.3% write 10.0% 10.0% 149391 180299 0 5.80 124.73 0.06 64.5% create 1.0% 1.0% 14829 14829 0 2.65 63.77 0.13 2.9% remove 1.0% 0.6% 8420 8420 0 0.22 0.16 0.01 0.1% readdir 1.0% 1.0% 15021 15021 0 0.50 0.11 0.01 0.6% fsstat 1.0% 1.0% 14758 14758 0 0.19 0.22 0.01 0.2% access 11.0% 11.1% 164664 164664 0 0.19 0.26 0.00 2.3% commit 0.0% 0.0% 0 89918 0 0.00 0.00 0.00 1.3% readdirplus 2.0% 2.0% 29907 29907 0 0.91 0.27 0.01 2.0% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4928.75 Ops/Sec AVG. RESPONSE TIME: 0.90 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5400 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1488484 TEST TIME: 302 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1671017 PHYSICAL NFS V3 THROUGHPUT: 5533.16 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 21:46:32 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5400 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 21:46:32 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:46:32 2010 Completed. Tue Mar 30 21:46:32 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 21:46:32 2010 Received. Tue Mar 30 21:46:32 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 21:46:32 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5500 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 21:46:34 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 21:46:34 2010 Mounting 4 remote test directories. Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Child[000]: NFS negotiated block size 32768 Tue Mar 30 21:46:50 2010 Completed. Tue Mar 30 21:46:50 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:46:50 2010 Completed. Tue Mar 30 21:46:50 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:46:50 2010 Received. Tue Mar 30 21:46:50 2010 Initializing test directories. Tue Mar 30 21:46:50 2010 Child 2 will create 167 directories. Tue Mar 30 21:46:50 2010 Child 3 will create 167 directories. Tue Mar 30 21:46:50 2010 Child 1 will create 167 directories. Tue Mar 30 21:46:50 2010 Child 0 will create 167 directories. Tue Mar 30 21:46:52 2010 Child 2 finished creating 167 directories. Tue Mar 30 21:46:52 2010 Child 2 will create 5102 files. Tue Mar 30 21:46:52 2010 Child 0 finished creating 167 directories. Tue Mar 30 21:46:52 2010 Child 0 will create 5102 files. Tue Mar 30 21:46:55 2010 Child 3 finished creating 167 directories. Tue Mar 30 21:46:55 2010 Child 3 will create 5102 files. Tue Mar 30 21:47:06 2010 Child 1 finished creating 167 directories. Tue Mar 30 21:47:06 2010 Child 1 will create 5102 files. Tue Mar 30 21:47:16 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 21:47:16 2010 Child 2 will create 6 symlinks. Tue Mar 30 21:47:16 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 21:47:18 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 21:47:18 2010 Child 0 will create 6 symlinks. Tue Mar 30 21:47:18 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 21:47:21 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 21:47:21 2010 Child 3 will create 6 symlinks. Tue Mar 30 21:47:21 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 21:47:26 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 21:47:26 2010 Child 1 will create 6 symlinks. Tue Mar 30 21:47:26 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 21:47:26 2010 Completed. Tue Mar 30 21:47:26 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:47:26 2010 Completed. Tue Mar 30 21:47:26 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:47:27 2010 Received. Tue Mar 30 21:47:27 2010 Performing 300 seconds pretest warmup. Child 3 - 50 aborted ops Child 2 - 50 aborted ops Child 3 - 100 aborted ops Child 1 - 50 aborted ops Child 3 - 150 aborted ops Child 2 - 100 aborted ops Child 1 - 100 aborted ops Child 3 - 200 aborted ops Child 2 - 150 aborted ops Child 1 - 150 aborted ops Child 3 - 250 aborted ops Child 0 - 50 aborted ops Child 1 - 200 aborted ops Child 2 - 200 aborted ops Child 0 - 100 aborted ops Child 3 - 300 aborted ops Child 1 - 250 aborted ops Child 0 - 150 aborted ops Child 3 - 350 aborted ops Child 2 - 250 aborted ops Child 1 - 300 aborted ops Child 3 - 400 aborted ops Child 0 - 200 aborted ops Child 2 - 300 aborted ops Child 1 - 350 aborted ops Child 0 - 250 aborted ops Child 3 - 450 aborted ops Child 2 - 350 aborted ops Child 0 - 300 aborted ops Child 3 - 500 aborted ops Child 2 - 400 aborted ops Child 0 - 350 aborted ops Child 1 - 400 aborted ops Child 2 - 450 aborted ops Child 3 - 550 aborted ops Child 0 - 400 aborted ops Child 1 - 450 aborted ops Child 3 - 600 aborted ops Child 2 - 500 aborted ops Child 0 - 450 aborted ops Child 3 - 650 aborted ops Child 1 - 500 aborted ops Child 1 - 550 aborted ops Child 2 - 550 aborted ops Child 3 - 700 aborted ops Child 0 - 500 aborted ops Child 2 - 600 aborted ops Child 1 - 600 aborted ops Child 2 - 650 aborted ops Child 3 - 750 aborted ops Child 3 - 800 aborted ops Child 1 - 650 aborted ops Child 2 - 700 aborted ops Child 1 - 700 aborted ops Child 3 - 850 aborted ops Child 0 - 550 aborted ops Child 2 - 750 aborted ops Child 1 - 750 aborted ops Child 1 - 800 aborted ops Child 3 - 900 aborted ops Child 2 - 800 aborted ops Child 0 - 600 aborted ops Child 3 - 950 aborted ops Child 1 - 850 aborted ops Child 2 - 850 aborted ops Child 0 - 650 aborted ops Child 1 - 900 aborted ops Child 0 - 700 aborted ops Child 2 - 900 aborted ops Child 3 - 1000 aborted ops Child 1 - 950 aborted ops Child 1 - 1000 aborted ops Child 2 - 950 aborted ops Child 3 - 1050 aborted ops Child 1 - 1050 aborted ops Child 3 - 1100 aborted ops Child 1 - 1100 aborted ops Child 3 - 1150 aborted ops Child 0 - 750 aborted ops Child 2 - 1000 aborted ops Child 3 - 1200 aborted ops Child 1 - 1150 aborted ops Child 2 - 1050 aborted ops Child 3 - 1250 aborted ops Child 0 - 800 aborted ops Child 3 - 1300 aborted ops Child 2 - 1100 aborted ops Child 0 - 850 aborted ops Child 1 - 1200 aborted ops Child 3 - 1350 aborted ops Child 0 - 900 aborted ops Child 2 - 1150 aborted ops Child 1 - 1250 aborted ops Child 0 - 950 aborted ops Child 2 - 1200 aborted ops Child 3 - 1400 aborted ops Child 0 - 1000 aborted ops Child 0 - 1050 aborted ops Child 2 - 1250 aborted ops Child 2 - 1300 aborted ops Child 1 - 1300 aborted ops Child 3 - 1450 aborted ops Child 0 - 1100 aborted ops Child 1 - 1350 aborted ops Child 0 - 1150 aborted ops Child 3 - 1500 aborted ops Child 2 - 1350 aborted ops Child 0 - 1200 aborted ops Child 1 - 1400 aborted ops Child 3 - 1550 aborted ops Tue Mar 30 21:52:27 2010 Completed. Tue Mar 30 21:52:27 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:52:27 2010 Completed. Tue Mar 30 21:52:27 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:52:28 2010 Received. Tue Mar 30 21:52:28 2010 Starting 300 seconds test run. Child 0 - 1250 aborted ops Child 3 - 1600 aborted ops Child 1 - 1450 aborted ops Child 1 - 1500 aborted ops Child 2 - 1400 aborted ops Child 0 - 1300 aborted ops Child 0 - 1350 aborted ops Child 2 - 1450 aborted ops Child 2 - 1500 aborted ops Child 2 - 1550 aborted ops Child 3 - 1650 aborted ops Child 0 - 1400 aborted ops Child 1 - 1550 aborted ops Child 0 - 1450 aborted ops Child 2 - 1600 aborted ops Child 2 - 1650 aborted ops Child 2 - 1700 aborted ops Child 3 - 1700 aborted ops Child 0 - 1500 aborted ops Child 0 - 1550 aborted ops Child 2 - 1750 aborted ops Child 1 - 1600 aborted ops Child 3 - 1750 aborted ops Child 0 - 1600 aborted ops Child 1 - 1650 aborted ops Child 0 - 1650 aborted ops Child 3 - 1800 aborted ops Child 1 - 1700 aborted ops Child 0 - 1700 aborted ops Child 2 - 1800 aborted ops Child 3 - 1850 aborted ops Child 3 - 1900 aborted ops Child 1 - 1750 aborted ops Child 2 - 1850 aborted ops Child 2 - 1900 aborted ops Child 0 - 1750 aborted ops Child 2 - 1950 aborted ops Child 3 - 1950 aborted ops Child 0 - 1800 aborted ops Child 1 - 1800 aborted ops Child 2 - 2000 aborted ops Child 3 - 2000 aborted ops Child 2 - 2050 aborted ops Child 0 - 1850 aborted ops Child 3 - 2050 aborted ops Child 1 - 1850 aborted ops Child 2 - 2100 aborted ops Child 3 - 2100 aborted ops Child 0 - 1900 aborted ops Child 1 - 1900 aborted ops Child 1 - 1950 aborted ops Child 1 - 2000 aborted ops Child 3 - 2150 aborted ops Child 2 - 2150 aborted ops Child 0 - 1950 aborted ops Child 2 - 2200 aborted ops Child 2 - 2250 aborted ops Child 3 - 2200 aborted ops Child 2 - 2300 aborted ops Child 1 - 2050 aborted ops Child 2 - 2350 aborted ops Child 0 - 2000 aborted ops Child 3 - 2250 aborted ops Child 0 - 2050 aborted ops Child 3 - 2300 aborted ops Child 0 - 2100 aborted ops Child 2 - 2400 aborted ops Child 1 - 2100 aborted ops Child 3 - 2350 aborted ops Child 0 - 2150 aborted ops Child 0 - 2200 aborted ops Child 3 - 2400 aborted ops Child 2 - 2450 aborted ops Child 0 - 2250 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 21:58:44 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.0% 212554 212554 1 0.21 11.60 0.01 4.2% setattr 4.0% 4.0% 32746 32746 0 0.20 1.00 0.01 0.6% lookup 24.0% 24.2% 197858 197858 0 0.19 0.35 0.00 3.5% readlink 1.0% 1.0% 8294 8294 0 0.18 0.10 0.01 0.1% read 18.0% 18.1% 147893 181993 1 1.15 6.37 0.01 15.9% write 10.0% 10.0% 81849 98776 4 9.20 291.67 0.12 70.4% create 1.0% 1.0% 8135 8135 0 1.04 23.60 0.11 0.8% remove 1.0% 0.6% 4510 4510 0 0.22 0.32 0.02 0.1% readdir 1.0% 1.0% 8095 8095 0 0.48 0.21 0.01 0.4% fsstat 1.0% 1.0% 8338 8338 0 0.18 0.38 0.01 0.1% access 11.0% 11.2% 91288 91288 0 0.18 0.47 0.00 1.6% commit 0.0% 0.0% 0 49251 0 0.00 0.00 0.00 0.8% readdirplus 2.0% 2.0% 16325 16325 1 0.88 0.27 0.01 1.3% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 2343.51 Ops/Sec AVG. RESPONSE TIME: 1.30 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5500 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 817885 TEST TIME: 349 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 918163 PHYSICAL NFS V3 THROUGHPUT: 2630.83 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 21:58:44 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5500 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 21:58:44 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:58:44 2010 Completed. Tue Mar 30 21:58:44 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 21:58:44 2010 Received. Tue Mar 30 21:58:44 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 21:58:44 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5600 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 21:58:46 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 21:58:46 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Tue Mar 30 21:59:02 2010 Completed. Tue Mar 30 21:59:02 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:59:02 2010 Completed. Tue Mar 30 21:59:02 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:59:02 2010 Received. Tue Mar 30 21:59:02 2010 Initializing test directories. Tue Mar 30 21:59:02 2010 Child 1 will create 167 directories. Tue Mar 30 21:59:02 2010 Child 3 will create 167 directories. Tue Mar 30 21:59:02 2010 Child 0 will create 167 directories. Tue Mar 30 21:59:02 2010 Child 2 will create 167 directories. Tue Mar 30 21:59:07 2010 Child 1 finished creating 167 directories. Tue Mar 30 21:59:07 2010 Child 1 will create 5102 files. Tue Mar 30 21:59:09 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 21:59:09 2010 Child 1 will create 6 symlinks. Tue Mar 30 21:59:09 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 21:59:10 2010 Child 2 finished creating 167 directories. Tue Mar 30 21:59:10 2010 Child 2 will create 5102 files. Tue Mar 30 21:59:12 2010 Child 2 verified 5102 files, created 48 Tue Mar 30 21:59:12 2010 Child 2 will create 6 symlinks. Tue Mar 30 21:59:12 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 21:59:12 2010 Child 3 finished creating 167 directories. Tue Mar 30 21:59:12 2010 Child 3 will create 5102 files. Tue Mar 30 21:59:15 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 21:59:15 2010 Child 3 will create 6 symlinks. Tue Mar 30 21:59:15 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 21:59:17 2010 Child 0 finished creating 167 directories. Tue Mar 30 21:59:17 2010 Child 0 will create 5102 files. Tue Mar 30 21:59:22 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 21:59:22 2010 Child 0 will create 6 symlinks. Tue Mar 30 21:59:22 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 21:59:22 2010 Completed. Tue Mar 30 21:59:22 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:59:22 2010 Completed. Tue Mar 30 21:59:22 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 21:59:23 2010 Received. Tue Mar 30 21:59:23 2010 Performing 300 seconds pretest warmup. Child 3 - 50 aborted ops Child 3 - 100 aborted ops Child 0 - 50 aborted ops Child 0 - 100 aborted ops Child 3 - 150 aborted ops Child 0 - 150 aborted ops Child 3 - 200 aborted ops Child 2 - 50 aborted ops Child 0 - 200 aborted ops Child 3 - 250 aborted ops Child 2 - 100 aborted ops Child 0 - 250 aborted ops Child 1 - 50 aborted ops Child 3 - 300 aborted ops Child 0 - 300 aborted ops Child 3 - 350 aborted ops Child 1 - 100 aborted ops Child 2 - 150 aborted ops Child 0 - 350 aborted ops Child 3 - 400 aborted ops Child 3 - 450 aborted ops Child 0 - 400 aborted ops Child 3 - 500 aborted ops Child 1 - 150 aborted ops Child 2 - 200 aborted ops Child 3 - 550 aborted ops Child 1 - 200 aborted ops Child 0 - 450 aborted ops Child 2 - 250 aborted ops Child 1 - 250 aborted ops Child 0 - 500 aborted ops Child 3 - 600 aborted ops Child 2 - 300 aborted ops Child 3 - 650 aborted ops Child 1 - 300 aborted ops Child 0 - 550 aborted ops Child 3 - 700 aborted ops Child 2 - 350 aborted ops Child 0 - 600 aborted ops Child 1 - 350 aborted ops Child 3 - 750 aborted ops Child 2 - 400 aborted ops Child 0 - 650 aborted ops Child 0 - 700 aborted ops Child 3 - 800 aborted ops Child 1 - 400 aborted ops Child 2 - 450 aborted ops Child 0 - 750 aborted ops Child 3 - 850 aborted ops Child 2 - 500 aborted ops Child 1 - 450 aborted ops Child 0 - 800 aborted ops Child 2 - 550 aborted ops Child 3 - 900 aborted ops Child 0 - 850 aborted ops Child 0 - 900 aborted ops Child 1 - 500 aborted ops Child 2 - 600 aborted ops Child 3 - 950 aborted ops Child 0 - 950 aborted ops Child 2 - 650 aborted ops Child 1 - 550 aborted ops Child 0 - 1000 aborted ops Child 3 - 1000 aborted ops Child 2 - 700 aborted ops Child 1 - 600 aborted ops Child 0 - 1050 aborted ops Child 3 - 1050 aborted ops Child 1 - 650 aborted ops Child 2 - 750 aborted ops Child 0 - 1100 aborted ops Child 1 - 700 aborted ops Child 3 - 1100 aborted ops Child 2 - 800 aborted ops Child 0 - 1150 aborted ops Child 1 - 750 aborted ops Child 3 - 1150 aborted ops Child 2 - 850 aborted ops Child 1 - 800 aborted ops Child 0 - 1200 aborted ops Child 1 - 850 aborted ops Tue Mar 30 22:04:23 2010 Completed. Tue Mar 30 22:04:23 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:04:23 2010 Completed. Tue Mar 30 22:04:23 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:04:24 2010 Received. Tue Mar 30 22:04:24 2010 Starting 300 seconds test run. Child 2 - 900 aborted ops Child 3 - 1200 aborted ops Child 0 - 1250 aborted ops Child 1 - 900 aborted ops Child 2 - 950 aborted ops Child 3 - 1250 aborted ops Child 1 - 950 aborted ops Child 0 - 1300 aborted ops Child 2 - 1000 aborted ops Child 3 - 1300 aborted ops Child 2 - 1050 aborted ops Child 0 - 1350 aborted ops Child 1 - 1000 aborted ops Child 2 - 1100 aborted ops Child 3 - 1350 aborted ops Child 0 - 1400 aborted ops Child 2 - 1150 aborted ops Child 3 - 1400 aborted ops Child 1 - 1050 aborted ops Child 2 - 1200 aborted ops Child 0 - 1450 aborted ops Child 1 - 1100 aborted ops Child 1 - 1150 aborted ops Child 2 - 1250 aborted ops Child 0 - 1500 aborted ops Child 3 - 1450 aborted ops Child 3 - 1500 aborted ops Child 3 - 1550 aborted ops Child 3 - 1600 aborted ops Child 1 - 1200 aborted ops Child 2 - 1300 aborted ops Child 0 - 1550 aborted ops Child 2 - 1350 aborted ops Child 1 - 1250 aborted ops Child 2 - 1400 aborted ops Child 0 - 1600 aborted ops Child 3 - 1650 aborted ops Child 3 - 1700 aborted ops Child 1 - 1300 aborted ops Child 2 - 1450 aborted ops Child 0 - 1650 aborted ops Child 1 - 1350 aborted ops Child 2 - 1500 aborted ops Child 3 - 1750 aborted ops Child 1 - 1400 aborted ops Child 0 - 1700 aborted ops Child 2 - 1550 aborted ops Child 3 - 1800 aborted ops Child 0 - 1750 aborted ops Child 1 - 1450 aborted ops Child 2 - 1600 aborted ops Child 1 - 1500 aborted ops Child 2 - 1650 aborted ops Child 1 - 1550 aborted ops Child 2 - 1700 aborted ops Child 0 - 1800 aborted ops Child 3 - 1850 aborted ops Child 0 - 1850 aborted ops Child 3 - 1900 aborted ops Child 0 - 1900 aborted ops Child 3 - 1950 aborted ops Child 0 - 1950 aborted ops Child 2 - 1750 aborted ops Child 1 - 1600 aborted ops Child 2 - 1800 aborted ops Child 1 - 1650 aborted ops Child 3 - 2000 aborted ops Child 2 - 1850 aborted ops Child 2 - 1900 aborted ops Child 0 - 2000 aborted ops Child 3 - 2050 aborted ops Child 1 - 1700 aborted ops Child 0 - 2050 aborted ops Child 1 - 1750 aborted ops Child 3 - 2100 aborted ops Child 2 - 1950 aborted ops Child 1 - 1800 aborted ops Child 0 - 2100 aborted ops Child 2 - 2000 aborted ops Child 2 - 2050 aborted ops Child 1 - 1850 aborted ops Child 0 - 2150 aborted ops Child 3 - 2150 aborted ops Child 2 - 2100 aborted ops Child 3 - 2200 aborted ops Child 0 - 2200 aborted ops Child 1 - 1900 aborted ops Child 2 - 2150 aborted ops Child 3 - 2250 aborted ops Child 1 - 1950 aborted ops Child 2 - 2200 aborted ops Child 3 - 2300 aborted ops Child 0 - 2250 aborted ops Child 3 - 2350 aborted ops Child 0 - 2300 aborted ops Child 2 - 2250 aborted ops Child 3 - 2400 aborted ops Child 1 - 2000 aborted ops Child 2 - 2300 aborted ops Child 0 - 2350 aborted ops Child 2 - 2350 aborted ops Child 0 - 2400 aborted ops Child 3 - 2450 aborted ops Child 2 - 2400 aborted ops Child 1 - 2050 aborted ops Child 0 - 2450 aborted ops Child 1 - 2100 aborted ops Child 0 - 2500 aborted ops Child 1 - 2150 aborted ops Child 3 - 2500 aborted ops Child 2 - 2450 aborted ops Child 3 - 2550 aborted ops Child 2 - 2500 aborted ops Child 0 - 2550 aborted ops Child 1 - 2200 aborted ops Child 1 - 2250 aborted ops Child 0 - 2600 aborted ops Child 1 - 2300 aborted ops Child 0 - 2650 aborted ops Child 2 - 2550 aborted ops Child 0 - 2700 aborted ops Child 3 - 2600 aborted ops Child 1 - 2350 aborted ops Child 1 - 2400 aborted ops Child 1 - 2450 aborted ops Child 3 - 2650 aborted ops Child 2 - 2600 aborted ops Child 0 - 2750 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 22:09:35 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.2% 377942 377942 0 0.19 0.80 0.00 5.9% setattr 4.0% 4.0% 57713 57713 0 0.22 4.24 0.02 1.1% lookup 24.0% 24.1% 348789 348789 0 0.19 0.35 0.00 5.6% readlink 1.0% 1.0% 14267 14267 0 0.20 0.51 0.01 0.2% read 18.0% 18.0% 260503 319944 0 0.54 1.41 0.00 11.7% write 10.0% 10.1% 145266 175765 0 5.41 86.19 0.05 65.7% create 1.0% 1.0% 14706 14706 0 2.29 55.58 0.12 2.8% remove 1.0% 0.6% 8251 8251 0 0.22 0.29 0.01 0.2% readdir 1.0% 1.0% 14512 14512 0 0.49 0.27 0.01 0.6% fsstat 1.0% 1.0% 14370 14370 0 0.18 0.13 0.01 0.2% access 11.0% 11.0% 159415 159415 0 0.19 0.63 0.00 2.5% commit 0.0% 0.0% 0 87477 0 0.00 0.00 0.00 1.4% readdirplus 2.0% 2.0% 28670 28670 0 0.90 0.50 0.01 2.2% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 4814.68 Ops/Sec AVG. RESPONSE TIME: 0.82 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5600 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1444404 TEST TIME: 300 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1621821 PHYSICAL NFS V3 THROUGHPUT: 5406.07 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 22:09:35 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5600 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 22:09:35 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:09:35 2010 Completed. Tue Mar 30 22:09:35 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 22:09:35 2010 Received. Tue Mar 30 22:09:35 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 22:09:35 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5700 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 22:09:37 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 22:09:37 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 22:09:48 2010 Completed. Tue Mar 30 22:09:48 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:09:48 2010 Completed. Tue Mar 30 22:09:48 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:09:53 2010 Received. Tue Mar 30 22:09:53 2010 Initializing test directories. Tue Mar 30 22:09:53 2010 Child 3 will create 167 directories. Tue Mar 30 22:09:53 2010 Child 1 will create 167 directories. Tue Mar 30 22:09:53 2010 Child 2 will create 167 directories. Tue Mar 30 22:09:53 2010 Child 0 will create 167 directories. Tue Mar 30 22:10:03 2010 Child 1 finished creating 167 directories. Tue Mar 30 22:10:03 2010 Child 1 will create 5102 files. Tue Mar 30 22:10:06 2010 Child 2 finished creating 167 directories. Tue Mar 30 22:10:06 2010 Child 2 will create 5102 files. Tue Mar 30 22:10:07 2010 Child 1 verified 5102 files, created 49 Tue Mar 30 22:10:07 2010 Child 1 will create 6 symlinks. Tue Mar 30 22:10:07 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 22:10:07 2010 Child 0 finished creating 167 directories. Tue Mar 30 22:10:07 2010 Child 0 will create 5102 files. Tue Mar 30 22:10:09 2010 Child 3 finished creating 167 directories. Tue Mar 30 22:10:09 2010 Child 3 will create 5102 files. Tue Mar 30 22:10:12 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 22:10:12 2010 Child 3 will create 6 symlinks. Tue Mar 30 22:10:12 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 22:10:20 2010 Child 2 verified 5102 files, created 48 Tue Mar 30 22:10:20 2010 Child 2 will create 6 symlinks. Tue Mar 30 22:10:20 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 22:10:22 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 22:10:22 2010 Child 0 will create 6 symlinks. Tue Mar 30 22:10:22 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 22:10:23 2010 Completed. Tue Mar 30 22:10:23 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:10:23 2010 Completed. Tue Mar 30 22:10:23 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:10:24 2010 Received. Tue Mar 30 22:10:24 2010 Performing 300 seconds pretest warmup. Child 3 - 50 aborted ops Child 2 - 50 aborted ops Child 3 - 100 aborted ops Child 2 - 100 aborted ops Child 3 - 150 aborted ops Child 2 - 150 aborted ops Child 0 - 50 aborted ops Child 1 - 50 aborted ops Child 2 - 200 aborted ops Child 0 - 100 aborted ops Child 1 - 100 aborted ops Child 0 - 150 aborted ops Child 2 - 250 aborted ops Child 3 - 200 aborted ops Child 1 - 150 aborted ops Child 2 - 300 aborted ops Child 0 - 200 aborted ops Child 3 - 250 aborted ops Child 1 - 200 aborted ops Child 2 - 350 aborted ops Child 3 - 300 aborted ops Child 1 - 250 aborted ops Child 0 - 250 aborted ops Child 3 - 350 aborted ops Child 2 - 400 aborted ops Child 0 - 300 aborted ops Child 2 - 450 aborted ops Child 1 - 300 aborted ops Child 3 - 400 aborted ops Child 1 - 350 aborted ops Child 0 - 350 aborted ops Child 3 - 450 aborted ops Child 2 - 500 aborted ops Child 1 - 400 aborted ops Child 3 - 500 aborted ops Child 2 - 550 aborted ops Child 0 - 400 aborted ops Child 2 - 600 aborted ops Child 1 - 450 aborted ops Child 0 - 450 aborted ops Child 3 - 550 aborted ops Child 2 - 650 aborted ops Child 0 - 500 aborted ops Child 1 - 500 aborted ops Child 3 - 600 aborted ops Child 1 - 550 aborted ops Child 2 - 700 aborted ops Child 0 - 550 aborted ops Child 3 - 650 aborted ops Child 2 - 750 aborted ops Child 0 - 600 aborted ops Child 1 - 600 aborted ops Child 0 - 650 aborted ops Child 3 - 700 aborted ops Child 2 - 800 aborted ops Child 1 - 650 aborted ops Child 3 - 750 aborted ops Child 0 - 700 aborted ops Child 1 - 700 aborted ops Child 3 - 800 aborted ops Child 0 - 750 aborted ops Child 1 - 750 aborted ops Child 3 - 850 aborted ops Child 0 - 800 aborted ops Child 1 - 800 aborted ops Child 0 - 850 aborted ops Child 3 - 900 aborted ops Child 0 - 900 aborted ops Child 2 - 850 aborted ops Child 1 - 850 aborted ops Child 3 - 950 aborted ops Child 0 - 950 aborted ops Child 3 - 1000 aborted ops Child 2 - 900 aborted ops Child 1 - 900 aborted ops Child 0 - 1000 aborted ops Child 1 - 950 aborted ops Child 3 - 1050 aborted ops Child 2 - 950 aborted ops Child 3 - 1100 aborted ops Child 0 - 1050 aborted ops Child 2 - 1000 aborted ops Child 3 - 1150 aborted ops Child 2 - 1050 aborted ops Child 0 - 1100 aborted ops Child 1 - 1000 aborted ops Child 2 - 1100 aborted ops Child 0 - 1150 aborted ops Child 3 - 1200 aborted ops Child 0 - 1200 aborted ops Child 3 - 1250 aborted ops Child 3 - 1300 aborted ops Child 2 - 1150 aborted ops Child 3 - 1350 aborted ops Child 0 - 1250 aborted ops Child 1 - 1050 aborted ops Child 0 - 1300 aborted ops Child 0 - 1350 aborted ops Child 3 - 1400 aborted ops Child 1 - 1100 aborted ops Child 0 - 1400 aborted ops Child 2 - 1200 aborted ops Child 3 - 1450 aborted ops Child 0 - 1450 aborted ops Child 1 - 1150 aborted ops Child 0 - 1500 aborted ops Child 0 - 1550 aborted ops Child 0 - 1600 aborted ops Child 1 - 1200 aborted ops Child 2 - 1250 aborted ops Child 3 - 1500 aborted ops Child 2 - 1300 aborted ops Child 0 - 1650 aborted ops Child 2 - 1350 aborted ops Child 1 - 1250 aborted ops Child 3 - 1550 aborted ops Child 1 - 1300 aborted ops Child 0 - 1700 aborted ops Tue Mar 30 22:15:24 2010 Completed. Tue Mar 30 22:15:24 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:15:24 2010 Completed. Tue Mar 30 22:15:24 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:15:25 2010 Received. Tue Mar 30 22:15:25 2010 Starting 300 seconds test run. Child 2 - 1400 aborted ops Child 1 - 1350 aborted ops Child 0 - 1750 aborted ops Child 3 - 1600 aborted ops Child 3 - 1650 aborted ops Child 2 - 1450 aborted ops Child 0 - 1800 aborted ops Child 3 - 1700 aborted ops Child 3 - 1750 aborted ops Child 3 - 1800 aborted ops Child 0 - 1850 aborted ops Child 1 - 1400 aborted ops Child 2 - 1500 aborted ops Child 1 - 1450 aborted ops Child 0 - 1900 aborted ops Child 3 - 1850 aborted ops Child 3 - 1900 aborted ops Child 3 - 1950 aborted ops Child 2 - 1550 aborted ops Child 1 - 1500 aborted ops Child 0 - 1950 aborted ops Child 3 - 2000 aborted ops Child 1 - 1550 aborted ops Child 0 - 2000 aborted ops Child 3 - 2050 aborted ops Child 2 - 1600 aborted ops Child 0 - 2050 aborted ops Child 1 - 1600 aborted ops Child 2 - 1650 aborted ops Child 3 - 2100 aborted ops Child 2 - 1700 aborted ops Child 1 - 1650 aborted ops Child 0 - 2100 aborted ops Child 2 - 1750 aborted ops Child 3 - 2150 aborted ops Child 2 - 1800 aborted ops Child 0 - 2150 aborted ops Child 0 - 2200 aborted ops Child 1 - 1700 aborted ops Child 3 - 2200 aborted ops Child 2 - 1850 aborted ops Child 1 - 1750 aborted ops Child 0 - 2250 aborted ops Child 2 - 1900 aborted ops Child 0 - 2300 aborted ops Child 3 - 2250 aborted ops Child 0 - 2350 aborted ops Child 2 - 1950 aborted ops Child 3 - 2300 aborted ops Child 2 - 2000 aborted ops Child 1 - 1800 aborted ops Child 0 - 2400 aborted ops Child 2 - 2050 aborted ops Child 0 - 2450 aborted ops Child 1 - 1850 aborted ops Child 2 - 2100 aborted ops Child 3 - 2350 aborted ops Child 0 - 2500 aborted ops Child 2 - 2150 aborted ops Child 1 - 1900 aborted ops Child 3 - 2400 aborted ops Child 1 - 1950 aborted ops Child 0 - 2550 aborted ops Child 3 - 2450 aborted ops Child 0 - 2600 aborted ops Child 1 - 2000 aborted ops Child 0 - 2650 aborted ops Child 3 - 2500 aborted ops Child 1 - 2050 aborted ops Child 2 - 2200 aborted ops Child 0 - 2700 aborted ops Child 1 - 2100 aborted ops Child 2 - 2250 aborted ops Child 3 - 2550 aborted ops Child 0 - 2750 aborted ops Child 3 - 2600 aborted ops Child 2 - 2300 aborted ops Child 0 - 2800 aborted ops Child 2 - 2350 aborted ops Child 1 - 2150 aborted ops Child 3 - 2650 aborted ops Child 0 - 2850 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 22:21:31 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.0% 237356 237356 1 0.21 6.41 0.01 5.2% setattr 4.0% 4.1% 37027 37027 0 0.29 11.64 0.03 1.1% lookup 24.0% 24.2% 220376 220376 0 1.12 248.31 0.07 25.8% readlink 1.0% 1.0% 9107 9107 0 0.20 0.26 0.01 0.2% read 18.0% 18.1% 165228 203714 4 0.55 1.25 0.01 9.5% write 10.0% 10.0% 91240 110270 1 5.36 137.76 0.08 51.3% create 1.0% 1.0% 9168 9168 0 1.23 28.42 0.11 1.2% remove 1.0% 0.6% 5171 5171 0 0.23 0.12 0.01 0.1% readdir 1.0% 1.0% 9216 9216 1 0.50 0.11 0.01 0.5% fsstat 1.0% 1.0% 9084 9084 0 0.19 0.12 0.01 0.2% access 11.0% 11.0% 100109 100109 1 0.20 0.20 0.00 2.1% commit 0.0% 0.0% 0 54889 0 0.00 0.00 0.00 1.1% readdirplus 2.0% 2.0% 18275 18275 1 0.91 0.13 0.01 1.7% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 2581.74 Ops/Sec AVG. RESPONSE TIME: 1.04 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5700 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 911357 TEST TIME: 353 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1023762 PHYSICAL NFS V3 THROUGHPUT: 2900.17 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 22:21:31 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5700 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 22:21:31 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:21:31 2010 Completed. Tue Mar 30 22:21:31 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 22:21:31 2010 Received. Tue Mar 30 22:21:31 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 22:21:31 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5800 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 22:21:33 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 22:21:33 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 22:21:44 2010 Completed. Tue Mar 30 22:21:44 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:21:44 2010 Completed. Tue Mar 30 22:21:44 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:21:49 2010 Received. Tue Mar 30 22:21:49 2010 Initializing test directories. Tue Mar 30 22:21:49 2010 Child 2 will create 167 directories. Tue Mar 30 22:21:49 2010 Child 1 will create 167 directories. Tue Mar 30 22:21:49 2010 Child 3 will create 167 directories. Tue Mar 30 22:21:49 2010 Child 0 will create 167 directories. Tue Mar 30 22:21:50 2010 Child 2 finished creating 167 directories. Tue Mar 30 22:21:50 2010 Child 2 will create 5102 files. Tue Mar 30 22:21:53 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 22:21:53 2010 Child 2 will create 6 symlinks. Tue Mar 30 22:21:53 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 22:21:53 2010 Child 3 finished creating 167 directories. Tue Mar 30 22:21:53 2010 Child 3 will create 5102 files. Tue Mar 30 22:21:53 2010 Child 0 finished creating 167 directories. Tue Mar 30 22:21:53 2010 Child 0 will create 5102 files. Tue Mar 30 22:21:57 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 22:21:57 2010 Child 3 will create 6 symlinks. Tue Mar 30 22:21:57 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 22:21:57 2010 Child 0 verified 5102 files, created 48 Tue Mar 30 22:21:57 2010 Child 0 will create 6 symlinks. Tue Mar 30 22:21:57 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 22:22:04 2010 Child 1 finished creating 167 directories. Tue Mar 30 22:22:04 2010 Child 1 will create 5102 files. Tue Mar 30 22:22:07 2010 Child 1 verified 5102 files, created 51 Tue Mar 30 22:22:07 2010 Child 1 will create 6 symlinks. Tue Mar 30 22:22:07 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 22:22:07 2010 Completed. Tue Mar 30 22:22:07 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:22:07 2010 Completed. Tue Mar 30 22:22:07 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:22:08 2010 Received. Tue Mar 30 22:22:08 2010 Performing 300 seconds pretest warmup. Child 2 - 50 aborted ops Child 2 - 100 aborted ops Child 2 - 150 aborted ops Child 1 - 50 aborted ops Child 0 - 50 aborted ops Child 2 - 200 aborted ops Child 3 - 50 aborted ops Child 0 - 100 aborted ops Child 1 - 100 aborted ops Child 2 - 250 aborted ops Child 0 - 150 aborted ops Child 2 - 300 aborted ops Child 3 - 100 aborted ops Child 0 - 200 aborted ops Child 1 - 150 aborted ops Child 3 - 150 aborted ops Child 2 - 350 aborted ops Child 3 - 200 aborted ops Child 0 - 250 aborted ops Child 1 - 200 aborted ops Child 3 - 250 aborted ops Child 2 - 400 aborted ops Child 1 - 250 aborted ops Child 0 - 300 aborted ops Child 3 - 300 aborted ops Child 3 - 350 aborted ops Child 0 - 350 aborted ops Child 1 - 300 aborted ops Child 0 - 400 aborted ops Child 2 - 450 aborted ops Child 3 - 400 aborted ops Child 1 - 350 aborted ops Child 3 - 450 aborted ops Child 0 - 450 aborted ops Child 1 - 400 aborted ops Child 3 - 500 aborted ops Child 0 - 500 aborted ops Child 1 - 450 aborted ops Child 3 - 550 aborted ops Child 0 - 550 aborted ops Child 2 - 500 aborted ops Child 1 - 500 aborted ops Child 3 - 600 aborted ops Child 2 - 550 aborted ops Child 0 - 600 aborted ops Child 3 - 650 aborted ops Child 1 - 550 aborted ops Child 1 - 600 aborted ops Child 2 - 600 aborted ops Child 3 - 700 aborted ops Child 0 - 650 aborted ops Child 1 - 650 aborted ops Child 3 - 750 aborted ops Child 2 - 650 aborted ops Child 0 - 700 aborted ops Child 1 - 700 aborted ops Child 0 - 750 aborted ops Child 3 - 800 aborted ops Child 1 - 750 aborted ops Child 2 - 700 aborted ops Child 1 - 800 aborted ops Child 3 - 850 aborted ops Child 0 - 800 aborted ops Child 2 - 750 aborted ops Child 0 - 850 aborted ops Child 3 - 900 aborted ops Child 1 - 850 aborted ops Child 2 - 800 aborted ops Child 1 - 900 aborted ops Child 3 - 950 aborted ops Child 0 - 900 aborted ops Child 1 - 950 aborted ops Child 3 - 1000 aborted ops Child 1 - 1000 aborted ops Child 0 - 950 aborted ops Child 3 - 1050 aborted ops Child 2 - 850 aborted ops Child 0 - 1000 aborted ops Child 3 - 1100 aborted ops Child 0 - 1050 aborted ops Child 1 - 1050 aborted ops Child 2 - 900 aborted ops Child 3 - 1150 aborted ops Child 0 - 1100 aborted ops Child 1 - 1100 aborted ops Child 3 - 1200 aborted ops Child 1 - 1150 aborted ops Child 3 - 1250 aborted ops Child 0 - 1150 aborted ops Child 2 - 950 aborted ops Child 0 - 1200 aborted ops Child 1 - 1200 aborted ops Child 0 - 1250 aborted ops Child 3 - 1300 aborted ops Child 1 - 1250 aborted ops Child 2 - 1000 aborted ops Child 1 - 1300 aborted ops Child 3 - 1350 aborted ops Child 0 - 1300 aborted ops Child 1 - 1350 aborted ops Child 2 - 1050 aborted ops Child 3 - 1400 aborted ops Child 0 - 1350 aborted ops Child 2 - 1100 aborted ops Child 1 - 1400 aborted ops Child 0 - 1400 aborted ops Child 3 - 1450 aborted ops Child 0 - 1450 aborted ops Child 3 - 1500 aborted ops Child 1 - 1450 aborted ops Child 2 - 1150 aborted ops Child 0 - 1500 aborted ops Child 1 - 1500 aborted ops Child 0 - 1550 aborted ops Child 3 - 1550 aborted ops Child 2 - 1200 aborted ops Child 1 - 1550 aborted ops Child 0 - 1600 aborted ops Child 2 - 1250 aborted ops Child 1 - 1600 aborted ops Child 2 - 1300 aborted ops Child 0 - 1650 aborted ops Child 3 - 1600 aborted ops Child 1 - 1650 aborted ops Child 3 - 1650 aborted ops Child 1 - 1700 aborted ops Child 0 - 1700 aborted ops Child 2 - 1350 aborted ops Child 1 - 1750 aborted ops Child 2 - 1400 aborted ops Child 3 - 1700 aborted ops Child 0 - 1750 aborted ops Child 2 - 1450 aborted ops Child 1 - 1800 aborted ops Child 0 - 1800 aborted ops Tue Mar 30 22:27:08 2010 Completed. Tue Mar 30 22:27:08 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:27:08 2010 Completed. Tue Mar 30 22:27:08 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Child 2 - 1500 aborted ops Child 0 - 1850 aborted ops Tue Mar 30 22:27:09 2010 Received. Tue Mar 30 22:27:09 2010 Starting 300 seconds test run. Child 0 - 1900 aborted ops Child 0 - 1950 aborted ops Child 2 - 1550 aborted ops Child 1 - 1850 aborted ops Child 3 - 1750 aborted ops Child 0 - 2000 aborted ops Child 3 - 1800 aborted ops Child 1 - 1900 aborted ops Child 3 - 1850 aborted ops Child 2 - 1600 aborted ops Child 3 - 1900 aborted ops Child 0 - 2050 aborted ops Child 2 - 1650 aborted ops Child 1 - 1950 aborted ops Child 3 - 1950 aborted ops Child 0 - 2100 aborted ops Child 0 - 2150 aborted ops Child 2 - 1700 aborted ops Child 3 - 2000 aborted ops Child 1 - 2000 aborted ops Child 2 - 1750 aborted ops Child 3 - 2050 aborted ops Child 0 - 2200 aborted ops Child 2 - 1800 aborted ops Child 2 - 1850 aborted ops Child 1 - 2050 aborted ops Child 0 - 2250 aborted ops Child 2 - 1900 aborted ops Child 0 - 2300 aborted ops Child 2 - 1950 aborted ops Child 1 - 2100 aborted ops Child 2 - 2000 aborted ops Child 3 - 2100 aborted ops Child 1 - 2150 aborted ops Child 2 - 2050 aborted ops Child 1 - 2200 aborted ops Child 0 - 2350 aborted ops Child 2 - 2100 aborted ops Child 3 - 2150 aborted ops Child 1 - 2250 aborted ops Child 3 - 2200 aborted ops Child 1 - 2300 aborted ops Child 0 - 2400 aborted ops Child 1 - 2350 aborted ops Child 3 - 2250 aborted ops Child 2 - 2150 aborted ops Child 0 - 2450 aborted ops Child 1 - 2400 aborted ops Child 0 - 2500 aborted ops Child 2 - 2200 aborted ops Child 3 - 2300 aborted ops Child 1 - 2450 aborted ops Child 0 - 2550 aborted ops Child 3 - 2350 aborted ops Child 0 - 2600 aborted ops Child 2 - 2250 aborted ops Child 1 - 2500 aborted ops Child 2 - 2300 aborted ops Child 1 - 2550 aborted ops Child 3 - 2400 aborted ops Child 0 - 2650 aborted ops Child 1 - 2600 aborted ops Child 2 - 2350 aborted ops Child 1 - 2650 aborted ops Child 1 - 2700 aborted ops Child 3 - 2450 aborted ops Child 1 - 2750 aborted ops Child 0 - 2700 aborted ops Child 1 - 2800 aborted ops Child 0 - 2750 aborted ops Child 1 - 2850 aborted ops Child 2 - 2400 aborted ops Child 3 - 2500 aborted ops Child 2 - 2450 aborted ops Child 3 - 2550 aborted ops Child 2 - 2500 aborted ops Child 0 - 2800 aborted ops Child 1 - 2900 aborted ops Child 3 - 2600 aborted ops Child 2 - 2550 aborted ops Child 0 - 2850 aborted ops Child 1 - 2950 aborted ops Child 2 - 2600 aborted ops Child 1 - 3000 aborted ops Child 2 - 2650 aborted ops Child 3 - 2650 aborted ops Child 0 - 2900 aborted ops Child 1 - 3050 aborted ops Child 3 - 2700 aborted ops Child 2 - 2700 aborted ops Child 3 - 2750 aborted ops Child 1 - 3100 aborted ops Child 3 - 2800 aborted ops Child 2 - 2750 aborted ops Child 0 - 2950 aborted ops Child 1 - 3150 aborted ops Child 3 - 2850 aborted ops Child 0 - 3000 aborted ops Child 1 - 3200 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 22:32:23 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.2% 307329 307329 0 0.18 0.44 0.00 3.9% setattr 4.0% 4.0% 47197 47197 0 0.20 0.72 0.01 0.7% lookup 24.0% 24.1% 283200 283200 0 0.19 0.52 0.00 3.7% readlink 1.0% 1.0% 11794 11794 0 0.19 0.46 0.01 0.2% read 18.0% 18.0% 210825 258975 0 0.71 3.36 0.01 10.5% write 10.0% 10.1% 118283 143340 0 8.86 155.41 0.07 73.8% create 1.0% 1.0% 11815 11815 0 3.08 85.31 0.17 2.6% remove 1.0% 0.6% 6816 6816 0 0.22 0.59 0.02 0.1% readdir 1.0% 1.0% 11650 11650 0 0.48 0.19 0.01 0.4% fsstat 1.0% 1.0% 11680 11680 0 0.17 0.13 0.01 0.1% access 11.0% 11.0% 129310 129310 0 0.18 0.48 0.00 1.7% commit 0.0% 0.0% 0 71232 0 0.00 0.00 0.00 0.9% readdirplus 2.0% 2.0% 23447 23447 0 0.89 0.51 0.01 1.5% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 3885.25 Ops/Sec AVG. RESPONSE TIME: 1.21 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5800 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1173346 TEST TIME: 302 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1317785 PHYSICAL NFS V3 THROUGHPUT: 4363.52 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3521058.0 KB (100.00% to 110.44% of Base) ------------------------------------------------------------------------ Tue Mar 30 22:32:23 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5800 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 22:32:23 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:32:23 2010 Completed. Tue Mar 30 22:32:23 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 22:32:23 2010 Received. Tue Mar 30 22:32:23 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 22:32:23 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 5900 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 22:32:25 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 22:32:25 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 22:32:37 2010 Completed. Tue Mar 30 22:32:37 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:32:37 2010 Completed. Tue Mar 30 22:32:37 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:32:41 2010 Received. Tue Mar 30 22:32:41 2010 Initializing test directories. Tue Mar 30 22:32:41 2010 Child 1 will create 167 directories. Tue Mar 30 22:32:41 2010 Child 2 will create 167 directories. Tue Mar 30 22:32:41 2010 Child 3 will create 167 directories. Tue Mar 30 22:32:41 2010 Child 0 will create 167 directories. Tue Mar 30 22:32:47 2010 Child 2 finished creating 167 directories. Tue Mar 30 22:32:47 2010 Child 2 will create 5102 files. Tue Mar 30 22:32:48 2010 Child 0 finished creating 167 directories. Tue Mar 30 22:32:48 2010 Child 0 will create 5102 files. Tue Mar 30 22:32:50 2010 Child 3 finished creating 167 directories. Tue Mar 30 22:32:50 2010 Child 3 will create 5102 files. Tue Mar 30 22:32:52 2010 Child 1 finished creating 167 directories. Tue Mar 30 22:32:52 2010 Child 1 will create 5102 files. Tue Mar 30 22:32:55 2010 Child 0 verified 5102 files, created 48 Tue Mar 30 22:32:55 2010 Child 0 will create 6 symlinks. Tue Mar 30 22:32:55 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 22:32:58 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 22:32:58 2010 Child 2 will create 6 symlinks. Tue Mar 30 22:32:58 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 22:33:00 2010 Child 1 verified 5102 files, created 49 Tue Mar 30 22:33:00 2010 Child 1 will create 6 symlinks. Tue Mar 30 22:33:00 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 22:33:05 2010 Child 3 verified 5102 files, created 49 Tue Mar 30 22:33:05 2010 Child 3 will create 6 symlinks. Tue Mar 30 22:33:05 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 22:33:05 2010 Completed. Tue Mar 30 22:33:05 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:33:05 2010 Completed. Tue Mar 30 22:33:05 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:33:06 2010 Received. Tue Mar 30 22:33:06 2010 Performing 300 seconds pretest warmup. Child 0 - 50 aborted ops Child 3 - 50 aborted ops Child 3 - 100 aborted ops Child 0 - 100 aborted ops Child 2 - 50 aborted ops Child 1 - 50 aborted ops Child 3 - 150 aborted ops Child 2 - 100 aborted ops Child 0 - 150 aborted ops Child 3 - 200 aborted ops Child 1 - 100 aborted ops Child 0 - 200 aborted ops Child 1 - 150 aborted ops Child 2 - 150 aborted ops Child 0 - 250 aborted ops Child 1 - 200 aborted ops Child 0 - 300 aborted ops Child 1 - 250 aborted ops Child 3 - 250 aborted ops Child 0 - 350 aborted ops Child 1 - 300 aborted ops Child 2 - 200 aborted ops Child 0 - 400 aborted ops Child 3 - 300 aborted ops Child 2 - 250 aborted ops Child 1 - 350 aborted ops Child 3 - 350 aborted ops Child 2 - 300 aborted ops Child 0 - 450 aborted ops Child 3 - 400 aborted ops Child 0 - 500 aborted ops Child 2 - 350 aborted ops Child 1 - 400 aborted ops Child 2 - 400 aborted ops Child 3 - 450 aborted ops Child 0 - 550 aborted ops Child 0 - 600 aborted ops Child 3 - 500 aborted ops Child 1 - 450 aborted ops Child 0 - 650 aborted ops Child 1 - 500 aborted ops Child 2 - 450 aborted ops Child 0 - 700 aborted ops Child 1 - 550 aborted ops Child 3 - 550 aborted ops Child 1 - 600 aborted ops Child 0 - 750 aborted ops Child 2 - 500 aborted ops Child 3 - 600 aborted ops Child 3 - 650 aborted ops Child 1 - 650 aborted ops Child 2 - 550 aborted ops Child 1 - 700 aborted ops Child 2 - 600 aborted ops Child 0 - 800 aborted ops Child 0 - 850 aborted ops Child 3 - 700 aborted ops Child 0 - 900 aborted ops Child 1 - 750 aborted ops Child 1 - 800 aborted ops Child 3 - 750 aborted ops Child 0 - 950 aborted ops Child 1 - 850 aborted ops Child 1 - 900 aborted ops Child 1 - 950 aborted ops Child 2 - 650 aborted ops Child 0 - 1000 aborted ops Child 3 - 800 aborted ops Child 0 - 1050 aborted ops Child 3 - 850 aborted ops Child 1 - 1000 aborted ops Child 2 - 700 aborted ops Child 2 - 750 aborted ops Child 3 - 900 aborted ops Child 0 - 1100 aborted ops Child 1 - 1050 aborted ops Child 2 - 800 aborted ops Child 3 - 950 aborted ops Child 0 - 1150 aborted ops Child 2 - 850 aborted ops Child 2 - 900 aborted ops Child 1 - 1100 aborted ops Child 0 - 1200 aborted ops Child 3 - 1000 aborted ops Child 0 - 1250 aborted ops Child 2 - 950 aborted ops Child 1 - 1150 aborted ops Child 0 - 1300 aborted ops Child 3 - 1050 aborted ops Child 2 - 1000 aborted ops Child 1 - 1200 aborted ops Child 0 - 1350 aborted ops Child 1 - 1250 aborted ops Child 2 - 1050 aborted ops Tue Mar 30 22:38:06 2010 Completed. Tue Mar 30 22:38:06 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:38:06 2010 Completed. Tue Mar 30 22:38:06 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:38:07 2010 Received. Tue Mar 30 22:38:07 2010 Starting 300 seconds test run. Child 2 - 1100 aborted ops Child 3 - 1100 aborted ops Child 2 - 1150 aborted ops Child 0 - 1400 aborted ops Child 1 - 1300 aborted ops Child 3 - 1150 aborted ops Child 0 - 1450 aborted ops Child 2 - 1200 aborted ops Child 0 - 1500 aborted ops Child 2 - 1250 aborted ops Child 0 - 1550 aborted ops Child 1 - 1350 aborted ops Child 3 - 1200 aborted ops Child 0 - 1600 aborted ops Child 2 - 1300 aborted ops Child 3 - 1250 aborted ops Child 1 - 1400 aborted ops Child 0 - 1650 aborted ops Child 3 - 1300 aborted ops Child 2 - 1350 aborted ops Child 1 - 1450 aborted ops Child 3 - 1350 aborted ops Child 0 - 1700 aborted ops Child 1 - 1500 aborted ops Child 2 - 1400 aborted ops Child 3 - 1400 aborted ops Child 0 - 1750 aborted ops Child 3 - 1450 aborted ops Child 1 - 1550 aborted ops Child 2 - 1450 aborted ops Child 0 - 1800 aborted ops Child 1 - 1600 aborted ops Child 3 - 1500 aborted ops Child 2 - 1500 aborted ops Child 0 - 1850 aborted ops Child 1 - 1650 aborted ops Child 1 - 1700 aborted ops Child 0 - 1900 aborted ops Child 1 - 1750 aborted ops Child 2 - 1550 aborted ops Child 3 - 1550 aborted ops Child 1 - 1800 aborted ops Child 3 - 1600 aborted ops Child 0 - 1950 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 22:43:18 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.0% 128306 128306 0 0.46 92.94 0.05 7.8% setattr 4.0% 4.0% 19755 19755 2 2.85 361.29 0.27 7.5% lookup 24.0% 24.1% 119126 119126 0 0.76 136.47 0.07 12.0% readlink 1.0% 1.0% 4895 4895 0 0.20 0.11 0.01 0.1% read 18.0% 18.2% 89758 110144 3 0.94 111.14 0.07 11.2% write 10.0% 10.1% 49827 60391 2 8.12 404.51 0.18 53.8% create 1.0% 1.0% 5013 5013 0 5.41 86.21 0.26 3.6% remove 1.0% 0.5% 2694 2694 0 0.23 0.12 0.01 0.1% readdir 1.0% 1.0% 4964 4964 0 0.50 0.11 0.01 0.3% fsstat 1.0% 1.0% 5017 5017 0 0.19 0.11 0.01 0.1% access 11.0% 11.0% 54150 54150 1 0.20 0.24 0.00 1.4% commit 0.0% 0.0% 0 29993 0 0.00 0.00 0.00 0.8% readdirplus 2.0% 2.0% 9923 9923 0 0.91 0.13 0.01 1.2% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 1661.37 Ops/Sec AVG. RESPONSE TIME: 1.52 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 5900 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 493428 TEST TIME: 297 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 554371 PHYSICAL NFS V3 THROUGHPUT: 1866.56 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 22:43:18 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 5900 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 22:43:18 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:43:18 2010 Completed. Tue Mar 30 22:43:18 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 22:43:18 2010 Received. Tue Mar 30 22:43:18 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 22:43:18 2010 Completed. Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 6000 -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -F 20000 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export c09-45.sysnet.ucsd.edu:/export NFS V3 Protocol Version ************************************************************************ ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client c09-44: Good clock resolution [ 1.000000 ] Micro seconds. SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 SFS NFS V3 Benchmark Client Logfile, Tue Mar 30 22:43:20 2010 Client hostname = c09-44 Prime Client hostname = c09-44.sysnet.ucsd.edu SPEC SFS Benchmark Version 2008, Creation - 1 February 2008 NFS V3 Protocol Tue Mar 30 22:43:20 2010 Mounting 4 remote test directories. Child[000]: NFS negotiated block size 32768 Child[001]: NFS negotiated block size 32768 Child[002]: NFS negotiated block size 32768 Child[003]: NFS negotiated block size 32768 Tue Mar 30 22:43:31 2010 Completed. Tue Mar 30 22:43:31 2010 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:43:31 2010 Completed. Tue Mar 30 22:43:31 2010 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:43:36 2010 Received. Tue Mar 30 22:43:36 2010 Initializing test directories. Tue Mar 30 22:43:36 2010 Child 1 will create 167 directories. Tue Mar 30 22:43:36 2010 Child 3 will create 167 directories. Tue Mar 30 22:43:36 2010 Child 2 will create 167 directories. Tue Mar 30 22:43:36 2010 Child 0 will create 167 directories. Tue Mar 30 22:43:39 2010 Child 2 finished creating 167 directories. Tue Mar 30 22:43:39 2010 Child 2 will create 5102 files. Tue Mar 30 22:43:42 2010 Child 0 finished creating 167 directories. Tue Mar 30 22:43:42 2010 Child 0 will create 5102 files. Tue Mar 30 22:43:50 2010 Child 3 finished creating 167 directories. Tue Mar 30 22:43:50 2010 Child 3 will create 5102 files. Tue Mar 30 22:43:52 2010 Child 2 verified 5102 files, created 51 Tue Mar 30 22:43:52 2010 Child 2 will create 6 symlinks. Tue Mar 30 22:43:52 2010 Child 2 finished creating 6 symlinks. Tue Mar 30 22:43:53 2010 Child 1 finished creating 167 directories. Tue Mar 30 22:43:53 2010 Child 1 will create 5102 files. Tue Mar 30 22:43:56 2010 Child 0 verified 5102 files, created 51 Tue Mar 30 22:43:56 2010 Child 0 will create 6 symlinks. Tue Mar 30 22:43:56 2010 Child 0 finished creating 6 symlinks. Tue Mar 30 22:43:58 2010 Child 3 verified 5102 files, created 51 Tue Mar 30 22:43:58 2010 Child 3 will create 6 symlinks. Tue Mar 30 22:43:58 2010 Child 3 finished creating 6 symlinks. Tue Mar 30 22:44:05 2010 Child 1 verified 5102 files, created 50 Tue Mar 30 22:44:05 2010 Child 1 will create 6 symlinks. Tue Mar 30 22:44:05 2010 Child 1 finished creating 6 symlinks. Tue Mar 30 22:44:05 2010 Completed. Tue Mar 30 22:44:05 2010 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:44:05 2010 Completed. Tue Mar 30 22:44:05 2010 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:44:06 2010 Received. Tue Mar 30 22:44:06 2010 Performing 300 seconds pretest warmup. Child 3 - 50 aborted ops Child 1 - 50 aborted ops Child 0 - 50 aborted ops Child 2 - 50 aborted ops Child 1 - 100 aborted ops Child 0 - 100 aborted ops Child 0 - 150 aborted ops Child 3 - 100 aborted ops Child 1 - 150 aborted ops Child 2 - 100 aborted ops Child 3 - 150 aborted ops Child 0 - 200 aborted ops Child 1 - 200 aborted ops Child 2 - 150 aborted ops Child 0 - 250 aborted ops Child 3 - 200 aborted ops Child 1 - 250 aborted ops Child 2 - 200 aborted ops Child 0 - 300 aborted ops Child 3 - 250 aborted ops Child 1 - 300 aborted ops Child 2 - 250 aborted ops Child 0 - 350 aborted ops Child 3 - 300 aborted ops Child 2 - 300 aborted ops Child 1 - 350 aborted ops Child 3 - 350 aborted ops Child 2 - 350 aborted ops Child 0 - 400 aborted ops Child 1 - 400 aborted ops Child 3 - 400 aborted ops Child 1 - 450 aborted ops Child 2 - 400 aborted ops Child 3 - 450 aborted ops Child 0 - 450 aborted ops Child 1 - 500 aborted ops Child 3 - 500 aborted ops Child 2 - 450 aborted ops Child 1 - 550 aborted ops Child 0 - 500 aborted ops Child 3 - 550 aborted ops Child 1 - 600 aborted ops Child 2 - 500 aborted ops Child 3 - 600 aborted ops Child 0 - 550 aborted ops Child 1 - 650 aborted ops Child 2 - 550 aborted ops Child 3 - 650 aborted ops Child 0 - 600 aborted ops Child 2 - 600 aborted ops Child 1 - 700 aborted ops Child 2 - 650 aborted ops Child 0 - 650 aborted ops Child 3 - 700 aborted ops Child 2 - 700 aborted ops Child 2 - 750 aborted ops Child 1 - 750 aborted ops Child 0 - 700 aborted ops Child 3 - 750 aborted ops Child 1 - 800 aborted ops Child 2 - 800 aborted ops Child 3 - 800 aborted ops Child 0 - 750 aborted ops Child 2 - 850 aborted ops Child 1 - 850 aborted ops Child 0 - 800 aborted ops Child 3 - 850 aborted ops Child 0 - 850 aborted ops Child 2 - 900 aborted ops Child 3 - 900 aborted ops Child 1 - 900 aborted ops Child 2 - 950 aborted ops Child 0 - 900 aborted ops Child 3 - 950 aborted ops Child 1 - 950 aborted ops Child 2 - 1000 aborted ops Child 0 - 950 aborted ops Child 1 - 1000 aborted ops Child 2 - 1050 aborted ops Child 1 - 1050 aborted ops Child 0 - 1000 aborted ops Child 3 - 1000 aborted ops Child 1 - 1100 aborted ops Child 2 - 1100 aborted ops Child 2 - 1150 aborted ops Child 0 - 1050 aborted ops Child 1 - 1150 aborted ops Child 0 - 1100 aborted ops Child 3 - 1050 aborted ops Child 2 - 1200 aborted ops Child 1 - 1200 aborted ops Child 0 - 1150 aborted ops Child 2 - 1250 aborted ops Child 1 - 1250 aborted ops Child 3 - 1100 aborted ops Child 0 - 1200 aborted ops Child 1 - 1300 aborted ops Child 2 - 1300 aborted ops Child 3 - 1150 aborted ops Child 0 - 1250 aborted ops Child 1 - 1350 aborted ops Child 2 - 1350 aborted ops Child 3 - 1200 aborted ops Child 0 - 1300 aborted ops Child 2 - 1400 aborted ops Child 3 - 1250 aborted ops Child 1 - 1400 aborted ops Child 0 - 1350 aborted ops Child 2 - 1450 aborted ops Child 1 - 1450 aborted ops Child 3 - 1300 aborted ops Child 2 - 1500 aborted ops Child 3 - 1350 aborted ops Child 1 - 1500 aborted ops Child 0 - 1400 aborted ops Child 3 - 1400 aborted ops Child 1 - 1550 aborted ops Child 1 - 1600 aborted ops Child 2 - 1550 aborted ops Child 1 - 1650 aborted ops Child 3 - 1450 aborted ops Child 0 - 1450 aborted ops Child 1 - 1700 aborted ops Child 2 - 1600 aborted ops Child 3 - 1500 aborted ops Child 2 - 1650 aborted ops Child 2 - 1700 aborted ops Child 1 - 1750 aborted ops Child 0 - 1500 aborted ops Child 3 - 1550 aborted ops Child 0 - 1550 aborted ops Child 1 - 1800 aborted ops Child 3 - 1600 aborted ops Child 0 - 1600 aborted ops Child 3 - 1650 aborted ops Child 1 - 1850 aborted ops Child 2 - 1750 aborted ops Child 0 - 1650 aborted ops Tue Mar 30 22:49:06 2010 Completed. Tue Mar 30 22:49:06 2010 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:49:06 2010 Completed. Tue Mar 30 22:49:06 2010 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:49:07 2010 Received. Tue Mar 30 22:49:07 2010 Starting 300 seconds test run. Child 3 - 1700 aborted ops Child 1 - 1900 aborted ops Child 2 - 1800 aborted ops Child 0 - 1700 aborted ops Child 3 - 1750 aborted ops Child 2 - 1850 aborted ops Child 1 - 1950 aborted ops Child 3 - 1800 aborted ops Child 2 - 1900 aborted ops Child 1 - 2000 aborted ops Child 3 - 1850 aborted ops Child 1 - 2050 aborted ops Child 0 - 1750 aborted ops Child 3 - 1900 aborted ops Child 2 - 1950 aborted ops Child 1 - 2100 aborted ops Child 1 - 2150 aborted ops Child 2 - 2000 aborted ops Child 0 - 1800 aborted ops Child 1 - 2200 aborted ops Child 2 - 2050 aborted ops Child 3 - 1950 aborted ops Child 0 - 1850 aborted ops Child 2 - 2100 aborted ops Child 1 - 2250 aborted ops Child 0 - 1900 aborted ops Child 3 - 2000 aborted ops Child 1 - 2300 aborted ops Child 2 - 2150 aborted ops Child 3 - 2050 aborted ops Child 0 - 1950 aborted ops Child 3 - 2100 aborted ops Child 1 - 2350 aborted ops Child 3 - 2150 aborted ops Child 3 - 2200 aborted ops Child 0 - 2000 aborted ops Child 1 - 2400 aborted ops Child 1 - 2450 aborted ops Child 0 - 2050 aborted ops Child 1 - 2500 aborted ops Child 2 - 2200 aborted ops Child 3 - 2250 aborted ops Child 2 - 2250 aborted ops Child 0 - 2100 aborted ops Child 2 - 2300 aborted ops Child 1 - 2550 aborted ops Child 3 - 2300 aborted ops Child 3 - 2350 aborted ops Child 0 - 2150 aborted ops Child 3 - 2400 aborted ops Child 1 - 2600 aborted ops Child 0 - 2200 aborted ops Child 0 - 2250 aborted ops Child 1 - 2650 aborted ops Child 2 - 2350 aborted ops Child 3 - 2450 aborted ops Child 0 - 2300 aborted ops Child 2 - 2400 aborted ops Child 3 - 2500 aborted ops Child 2 - 2450 aborted ops Child 0 - 2350 aborted ops Child 0 - 2400 aborted ops Child 1 - 2700 aborted ops Child 2 - 2500 aborted ops Child 3 - 2550 aborted ops Child 0 - 2450 aborted ops Child 2 - 2550 aborted ops Child 1 - 2750 aborted ops Child 3 - 2600 aborted ops Child 0 - 2500 aborted ops Child 2 - 2600 aborted ops Child 1 - 2800 aborted ops Child 3 - 2650 aborted ops Child 2 - 2650 aborted ops Child 0 - 2550 aborted ops Child 3 - 2700 aborted ops Child 1 - 2850 aborted ops Child 2 - 2700 aborted ops Child 1 - 2900 aborted ops Child 3 - 2750 aborted ops Child 0 - 2600 aborted ops Child 2 - 2750 aborted ops Child 2 - 2800 aborted ops Child 2 - 2850 aborted ops Child 0 - 2650 aborted ops Child 3 - 2800 aborted ops Child 2 - 2900 aborted ops Child 1 - 2950 aborted ops Child 2 - 2950 aborted ops Child 0 - 2700 aborted ops Child 3 - 2850 aborted ops Child 1 - 3000 aborted ops Child 3 - 2900 aborted ops Child 0 - 2750 aborted ops Child 2 - 3000 aborted ops Child 1 - 3050 aborted ops Child 3 - 2950 aborted ops Child 1 - 3100 aborted ops SFS Single Client (c09-44) Results, Tue Mar 30 22:54:18 2010 -------------------------------------------------------------------------------------- NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt Op Logical Logical Logical Physical Op Response Response of Mean, of Type Mix Mix Success Success Error Time Time 95% Conf Total Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time -------------------------------------------------------------------------------------- getattr 26.0% 26.1% 288873 288873 0 0.18 1.17 0.00 3.8% setattr 4.0% 4.0% 44591 44591 0 0.20 0.59 0.01 0.6% lookup 24.0% 24.1% 267287 267287 0 0.20 7.37 0.01 3.9% readlink 1.0% 1.0% 10931 10931 0 0.18 0.14 0.01 0.1% read 18.0% 18.1% 200211 246428 0 0.63 2.53 0.01 9.1% write 10.0% 10.1% 111586 135015 0 9.53 176.49 0.08 76.3% create 1.0% 1.0% 10900 10900 0 2.07 56.70 0.14 1.6% remove 1.0% 0.6% 6172 6172 0 0.22 0.35 0.01 0.1% readdir 1.0% 1.0% 11184 11184 0 0.50 0.51 0.01 0.4% fsstat 1.0% 1.0% 11218 11218 0 0.17 0.09 0.01 0.1% access 11.0% 11.0% 122306 122306 0 0.18 1.49 0.01 1.6% commit 0.0% 0.0% 0 67172 0 0.00 0.00 0.00 0.9% readdirplus 2.0% 2.0% 22186 22186 0 0.89 0.33 0.01 1.4% -------------------------------------------------------------------------------------- -------------------------------------------------- | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY | --------------------------+----------------------- SFS NFS V3 THROUGHPUT: 3741.36 Ops/Sec AVG. RESPONSE TIME: 1.25 Msec/Op TCP PROTOCOL FAST CALLS: 0 NFS V3 MIXFILE: [ SFS Default ] CLIENT REQUESTED LOAD: 6000 Ops/Sec TOTAL LOGICAL NFS V3 OPERATIONS: 1107445 TEST TIME: 296 Sec TOTAL PHYSICAL NFS V3 OPERATIONS: 1244263 PHYSICAL NFS V3 THROUGHPUT: 4203.59 Ops/Sec FILE SET SIZE CREATED: 10622124.0 KB FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB (100.00% to 110.00% of Base) ------------------------------------------------------------------------ Tue Mar 30 22:54:18 2010 Completed. Client Test Parameters: Number of processes = 4 Requested Load (NFS V3 operations/second) = 6000 Maximum number of outstanding biod writes = 2 Maximum number of outstanding biod reads = 2 Warm-up time (seconds) = 300 Run time (seconds) = 300 File Set = 20004 Files created for I/O operations 6000 Files accessed for I/O operations 404 Files for non-I/O operations 24 Symlinks 664 Directories Additional non-I/O files created as necessary SPEC SFS 2008 Benchmark, Creation - 1 February 2008 Tue Mar 30 22:54:18 2010 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu). Tue Mar 30 22:54:18 2010 Completed. Tue Mar 30 22:54:18 2010 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu). ************************************************************************ Tue Mar 30 22:54:18 2010 Received. Tue Mar 30 22:54:18 2010 Sending results to Prime Client(c09-44.sysnet.ucsd.edu) Tue Mar 30 22:54:18 2010 Completed.