Checking in some results with a smaller, slower disk.
[bluesky.git] / results / 20110215 / sfsc001.20110214-bluesky-4G
1 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 200  -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  c09-45.sysnet.ucsd.edu:/ c09-45.sysnet.ucsd.edu:/ c09-45.sysnet.ucsd.edu:/ c09-45.sysnet.ucsd.edu:/ 
2 NFS V3 Protocol Version
3
4 ************************************************************************
5 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
6 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
7
8 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
9 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
10
11 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 09:18:29 2011
12         Client hostname = c09-44
13         Prime Client hostname = c09-44.sysnet.ucsd.edu
14
15 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
16 NFS V3 Protocol
17 Mon Feb 14 09:18:29 2011 Mounting 4 remote test directories.
18 sfsnfs30: mounting c09-45.sysnet.ucsd.edu:/ - access denied
19 sfsnfs30: can't pseudo mount c09-45.sysnet.ucsd.edu
20 sfsnfs30: sending Pid 0 Signal 2
21 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 200  -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -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 
22 NFS V3 Protocol Version
23
24 ************************************************************************
25 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
26 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
27
28 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
29 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
30
31 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 09:22:42 2011
32         Client hostname = c09-44
33         Prime Client hostname = c09-44.sysnet.ucsd.edu
34
35 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
36 NFS V3 Protocol
37 Mon Feb 14 09:22:42 2011 Mounting 4 remote test directories.
38 Child[000]: NFS negotiated block size 32768
39 Child[001]: NFS negotiated block size 32768
40 Child[002]: NFS negotiated block size 32768
41 Child[003]: NFS negotiated block size 32768
42 Mon Feb 14 09:22:53 2011 Completed.
43 Mon Feb 14 09:22:53 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
44 Mon Feb 14 09:22:53 2011 Completed.
45 Mon Feb 14 09:22:53 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
46 Mon Feb 14 09:22:58 2011 Received.
47
48 Mon Feb 14 09:22:58 2011 Initializing test directories.
49 Mon Feb 14 09:22:58 2011 Child 3 will create 379 directories.
50 Mon Feb 14 09:22:58 2011 Child 1 will create 379 directories.
51 Mon Feb 14 09:22:58 2011 Child 2 will create 379 directories.
52 Mon Feb 14 09:22:58 2011 Child 0 will create 379 directories.
53 Mon Feb 14 09:23:01 2011 Child 2 finished creating 379 directories.
54 Mon Feb 14 09:23:01 2011 Child 2 will create 11585 files.
55 Mon Feb 14 09:23:01 2011 Child 0 finished creating 379 directories.
56 Mon Feb 14 09:23:01 2011 Child 0 will create 11585 files.
57 Mon Feb 14 09:23:01 2011 Child 3 finished creating 379 directories.
58 Mon Feb 14 09:23:01 2011 Child 3 will create 11585 files.
59 Mon Feb 14 09:23:01 2011 Child 1 finished creating 379 directories.
60 Mon Feb 14 09:23:01 2011 Child 1 will create 11585 files.
61 Mon Feb 14 09:28:02 2011 Child 2 verified 2685 files (2685 creates).
62 Mon Feb 14 09:28:02 2011 Child 0 verified 2663 files (2663 creates).
63 Mon Feb 14 09:28:02 2011 Child 3 verified 2732 files (2732 creates).
64 Mon Feb 14 09:28:02 2011 Child 1 verified 2672 files (2672 creates).
65 Mon Feb 14 09:33:04 2011 Child 1 verified 4991 files (4991 creates).
66 Mon Feb 14 09:33:04 2011 Child 3 verified 4985 files (4985 creates).
67 Mon Feb 14 09:33:04 2011 Child 0 verified 5001 files (5001 creates).
68 Mon Feb 14 09:33:04 2011 Child 2 verified 5269 files (5269 creates).
69 Mon Feb 14 09:38:05 2011 Child 1 verified 8060 files (8060 creates).
70 Mon Feb 14 09:38:05 2011 Child 0 verified 8022 files (8022 creates).
71 Mon Feb 14 09:38:05 2011 Child 3 verified 8117 files (8117 creates).
72 Mon Feb 14 09:38:05 2011 Child 2 verified 8301 files (8301 creates).
73 lad_write() NFS call failed : No space left on device
74 sfsnfs33: error in lad_write() at 168 for f10879twnobeo.ouaeb 
75 sfsnfs33: sending Pid 0 Signal 2
76 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 200  -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 
77 NFS V3 Protocol Version
78
79 ************************************************************************
80 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
81 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
82
83 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
84 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
85
86 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 10:05:21 2011
87         Client hostname = c09-44
88         Prime Client hostname = c09-44.sysnet.ucsd.edu
89
90 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
91 NFS V3 Protocol
92 Mon Feb 14 10:05:21 2011 Mounting 4 remote test directories.
93 Child[001]: NFS negotiated block size 32768
94 Child[002]: NFS negotiated block size 32768
95 Child[003]: NFS negotiated block size 32768
96 Child[000]: NFS negotiated block size 32768
97 Mon Feb 14 10:05:37 2011 Completed.
98 Mon Feb 14 10:05:37 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
99 Mon Feb 14 10:05:37 2011 Completed.
100 Mon Feb 14 10:05:37 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
101 Mon Feb 14 10:05:37 2011 Received.
102
103 Mon Feb 14 10:05:37 2011 Initializing test directories.
104 Mon Feb 14 10:05:37 2011 Child 1 will create 167 directories.
105 Mon Feb 14 10:05:37 2011 Child 3 will create 167 directories.
106 Mon Feb 14 10:05:37 2011 Child 0 will create 167 directories.
107 Mon Feb 14 10:05:37 2011 Child 2 will create 167 directories.
108 Mon Feb 14 10:05:37 2011 Child 0 finished creating 167 directories.
109 Mon Feb 14 10:05:37 2011 Child 0 will create 5102 files.
110 Mon Feb 14 10:05:38 2011 Child 1 finished creating 167 directories.
111 Mon Feb 14 10:05:38 2011 Child 1 will create 5102 files.
112 Mon Feb 14 10:05:38 2011 Child 2 finished creating 167 directories.
113 Mon Feb 14 10:05:38 2011 Child 2 will create 5102 files.
114 Mon Feb 14 10:05:38 2011 Child 3 finished creating 167 directories.
115 Mon Feb 14 10:05:38 2011 Child 3 will create 5102 files.
116 Mon Feb 14 10:10:39 2011 Child 0 verified 2837 files (2837 creates).
117 Mon Feb 14 10:10:39 2011 Child 1 verified 2713 files (2713 creates).
118 Mon Feb 14 10:10:39 2011 Child 3 verified 2721 files (2721 creates).
119 Mon Feb 14 10:10:39 2011 Child 2 verified 2819 files (2819 creates).
120 Mon Feb 14 10:15:18 2011 Child 0 verified 5102 files, created 5052
121 Mon Feb 14 10:15:18 2011 Child 0 will create 6 symlinks.
122 Mon Feb 14 10:15:18 2011 Child 0 finished creating 6 symlinks.
123 Mon Feb 14 10:15:29 2011 Child 3 verified 5102 files, created 5052
124 Mon Feb 14 10:15:29 2011 Child 3 will create 6 symlinks.
125 Mon Feb 14 10:15:29 2011 Child 3 finished creating 6 symlinks.
126 Mon Feb 14 10:15:32 2011 Child 2 verified 5102 files, created 5052
127 Mon Feb 14 10:15:32 2011 Child 2 will create 6 symlinks.
128 Mon Feb 14 10:15:32 2011 Child 2 finished creating 6 symlinks.
129 Mon Feb 14 10:15:34 2011 Child 1 verified 5102 files, created 5052
130 Mon Feb 14 10:15:34 2011 Child 1 will create 6 symlinks.
131 Mon Feb 14 10:15:34 2011 Child 1 finished creating 6 symlinks.
132 Mon Feb 14 10:15:35 2011 Completed.
133 Mon Feb 14 10:15:35 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
134 Mon Feb 14 10:15:35 2011 Completed.
135 Mon Feb 14 10:15:35 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
136 Mon Feb 14 10:15:35 2011 Received.
137 Mon Feb 14 10:15:35 2011 Performing 300 seconds pretest warmup.
138 Mon Feb 14 10:20:35 2011 Completed.
139 Mon Feb 14 10:20:35 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
140 Mon Feb 14 10:20:35 2011 Completed.
141 Mon Feb 14 10:20:35 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
142 Mon Feb 14 10:20:36 2011 Received.
143 Mon Feb 14 10:20:36 2011 Starting 300 seconds test run.
144 SFS Single Client (c09-44) Results, Mon Feb 14 10:25:46 2011
145 --------------------------------------------------------------------------------------
146 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
147 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
148 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
149            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
150 --------------------------------------------------------------------------------------
151 getattr     26.0%    26.2%    15780    15780      0      0.14     0.02      0.00  2.4%
152 setattr      4.0%     4.0%     2411     2411      0      6.65    59.10      0.31 17.4%
153 lookup      24.0%    23.7%    14289    14289      0      0.14     0.02      0.00  2.2%
154 readlink     1.0%     1.0%      612      612      0      0.14     0.02      0.01  0.1%
155 read        18.0%    18.0%    10855    13345      0      1.81    10.63      0.06 21.3%
156 write       10.0%    10.0%     6010     7224      0      2.59    26.54      0.13 16.9%
157 create       1.0%     1.1%      649      649      0      6.66    45.22      0.52  4.7%
158 remove       1.0%     1.0%      623      623      0      9.94    76.81      0.69  6.7%
159 readdir      1.0%     1.0%      594      594      0      1.60    19.58      0.36  1.0%
160 fsstat       1.0%     1.0%      579      579      0      0.13     0.02      0.01  0.1%
161 access      11.0%    10.9%     6586     6586      0      0.14     0.02      0.00  1.0%
162 commit       0.0%     0.0%        0     3164      0      0.00     0.00      0.00 24.1%
163 readdirplus  2.0%     2.0%     1190     1190      0      1.62    15.50      0.22  2.1%
164 --------------------------------------------------------------------------------------
165
166       --------------------------------------------------
167       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
168       --------------------------+-----------------------
169 SFS NFS V3 THROUGHPUT:  200.59 Ops/Sec   AVG. RESPONSE TIME:    1.53 Msec/Op
170 TCP PROTOCOL
171 FAST CALLS: 0
172 NFS V3 MIXFILE: [ SFS Default ]
173 CLIENT REQUESTED LOAD: 200 Ops/Sec 
174 TOTAL LOGICAL NFS V3 OPERATIONS:  60178          TEST TIME: 300 Sec 
175 TOTAL PHYSICAL NFS V3 OPERATIONS: 67046    
176 PHYSICAL NFS V3 THROUGHPUT:  223.48 Ops/Sec
177 FILE SET SIZE CREATED: 10622124.0 KB
178 FILE SET SIZE ACCESSED: 3188124.0 - 3327741.0 KB  (100.00% to 104.38% of Base)
179
180 ------------------------------------------------------------------------
181
182 Mon Feb 14 10:25:46 2011 Completed.
183
184 Client Test Parameters: 
185         Number of processes = 4
186         Requested Load (NFS V3 operations/second) = 200
187         Maximum number of outstanding biod writes = 2
188         Maximum number of outstanding biod reads = 2
189         Warm-up time (seconds) = 300
190         Run time (seconds) = 300
191         File Set = 20004 Files created for I/O operations
192                    6000 Files accessed for I/O operations
193                     404 Files for non-I/O operations
194                      24 Symlinks
195                     664 Directories
196                         Additional non-I/O files created as necessary
197
198
199 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
200 Mon Feb 14 10:25:46 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
201 Mon Feb 14 10:25:46 2011 Completed.
202 Mon Feb 14 10:25:46 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
203
204 ************************************************************************
205 Mon Feb 14 10:25:47 2011 Received.
206 Mon Feb 14 10:25:47 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
207 Mon Feb 14 10:25:47 2011 Completed.
208 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 400  -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 
209 NFS V3 Protocol Version
210
211 ************************************************************************
212 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
213 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
214
215 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
216 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
217
218 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 10:25:49 2011
219         Client hostname = c09-44
220         Prime Client hostname = c09-44.sysnet.ucsd.edu
221
222 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
223 NFS V3 Protocol
224 Mon Feb 14 10:25:49 2011 Mounting 4 remote test directories.
225 Child[000]: NFS negotiated block size 32768
226 Child[001]: NFS negotiated block size 32768
227 Child[002]: NFS negotiated block size 32768
228 Child[003]: NFS negotiated block size 32768
229 Mon Feb 14 10:26:00 2011 Completed.
230 Mon Feb 14 10:26:00 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
231 Mon Feb 14 10:26:00 2011 Completed.
232 Mon Feb 14 10:26:00 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
233 Mon Feb 14 10:26:05 2011 Received.
234
235 Mon Feb 14 10:26:05 2011 Initializing test directories.
236 Mon Feb 14 10:26:05 2011 Child 2 will create 167 directories.
237 Mon Feb 14 10:26:05 2011 Child 0 will create 167 directories.
238 Mon Feb 14 10:26:05 2011 Child 1 will create 167 directories.
239 Mon Feb 14 10:26:05 2011 Child 3 will create 167 directories.
240 Mon Feb 14 10:26:09 2011 Child 1 finished creating 167 directories.
241 Mon Feb 14 10:26:09 2011 Child 1 will create 5102 files.
242 Mon Feb 14 10:26:11 2011 Child 1 verified 5102 files, created 17
243 Mon Feb 14 10:26:11 2011 Child 1 will create 6 symlinks.
244 Mon Feb 14 10:26:11 2011 Child 1 finished creating 6 symlinks.
245 Mon Feb 14 10:26:12 2011 Child 2 finished creating 167 directories.
246 Mon Feb 14 10:26:12 2011 Child 2 will create 5102 files.
247 Mon Feb 14 10:26:14 2011 Child 2 verified 5102 files, created 21
248 Mon Feb 14 10:26:14 2011 Child 2 will create 6 symlinks.
249 Mon Feb 14 10:26:14 2011 Child 2 finished creating 6 symlinks.
250 Mon Feb 14 10:26:15 2011 Child 3 finished creating 167 directories.
251 Mon Feb 14 10:26:15 2011 Child 3 will create 5102 files.
252 Mon Feb 14 10:26:17 2011 Child 0 finished creating 167 directories.
253 Mon Feb 14 10:26:17 2011 Child 0 will create 5102 files.
254 Mon Feb 14 10:26:17 2011 Child 3 verified 5102 files, created 11
255 Mon Feb 14 10:26:17 2011 Child 3 will create 6 symlinks.
256 Mon Feb 14 10:26:17 2011 Child 3 finished creating 6 symlinks.
257 Mon Feb 14 10:26:21 2011 Child 0 verified 5102 files, created 35
258 Mon Feb 14 10:26:21 2011 Child 0 will create 6 symlinks.
259 Mon Feb 14 10:26:21 2011 Child 0 finished creating 6 symlinks.
260 Mon Feb 14 10:26:21 2011 Completed.
261 Mon Feb 14 10:26:21 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
262 Mon Feb 14 10:26:21 2011 Completed.
263 Mon Feb 14 10:26:21 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
264 Mon Feb 14 10:26:22 2011 Received.
265 Mon Feb 14 10:26:22 2011 Performing 300 seconds pretest warmup.
266 Mon Feb 14 10:31:22 2011 Completed.
267 Mon Feb 14 10:31:22 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
268 Mon Feb 14 10:31:22 2011 Completed.
269 Mon Feb 14 10:31:22 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
270 Mon Feb 14 10:31:23 2011 Received.
271 Mon Feb 14 10:31:23 2011 Starting 300 seconds test run.
272 SFS Single Client (c09-44) Results, Mon Feb 14 10:36:33 2011
273 --------------------------------------------------------------------------------------
274 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
275 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
276 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
277            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
278 --------------------------------------------------------------------------------------
279 getattr     26.0%    26.0%    31336    31336      0      0.14     0.03      0.00  2.8%
280 setattr      4.0%     4.0%     4826     4826      0      6.09    57.64      0.21 18.9%
281 lookup      24.0%    24.0%    28949    28949      0      0.15     0.03      0.00  2.7%
282 readlink     1.0%     1.0%     1182     1182      0      0.15     0.03      0.01  0.1%
283 read        18.0%    17.9%    21567    26270      0      1.14     8.92      0.04 15.8%
284 write       10.0%     9.9%    11884    14282      0      1.86    21.68      0.08 14.2%
285 create       1.0%     1.0%     1186     1186      0      8.30    67.02      0.47  6.3%
286 remove       1.0%     1.0%     1165     1165      0      9.35    88.91      0.54  7.0%
287 readdir      1.0%     0.9%     1143     1143      0      1.24    18.41      0.25  0.9%
288 fsstat       1.0%     1.0%     1227     1227      0      0.14     0.04      0.01  0.1%
289 access      11.0%    11.2%    13507    13507      0      0.14     0.03      0.00  1.2%
290 commit       0.0%     0.0%        0     6824      0      0.00     0.00      0.00 27.8%
291 readdirplus  2.0%     2.1%     2496     2496      0      1.26    14.36      0.15  2.0%
292 --------------------------------------------------------------------------------------
293
294       --------------------------------------------------
295       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
296       --------------------------+-----------------------
297 SFS NFS V3 THROUGHPUT:  401.56 Ops/Sec   AVG. RESPONSE TIME:    1.29 Msec/Op
298 TCP PROTOCOL
299 FAST CALLS: 0
300 NFS V3 MIXFILE: [ SFS Default ]
301 CLIENT REQUESTED LOAD: 400 Ops/Sec 
302 TOTAL LOGICAL NFS V3 OPERATIONS:  120468         TEST TIME: 300 Sec 
303 TOTAL PHYSICAL NFS V3 OPERATIONS: 134393   
304 PHYSICAL NFS V3 THROUGHPUT:  447.97 Ops/Sec
305 FILE SET SIZE CREATED: 10622124.0 KB
306 FILE SET SIZE ACCESSED: 3188124.0 - 3457209.0 KB  (100.00% to 108.44% of Base)
307
308 ------------------------------------------------------------------------
309
310 Mon Feb 14 10:36:33 2011 Completed.
311
312 Client Test Parameters: 
313         Number of processes = 4
314         Requested Load (NFS V3 operations/second) = 400
315         Maximum number of outstanding biod writes = 2
316         Maximum number of outstanding biod reads = 2
317         Warm-up time (seconds) = 300
318         Run time (seconds) = 300
319         File Set = 20004 Files created for I/O operations
320                    6000 Files accessed for I/O operations
321                     404 Files for non-I/O operations
322                      24 Symlinks
323                     664 Directories
324                         Additional non-I/O files created as necessary
325
326
327 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
328 Mon Feb 14 10:36:33 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
329 Mon Feb 14 10:36:33 2011 Completed.
330 Mon Feb 14 10:36:33 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
331
332 ************************************************************************
333 Mon Feb 14 10:36:34 2011 Received.
334 Mon Feb 14 10:36:34 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
335 Mon Feb 14 10:36:34 2011 Completed.
336 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 600  -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 
337 NFS V3 Protocol Version
338
339 ************************************************************************
340 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
341 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
342
343 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
344 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
345
346 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 10:36:36 2011
347         Client hostname = c09-44
348         Prime Client hostname = c09-44.sysnet.ucsd.edu
349
350 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
351 NFS V3 Protocol
352 Mon Feb 14 10:36:36 2011 Mounting 4 remote test directories.
353 Child[000]: NFS negotiated block size 32768
354 Child[001]: NFS negotiated block size 32768
355 Child[002]: NFS negotiated block size 32768
356 Child[003]: NFS negotiated block size 32768
357 Mon Feb 14 10:36:47 2011 Completed.
358 Mon Feb 14 10:36:47 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
359 Mon Feb 14 10:36:47 2011 Completed.
360 Mon Feb 14 10:36:47 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
361 Mon Feb 14 10:36:52 2011 Received.
362
363 Mon Feb 14 10:36:52 2011 Initializing test directories.
364 Mon Feb 14 10:36:52 2011 Child 2 will create 167 directories.
365 Mon Feb 14 10:36:52 2011 Child 1 will create 167 directories.
366 Mon Feb 14 10:36:52 2011 Child 0 will create 167 directories.
367 Mon Feb 14 10:36:52 2011 Child 3 will create 167 directories.
368 Mon Feb 14 10:36:53 2011 Child 2 finished creating 167 directories.
369 Mon Feb 14 10:36:53 2011 Child 2 will create 5102 files.
370 Mon Feb 14 10:36:56 2011 Child 2 verified 5102 files, created 2
371 Mon Feb 14 10:36:56 2011 Child 2 will create 6 symlinks.
372 Mon Feb 14 10:36:56 2011 Child 2 finished creating 6 symlinks.
373 Mon Feb 14 10:36:56 2011 Child 3 finished creating 167 directories.
374 Mon Feb 14 10:36:56 2011 Child 3 will create 5102 files.
375 Mon Feb 14 10:36:59 2011 Child 3 verified 5102 files, created 49
376 Mon Feb 14 10:36:59 2011 Child 3 will create 6 symlinks.
377 Mon Feb 14 10:36:59 2011 Child 3 finished creating 6 symlinks.
378 Mon Feb 14 10:37:00 2011 Child 0 finished creating 167 directories.
379 Mon Feb 14 10:37:00 2011 Child 0 will create 5102 files.
380 Mon Feb 14 10:37:07 2011 Child 1 finished creating 167 directories.
381 Mon Feb 14 10:37:07 2011 Child 1 will create 5102 files.
382 Mon Feb 14 10:37:09 2011 Child 0 verified 5102 files, created 17
383 Mon Feb 14 10:37:09 2011 Child 0 will create 6 symlinks.
384 Mon Feb 14 10:37:09 2011 Child 0 finished creating 6 symlinks.
385 Mon Feb 14 10:37:12 2011 Child 1 verified 5102 files, created 11
386 Mon Feb 14 10:37:12 2011 Child 1 will create 6 symlinks.
387 Mon Feb 14 10:37:12 2011 Child 1 finished creating 6 symlinks.
388 Mon Feb 14 10:37:12 2011 Completed.
389 Mon Feb 14 10:37:12 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
390 Mon Feb 14 10:37:12 2011 Completed.
391 Mon Feb 14 10:37:12 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
392 Mon Feb 14 10:37:12 2011 Received.
393 Mon Feb 14 10:37:12 2011 Performing 300 seconds pretest warmup.
394 Child 1 - 50 aborted ops
395 Mon Feb 14 10:42:12 2011 Completed.
396 Mon Feb 14 10:42:12 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
397 Mon Feb 14 10:42:12 2011 Completed.
398 Mon Feb 14 10:42:12 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
399 Mon Feb 14 10:42:13 2011 Received.
400 Mon Feb 14 10:42:13 2011 Starting 300 seconds test run.
401 Child 1 - 100 aborted ops
402 Child 1 - 150 aborted ops
403 Child 2 - 50 aborted ops
404 Child 1 - 200 aborted ops
405 Child 1 - 250 aborted ops
406 Child 0 - 50 aborted ops
407 SFS Single Client (c09-44) Results, Mon Feb 14 10:47:23 2011
408 --------------------------------------------------------------------------------------
409 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
410 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
411 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
412            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
413 --------------------------------------------------------------------------------------
414 getattr     26.0%    26.1%    47728    47728      0      0.14     0.04      0.00  2.6%
415 setattr      4.0%     4.1%     7453     7453      0      7.81    71.83      0.19 22.4%
416 lookup      24.0%    23.9%    43696    43696      0      0.15     0.04      0.00  2.5%
417 readlink     1.0%     1.0%     1791     1791      0      0.15     0.04      0.01  0.1%
418 read        18.0%    17.9%    32794    40313      0      0.94     8.51      0.03 11.8%
419 write       10.0%    10.0%    18279    22275      0      1.68    22.80      0.07 11.8%
420 create       1.0%     1.1%     1940     1940      0      9.84    81.43      0.40  7.4%
421 remove       1.0%     0.9%     1711     1711      0     11.89   100.34      0.47  7.8%
422 readdir      1.0%     1.0%     1833     1833      0      0.86    10.35      0.15  0.6%
423 fsstat       1.0%     1.0%     1789     1789      0      0.14     0.04      0.01  0.1%
424 access      11.0%    11.0%    20108    20108      0      0.14     0.04      0.00  1.1%
425 commit       0.0%     0.0%        0    10719      0      0.00     0.00      0.00 30.3%
426 readdirplus  2.0%     2.0%     3685     3685      0      0.90     2.02      0.05  1.3%
427 --------------------------------------------------------------------------------------
428
429       --------------------------------------------------
430       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
431       --------------------------+-----------------------
432 SFS NFS V3 THROUGHPUT:  609.35 Ops/Sec   AVG. RESPONSE TIME:    1.41 Msec/Op
433 TCP PROTOCOL
434 FAST CALLS: 0
435 NFS V3 MIXFILE: [ SFS Default ]
436 CLIENT REQUESTED LOAD: 600 Ops/Sec 
437 TOTAL LOGICAL NFS V3 OPERATIONS:  182807         TEST TIME: 300 Sec 
438 TOTAL PHYSICAL NFS V3 OPERATIONS: 205041   
439 PHYSICAL NFS V3 THROUGHPUT:  683.47 Ops/Sec
440 FILE SET SIZE CREATED: 10622124.0 KB
441 FILE SET SIZE ACCESSED: 3188124.0 - 3514649.0 KB  (100.00% to 110.24% of Base)
442
443 ------------------------------------------------------------------------
444
445 Mon Feb 14 10:47:23 2011 Completed.
446
447 Client Test Parameters: 
448         Number of processes = 4
449         Requested Load (NFS V3 operations/second) = 600
450         Maximum number of outstanding biod writes = 2
451         Maximum number of outstanding biod reads = 2
452         Warm-up time (seconds) = 300
453         Run time (seconds) = 300
454         File Set = 20004 Files created for I/O operations
455                    6000 Files accessed for I/O operations
456                     404 Files for non-I/O operations
457                      24 Symlinks
458                     664 Directories
459                         Additional non-I/O files created as necessary
460
461
462 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
463 Mon Feb 14 10:47:23 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
464 Mon Feb 14 10:47:23 2011 Completed.
465 Mon Feb 14 10:47:23 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
466
467 ************************************************************************
468 Mon Feb 14 10:47:24 2011 Received.
469 Mon Feb 14 10:47:24 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
470 Mon Feb 14 10:47:24 2011 Completed.
471 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 800  -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 
472 NFS V3 Protocol Version
473
474 ************************************************************************
475 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
476 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
477
478 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
479 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
480
481 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 10:47:26 2011
482         Client hostname = c09-44
483         Prime Client hostname = c09-44.sysnet.ucsd.edu
484
485 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
486 NFS V3 Protocol
487 Mon Feb 14 10:47:26 2011 Mounting 4 remote test directories.
488 Child[000]: NFS negotiated block size 32768
489 Child[001]: NFS negotiated block size 32768
490 Child[002]: NFS negotiated block size 32768
491 Child[003]: NFS negotiated block size 32768
492 Mon Feb 14 10:47:37 2011 Completed.
493 Mon Feb 14 10:47:37 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
494 Mon Feb 14 10:47:37 2011 Completed.
495 Mon Feb 14 10:47:37 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
496 Mon Feb 14 10:47:42 2011 Received.
497
498 Mon Feb 14 10:47:42 2011 Initializing test directories.
499 Mon Feb 14 10:47:42 2011 Child 1 will create 167 directories.
500 Mon Feb 14 10:47:42 2011 Child 3 will create 167 directories.
501 Mon Feb 14 10:47:42 2011 Child 2 will create 167 directories.
502 Mon Feb 14 10:47:42 2011 Child 0 will create 167 directories.
503 Mon Feb 14 10:47:44 2011 Child 2 finished creating 167 directories.
504 Mon Feb 14 10:47:44 2011 Child 2 will create 5102 files.
505 Mon Feb 14 10:47:47 2011 Child 2 verified 5102 files, created 51
506 Mon Feb 14 10:47:47 2011 Child 2 will create 6 symlinks.
507 Mon Feb 14 10:47:47 2011 Child 2 finished creating 6 symlinks.
508 Mon Feb 14 10:47:56 2011 Child 3 finished creating 167 directories.
509 Mon Feb 14 10:47:56 2011 Child 3 will create 5102 files.
510 Mon Feb 14 10:47:56 2011 Child 0 finished creating 167 directories.
511 Mon Feb 14 10:47:56 2011 Child 0 will create 5102 files.
512 Mon Feb 14 10:47:58 2011 Child 1 finished creating 167 directories.
513 Mon Feb 14 10:47:58 2011 Child 1 will create 5102 files.
514 Mon Feb 14 10:48:03 2011 Child 3 verified 5102 files, created 28
515 Mon Feb 14 10:48:03 2011 Child 3 will create 6 symlinks.
516 Mon Feb 14 10:48:03 2011 Child 3 finished creating 6 symlinks.
517 Mon Feb 14 10:48:06 2011 Child 0 verified 5102 files, created 51
518 Mon Feb 14 10:48:06 2011 Child 0 will create 6 symlinks.
519 Mon Feb 14 10:48:06 2011 Child 0 finished creating 6 symlinks.
520 Mon Feb 14 10:48:09 2011 Child 1 verified 5102 files, created 43
521 Mon Feb 14 10:48:09 2011 Child 1 will create 6 symlinks.
522 Mon Feb 14 10:48:09 2011 Child 1 finished creating 6 symlinks.
523 Mon Feb 14 10:48:10 2011 Completed.
524 Mon Feb 14 10:48:10 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
525 Mon Feb 14 10:48:10 2011 Completed.
526 Mon Feb 14 10:48:10 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
527 Mon Feb 14 10:48:11 2011 Received.
528 Mon Feb 14 10:48:11 2011 Performing 300 seconds pretest warmup.
529 Mon Feb 14 10:53:11 2011 Completed.
530 Mon Feb 14 10:53:11 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
531 Mon Feb 14 10:53:11 2011 Completed.
532 Mon Feb 14 10:53:11 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
533 Mon Feb 14 10:53:12 2011 Received.
534 Mon Feb 14 10:53:12 2011 Starting 300 seconds test run.
535 Child 3 - 50 aborted ops
536 Child 2 - 50 aborted ops
537 Child 0 - 50 aborted ops
538 Child 3 - 100 aborted ops
539 Child 0 - 100 aborted ops
540 Child 2 - 100 aborted ops
541 Child 1 - 50 aborted ops
542 Child 0 - 150 aborted ops
543 Child 3 - 150 aborted ops
544 Child 2 - 150 aborted ops
545 Child 0 - 200 aborted ops
546 Child 3 - 200 aborted ops
547 Child 1 - 100 aborted ops
548 Child 2 - 200 aborted ops
549 Child 3 - 250 aborted ops
550 Child 0 - 250 aborted ops
551 Child 1 - 150 aborted ops
552 Child 2 - 250 aborted ops
553 SFS Single Client (c09-44) Results, Mon Feb 14 10:58:22 2011
554 --------------------------------------------------------------------------------------
555 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
556 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
557 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
558            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
559 --------------------------------------------------------------------------------------
560 getattr     26.0%    26.1%    63772    63772      0      0.15     0.05      0.00  2.3%
561 setattr      4.0%     4.0%     9849     9849      0      9.66    62.08      0.16 23.1%
562 lookup      24.0%    24.2%    59002    59002      0      0.15     0.05      0.00  2.2%
563 readlink     1.0%     1.0%     2399     2399      0      0.15     0.05      0.01  0.1%
564 read        18.0%    18.0%    44035    53986      0      0.88     9.11      0.03  9.4%
565 write       10.0%    10.0%    24333    29637      0      1.34    17.93      0.05  7.9%
566 create       1.0%     1.0%     2530     2530      0     15.66    96.73      0.38  9.6%
567 remove       1.0%     0.7%     1588     1588      0     13.97    90.21      0.47  5.4%
568 readdir      1.0%     1.0%     2446     2446      0      0.69     9.28      0.12  0.4%
569 fsstat       1.0%     1.0%     2493     2493      0      0.15     0.05      0.01  0.1%
570 access      11.0%    11.0%    26856    26856      0      0.15     0.05      0.00  1.0%
571 commit       0.0%     0.0%        0    14463      0      0.00     0.00      0.00 37.6%
572 readdirplus  2.0%     2.0%     4962     4962      0      0.85     0.78      0.02  1.0%
573 --------------------------------------------------------------------------------------
574
575       --------------------------------------------------
576       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
577       --------------------------+-----------------------
578 SFS NFS V3 THROUGHPUT:  816.93 Ops/Sec   AVG. RESPONSE TIME:    1.68 Msec/Op
579 TCP PROTOCOL
580 FAST CALLS: 0
581 NFS V3 MIXFILE: [ SFS Default ]
582 CLIENT REQUESTED LOAD: 800 Ops/Sec 
583 TOTAL LOGICAL NFS V3 OPERATIONS:  244265         TEST TIME: 299 Sec 
584 TOTAL PHYSICAL NFS V3 OPERATIONS: 273983   
585 PHYSICAL NFS V3 THROUGHPUT:  916.33 Ops/Sec
586 FILE SET SIZE CREATED: 10622124.0 KB
587 FILE SET SIZE ACCESSED: 3188124.0 - 3513126.0 KB  (100.00% to 110.19% of Base)
588
589 ------------------------------------------------------------------------
590
591 Mon Feb 14 10:58:22 2011 Completed.
592
593 Client Test Parameters: 
594         Number of processes = 4
595         Requested Load (NFS V3 operations/second) = 800
596         Maximum number of outstanding biod writes = 2
597         Maximum number of outstanding biod reads = 2
598         Warm-up time (seconds) = 300
599         Run time (seconds) = 300
600         File Set = 20004 Files created for I/O operations
601                    6000 Files accessed for I/O operations
602                     404 Files for non-I/O operations
603                      24 Symlinks
604                     664 Directories
605                         Additional non-I/O files created as necessary
606
607
608 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
609 Mon Feb 14 10:58:22 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
610 Mon Feb 14 10:58:22 2011 Completed.
611 Mon Feb 14 10:58:22 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
612
613 ************************************************************************
614 Mon Feb 14 10:58:23 2011 Received.
615 Mon Feb 14 10:58:23 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
616 Mon Feb 14 10:58:23 2011 Completed.
617 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1000  -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 
618 NFS V3 Protocol Version
619
620 ************************************************************************
621 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
622 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
623
624 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
625 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
626
627 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 10:58:25 2011
628         Client hostname = c09-44
629         Prime Client hostname = c09-44.sysnet.ucsd.edu
630
631 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
632 NFS V3 Protocol
633 Mon Feb 14 10:58:25 2011 Mounting 4 remote test directories.
634 Child[000]: NFS negotiated block size 32768
635 Child[001]: NFS negotiated block size 32768
636 Child[003]: NFS negotiated block size 32768
637 Child[002]: NFS negotiated block size 32768
638 Mon Feb 14 10:58:41 2011 Completed.
639 Mon Feb 14 10:58:41 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
640 Mon Feb 14 10:58:41 2011 Completed.
641 Mon Feb 14 10:58:41 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
642 Mon Feb 14 10:58:41 2011 Received.
643
644 Mon Feb 14 10:58:41 2011 Initializing test directories.
645 Mon Feb 14 10:58:41 2011 Child 2 will create 167 directories.
646 Mon Feb 14 10:58:41 2011 Child 1 will create 167 directories.
647 Mon Feb 14 10:58:41 2011 Child 3 will create 167 directories.
648 Mon Feb 14 10:58:41 2011 Child 0 will create 167 directories.
649 Mon Feb 14 10:58:45 2011 Child 0 finished creating 167 directories.
650 Mon Feb 14 10:58:45 2011 Child 0 will create 5102 files.
651 Mon Feb 14 10:58:50 2011 Child 0 verified 5102 files, created 47
652 Mon Feb 14 10:58:50 2011 Child 0 will create 6 symlinks.
653 Mon Feb 14 10:58:50 2011 Child 0 finished creating 6 symlinks.
654 Mon Feb 14 10:58:51 2011 Child 1 finished creating 167 directories.
655 Mon Feb 14 10:58:51 2011 Child 1 will create 5102 files.
656 Mon Feb 14 10:58:54 2011 Child 2 finished creating 167 directories.
657 Mon Feb 14 10:58:54 2011 Child 2 will create 5102 files.
658 Mon Feb 14 10:58:54 2011 Child 1 verified 5102 files, created 50
659 Mon Feb 14 10:58:54 2011 Child 1 will create 6 symlinks.
660 Mon Feb 14 10:58:54 2011 Child 1 finished creating 6 symlinks.
661 Mon Feb 14 10:58:56 2011 Child 3 finished creating 167 directories.
662 Mon Feb 14 10:58:56 2011 Child 3 will create 5102 files.
663 Mon Feb 14 10:59:03 2011 Child 2 verified 5102 files, created 51
664 Mon Feb 14 10:59:03 2011 Child 2 will create 6 symlinks.
665 Mon Feb 14 10:59:03 2011 Child 2 finished creating 6 symlinks.
666 Mon Feb 14 10:59:07 2011 Child 3 verified 5102 files, created 47
667 Mon Feb 14 10:59:07 2011 Child 3 will create 6 symlinks.
668 Mon Feb 14 10:59:07 2011 Child 3 finished creating 6 symlinks.
669 Mon Feb 14 10:59:08 2011 Completed.
670 Mon Feb 14 10:59:08 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
671 Mon Feb 14 10:59:08 2011 Completed.
672 Mon Feb 14 10:59:08 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
673 Mon Feb 14 10:59:09 2011 Received.
674 Mon Feb 14 10:59:09 2011 Performing 300 seconds pretest warmup.
675 Child 0 - 50 aborted ops
676 Child 0 - 100 aborted ops
677 Child 0 - 150 aborted ops
678 Child 0 - 200 aborted ops
679 Child 0 - 250 aborted ops
680 Mon Feb 14 11:04:09 2011 Completed.
681 Mon Feb 14 11:04:09 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
682 Mon Feb 14 11:04:09 2011 Completed.
683 Mon Feb 14 11:04:09 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
684 Mon Feb 14 11:04:10 2011 Received.
685 Mon Feb 14 11:04:10 2011 Starting 300 seconds test run.
686 Child 3 - 50 aborted ops
687 Child 2 - 50 aborted ops
688 Child 0 - 300 aborted ops
689 Child 3 - 100 aborted ops
690 Child 1 - 50 aborted ops
691 Child 0 - 350 aborted ops
692 Child 3 - 150 aborted ops
693 Child 2 - 100 aborted ops
694 Child 1 - 100 aborted ops
695 Child 2 - 150 aborted ops
696 Child 0 - 400 aborted ops
697 Child 3 - 200 aborted ops
698 Child 1 - 150 aborted ops
699 Child 2 - 200 aborted ops
700 Child 2 - 250 aborted ops
701 Child 3 - 250 aborted ops
702 Child 0 - 450 aborted ops
703 Child 0 - 500 aborted ops
704 Child 1 - 200 aborted ops
705 Child 2 - 300 aborted ops
706 Child 3 - 300 aborted ops
707 Child 1 - 250 aborted ops
708 Child 2 - 350 aborted ops
709 Child 0 - 550 aborted ops
710 Child 1 - 300 aborted ops
711 Child 3 - 350 aborted ops
712 Child 2 - 400 aborted ops
713 Child 0 - 600 aborted ops
714 Child 2 - 450 aborted ops
715 SFS Single Client (c09-44) Results, Mon Feb 14 11:09:20 2011
716 --------------------------------------------------------------------------------------
717 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
718 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
719 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
720            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
721 --------------------------------------------------------------------------------------
722 getattr     26.0%    26.0%    76399    76399      0      0.17     0.09      0.00  1.1%
723 setattr      4.0%     4.1%    11919    11919      0     29.86    75.93      0.16 30.3%
724 lookup      24.0%    24.1%    71036    71036      0      0.18     0.09      0.00  1.1%
725 readlink     1.0%     1.0%     3013     3013      0      0.17     0.09      0.01  0.0%
726 read        18.0%    18.2%    53393    65731      0      0.85     6.44      0.02  3.9%
727 write       10.0%    10.1%    29592    35728      0      1.50    16.08      0.05  3.8%
728 create       1.0%     1.0%     2889     2889      0     42.41   110.71      0.38 10.4%
729 remove       1.0%     0.5%     1583     1583      0     29.63    78.96      0.44  4.0%
730 readdir      1.0%     1.0%     3026     3026      0      0.67     9.89      0.11  0.2%
731 fsstat       1.0%     1.0%     2903     2903      0      0.17     0.09      0.01  0.0%
732 access      11.0%    11.0%    32448    32448      0      0.17     0.09      0.00  0.5%
733 commit       0.0%     0.0%        0    17624      0      0.00     0.00      0.00 44.1%
734 readdirplus  2.0%     2.0%     5953     5953      0      1.13    10.52      0.08  0.6%
735 --------------------------------------------------------------------------------------
736
737       --------------------------------------------------
738       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
739       --------------------------+-----------------------
740 SFS NFS V3 THROUGHPUT:  983.79 Ops/Sec   AVG. RESPONSE TIME:    3.98 Msec/Op
741 TCP PROTOCOL
742 FAST CALLS: 0
743 NFS V3 MIXFILE: [ SFS Default ]
744 CLIENT REQUESTED LOAD: 1000 Ops/Sec 
745 TOTAL LOGICAL NFS V3 OPERATIONS:  294154         TEST TIME: 299 Sec 
746 TOTAL PHYSICAL NFS V3 OPERATIONS: 330252   
747 PHYSICAL NFS V3 THROUGHPUT: 1104.52 Ops/Sec
748 FILE SET SIZE CREATED: 10622124.0 KB
749 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
750
751 ------------------------------------------------------------------------
752
753 Mon Feb 14 11:09:20 2011 Completed.
754
755 Client Test Parameters: 
756         Number of processes = 4
757         Requested Load (NFS V3 operations/second) = 1000
758         Maximum number of outstanding biod writes = 2
759         Maximum number of outstanding biod reads = 2
760         Warm-up time (seconds) = 300
761         Run time (seconds) = 300
762         File Set = 20004 Files created for I/O operations
763                    6000 Files accessed for I/O operations
764                     404 Files for non-I/O operations
765                      24 Symlinks
766                     664 Directories
767                         Additional non-I/O files created as necessary
768
769
770 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
771 Mon Feb 14 11:09:20 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
772 Mon Feb 14 11:09:20 2011 Completed.
773 Mon Feb 14 11:09:20 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
774
775 ************************************************************************
776 Mon Feb 14 11:09:21 2011 Received.
777 Mon Feb 14 11:09:21 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
778 Mon Feb 14 11:09:21 2011 Completed.
779 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1200  -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 
780 NFS V3 Protocol Version
781
782 ************************************************************************
783 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
784 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
785
786 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
787 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
788
789 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 11:09:23 2011
790         Client hostname = c09-44
791         Prime Client hostname = c09-44.sysnet.ucsd.edu
792
793 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
794 NFS V3 Protocol
795 Mon Feb 14 11:09:23 2011 Mounting 4 remote test directories.
796 Child[000]: NFS negotiated block size 32768
797 Child[001]: NFS negotiated block size 32768
798 Child[002]: NFS negotiated block size 32768
799 Child[003]: NFS negotiated block size 32768
800 Mon Feb 14 11:09:34 2011 Completed.
801 Mon Feb 14 11:09:34 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
802 Mon Feb 14 11:09:34 2011 Completed.
803 Mon Feb 14 11:09:34 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
804 Mon Feb 14 11:09:39 2011 Received.
805
806 Mon Feb 14 11:09:39 2011 Initializing test directories.
807 Mon Feb 14 11:09:39 2011 Child 3 will create 167 directories.
808 Mon Feb 14 11:09:39 2011 Child 1 will create 167 directories.
809 Mon Feb 14 11:09:39 2011 Child 0 will create 167 directories.
810 Mon Feb 14 11:09:39 2011 Child 2 will create 167 directories.
811 Mon Feb 14 11:09:42 2011 Child 1 finished creating 167 directories.
812 Mon Feb 14 11:09:42 2011 Child 1 will create 5102 files.
813 Mon Feb 14 11:09:45 2011 Child 2 finished creating 167 directories.
814 Mon Feb 14 11:09:45 2011 Child 2 will create 5102 files.
815 Mon Feb 14 11:09:46 2011 Child 1 verified 5102 files, created 51
816 Mon Feb 14 11:09:46 2011 Child 1 will create 6 symlinks.
817 Mon Feb 14 11:09:46 2011 Child 1 finished creating 6 symlinks.
818 Mon Feb 14 11:09:48 2011 Child 3 finished creating 167 directories.
819 Mon Feb 14 11:09:48 2011 Child 3 will create 5102 files.
820 Mon Feb 14 11:09:50 2011 Child 0 finished creating 167 directories.
821 Mon Feb 14 11:09:50 2011 Child 0 will create 5102 files.
822 Mon Feb 14 11:09:53 2011 Child 2 verified 5102 files, created 51
823 Mon Feb 14 11:09:53 2011 Child 2 will create 6 symlinks.
824 Mon Feb 14 11:09:53 2011 Child 2 finished creating 6 symlinks.
825 Mon Feb 14 11:10:02 2011 Child 3 verified 5102 files, created 51
826 Mon Feb 14 11:10:02 2011 Child 3 will create 6 symlinks.
827 Mon Feb 14 11:10:02 2011 Child 3 finished creating 6 symlinks.
828 Mon Feb 14 11:10:03 2011 Child 0 verified 5102 files, created 51
829 Mon Feb 14 11:10:03 2011 Child 0 will create 6 symlinks.
830 Mon Feb 14 11:10:03 2011 Child 0 finished creating 6 symlinks.
831 Mon Feb 14 11:10:03 2011 Completed.
832 Mon Feb 14 11:10:03 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
833 Mon Feb 14 11:10:03 2011 Completed.
834 Mon Feb 14 11:10:03 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
835 Mon Feb 14 11:10:04 2011 Received.
836 Mon Feb 14 11:10:04 2011 Performing 300 seconds pretest warmup.
837 Mon Feb 14 11:15:04 2011 Completed.
838 Mon Feb 14 11:15:04 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
839 Mon Feb 14 11:15:04 2011 Completed.
840 Mon Feb 14 11:15:04 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
841 Mon Feb 14 11:15:05 2011 Received.
842 Mon Feb 14 11:15:05 2011 Starting 300 seconds test run.
843 Child 2 - 50 aborted ops
844 Child 2 - 100 aborted ops
845 Child 0 - 50 aborted ops
846 Child 3 - 50 aborted ops
847 Child 1 - 50 aborted ops
848 Child 2 - 150 aborted ops
849 Child 3 - 100 aborted ops
850 Child 0 - 100 aborted ops
851 Child 1 - 100 aborted ops
852 Child 0 - 150 aborted ops
853 Child 2 - 200 aborted ops
854 Child 3 - 150 aborted ops
855 Child 2 - 250 aborted ops
856 Child 0 - 200 aborted ops
857 Child 1 - 150 aborted ops
858 Child 3 - 200 aborted ops
859 Child 0 - 250 aborted ops
860 Child 2 - 300 aborted ops
861 Child 3 - 250 aborted ops
862 Child 0 - 300 aborted ops
863 Child 1 - 200 aborted ops
864 Child 2 - 350 aborted ops
865 Child 0 - 350 aborted ops
866 Child 3 - 300 aborted ops
867 Child 1 - 250 aborted ops
868 SFS Single Client (c09-44) Results, Mon Feb 14 11:20:15 2011
869 --------------------------------------------------------------------------------------
870 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
871 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
872 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
873            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
874 --------------------------------------------------------------------------------------
875 getattr     26.0%    26.1%    76900    76900      0      0.17     0.09      0.00  1.1%
876 setattr      4.0%     4.0%    11860    11860      0     29.87    67.91      0.15 29.3%
877 lookup      24.0%    24.1%    70899    70899      0      0.18     0.09      0.00  1.1%
878 readlink     1.0%     1.0%     2994     2994      0      0.18     0.09      0.01  0.0%
879 read        18.0%    18.2%    53603    65461      0      0.89     9.65      0.03  3.9%
880 write       10.0%    10.0%    29418    35531      0      1.64    17.48      0.05  4.0%
881 create       1.0%     1.0%     3030     3030      0     46.86   131.53      0.41 11.7%
882 remove       1.0%     0.5%     1609     1609      0     31.77    81.00      0.44  4.2%
883 readdir      1.0%     1.0%     2987     2987      0      0.57     3.98      0.07  0.1%
884 fsstat       1.0%     1.0%     2923     2923      0      0.17     0.08      0.01  0.0%
885 access      11.0%    11.0%    32268    32268      0      0.17     0.09      0.00  0.5%
886 commit       0.0%     0.0%        0    17477      0      0.00     0.00      0.00 43.5%
887 readdirplus  2.0%     2.0%     6021     6021      0      0.94     1.60      0.03  0.5%
888 --------------------------------------------------------------------------------------
889
890       --------------------------------------------------
891       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
892       --------------------------+-----------------------
893 SFS NFS V3 THROUGHPUT:  984.98 Ops/Sec   AVG. RESPONSE TIME:    4.10 Msec/Op
894 TCP PROTOCOL
895 FAST CALLS: 0
896 NFS V3 MIXFILE: [ SFS Default ]
897 CLIENT REQUESTED LOAD: 1200 Ops/Sec 
898 TOTAL LOGICAL NFS V3 OPERATIONS:  294512         TEST TIME: 299 Sec 
899 TOTAL PHYSICAL NFS V3 OPERATIONS: 329960   
900 PHYSICAL NFS V3 THROUGHPUT: 1103.54 Ops/Sec
901 FILE SET SIZE CREATED: 10622124.0 KB
902 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
903
904 ------------------------------------------------------------------------
905
906 Mon Feb 14 11:20:15 2011 Completed.
907
908 Client Test Parameters: 
909         Number of processes = 4
910         Requested Load (NFS V3 operations/second) = 1200
911         Maximum number of outstanding biod writes = 2
912         Maximum number of outstanding biod reads = 2
913         Warm-up time (seconds) = 300
914         Run time (seconds) = 300
915         File Set = 20004 Files created for I/O operations
916                    6000 Files accessed for I/O operations
917                     404 Files for non-I/O operations
918                      24 Symlinks
919                     664 Directories
920                         Additional non-I/O files created as necessary
921
922
923 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
924 Mon Feb 14 11:20:15 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
925 Mon Feb 14 11:20:15 2011 Completed.
926 Mon Feb 14 11:20:15 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
927
928 ************************************************************************
929 Mon Feb 14 11:20:16 2011 Received.
930 Mon Feb 14 11:20:16 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
931 Mon Feb 14 11:20:16 2011 Completed.
932 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1400  -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 
933 NFS V3 Protocol Version
934
935 ************************************************************************
936 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
937 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
938
939 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
940 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
941
942 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 11:20:18 2011
943         Client hostname = c09-44
944         Prime Client hostname = c09-44.sysnet.ucsd.edu
945
946 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
947 NFS V3 Protocol
948 Mon Feb 14 11:20:18 2011 Mounting 4 remote test directories.
949 Child[000]: NFS negotiated block size 32768
950 Child[001]: NFS negotiated block size 32768
951 Child[002]: NFS negotiated block size 32768
952 Child[003]: NFS negotiated block size 32768
953 Mon Feb 14 11:20:29 2011 Completed.
954 Mon Feb 14 11:20:29 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
955 Mon Feb 14 11:20:29 2011 Completed.
956 Mon Feb 14 11:20:29 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
957 Mon Feb 14 11:20:34 2011 Received.
958
959 Mon Feb 14 11:20:34 2011 Initializing test directories.
960 Mon Feb 14 11:20:34 2011 Child 0 will create 167 directories.
961 Mon Feb 14 11:20:34 2011 Child 2 will create 167 directories.
962 Mon Feb 14 11:20:34 2011 Child 3 will create 167 directories.
963 Mon Feb 14 11:20:34 2011 Child 1 will create 167 directories.
964 Mon Feb 14 11:20:34 2011 Child 2 finished creating 167 directories.
965 Mon Feb 14 11:20:34 2011 Child 2 will create 5102 files.
966 Mon Feb 14 11:20:34 2011 Child 0 finished creating 167 directories.
967 Mon Feb 14 11:20:34 2011 Child 0 will create 5102 files.
968 Mon Feb 14 11:20:37 2011 Child 3 finished creating 167 directories.
969 Mon Feb 14 11:20:37 2011 Child 3 will create 5102 files.
970 Mon Feb 14 11:20:43 2011 Child 2 verified 5102 files, created 49
971 Mon Feb 14 11:20:43 2011 Child 2 will create 6 symlinks.
972 Mon Feb 14 11:20:43 2011 Child 2 finished creating 6 symlinks.
973 Mon Feb 14 11:20:43 2011 Child 0 verified 5102 files, created 51
974 Mon Feb 14 11:20:43 2011 Child 0 will create 6 symlinks.
975 Mon Feb 14 11:20:43 2011 Child 0 finished creating 6 symlinks.
976 Mon Feb 14 11:20:46 2011 Child 3 verified 5102 files, created 51
977 Mon Feb 14 11:20:46 2011 Child 3 will create 6 symlinks.
978 Mon Feb 14 11:20:46 2011 Child 3 finished creating 6 symlinks.
979 Mon Feb 14 11:20:48 2011 Child 1 finished creating 167 directories.
980 Mon Feb 14 11:20:48 2011 Child 1 will create 5102 files.
981 Mon Feb 14 11:20:55 2011 Child 1 verified 5102 files, created 51
982 Mon Feb 14 11:20:55 2011 Child 1 will create 6 symlinks.
983 Mon Feb 14 11:20:55 2011 Child 1 finished creating 6 symlinks.
984 Mon Feb 14 11:20:55 2011 Completed.
985 Mon Feb 14 11:20:55 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
986 Mon Feb 14 11:20:55 2011 Completed.
987 Mon Feb 14 11:20:55 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
988 Mon Feb 14 11:20:56 2011 Received.
989 Mon Feb 14 11:20:56 2011 Performing 300 seconds pretest warmup.
990 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 200  -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 
991 NFS V3 Protocol Version
992
993 ************************************************************************
994 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
995 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
996
997 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
998 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
999
1000 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 11:29:24 2011
1001         Client hostname = c09-44
1002         Prime Client hostname = c09-44.sysnet.ucsd.edu
1003
1004 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1005 NFS V3 Protocol
1006 Mon Feb 14 11:29:24 2011 Mounting 4 remote test directories.
1007 Child[000]: NFS negotiated block size 32768
1008 Child[002]: NFS negotiated block size 32768
1009 Child[003]: NFS negotiated block size 32768
1010 Child[001]: NFS negotiated block size 32768
1011 Mon Feb 14 11:29:40 2011 Completed.
1012 Mon Feb 14 11:29:40 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1013 Mon Feb 14 11:29:40 2011 Completed.
1014 Mon Feb 14 11:29:40 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1015 Mon Feb 14 11:29:40 2011 Received.
1016
1017 Mon Feb 14 11:29:40 2011 Initializing test directories.
1018 Mon Feb 14 11:29:40 2011 Child 1 will create 167 directories.
1019 Mon Feb 14 11:29:40 2011 Child 2 will create 167 directories.
1020 Mon Feb 14 11:29:40 2011 Child 3 will create 167 directories.
1021 Mon Feb 14 11:29:40 2011 Child 0 will create 167 directories.
1022 Mon Feb 14 11:29:41 2011 Child 0 finished creating 167 directories.
1023 Mon Feb 14 11:29:41 2011 Child 0 will create 5102 files.
1024 Mon Feb 14 11:29:41 2011 Child 1 finished creating 167 directories.
1025 Mon Feb 14 11:29:41 2011 Child 1 will create 5102 files.
1026 Mon Feb 14 11:29:41 2011 Child 2 finished creating 167 directories.
1027 Mon Feb 14 11:29:41 2011 Child 2 will create 5102 files.
1028 Mon Feb 14 11:29:41 2011 Child 3 finished creating 167 directories.
1029 Mon Feb 14 11:29:41 2011 Child 3 will create 5102 files.
1030 Mon Feb 14 11:34:45 2011 Child 1 verified 2652 files (2652 creates).
1031 Mon Feb 14 11:34:45 2011 Child 0 verified 2542 files (2542 creates).
1032 Mon Feb 14 11:34:45 2011 Child 2 verified 2542 files (2542 creates).
1033 Mon Feb 14 11:34:45 2011 Child 3 verified 2539 files (2539 creates).
1034 Mon Feb 14 11:39:43 2011 Child 2 verified 4528 files (4528 creates).
1035 Mon Feb 14 11:39:43 2011 Child 1 verified 4623 files (4623 creates).
1036 Mon Feb 14 11:39:51 2011 Child 0 verified 4514 files (4514 creates).
1037 Mon Feb 14 11:39:51 2011 Child 3 verified 4514 files (4514 creates).
1038 Mon Feb 14 11:41:02 2011 Child 1 verified 5102 files, created 5052
1039 Mon Feb 14 11:41:02 2011 Child 1 will create 6 symlinks.
1040 Mon Feb 14 11:41:02 2011 Child 1 finished creating 6 symlinks.
1041 Mon Feb 14 11:41:10 2011 Child 2 verified 5102 files, created 5052
1042 Mon Feb 14 11:41:10 2011 Child 2 will create 6 symlinks.
1043 Mon Feb 14 11:41:10 2011 Child 2 finished creating 6 symlinks.
1044 Mon Feb 14 11:41:15 2011 Child 3 verified 5102 files, created 5052
1045 Mon Feb 14 11:41:15 2011 Child 3 will create 6 symlinks.
1046 Mon Feb 14 11:41:15 2011 Child 3 finished creating 6 symlinks.
1047 Mon Feb 14 11:41:18 2011 Child 0 verified 5102 files, created 5052
1048 Mon Feb 14 11:41:18 2011 Child 0 will create 6 symlinks.
1049 Mon Feb 14 11:41:18 2011 Child 0 finished creating 6 symlinks.
1050 Mon Feb 14 11:41:19 2011 Completed.
1051 Mon Feb 14 11:41:19 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1052 Mon Feb 14 11:41:19 2011 Completed.
1053 Mon Feb 14 11:41:19 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1054 Mon Feb 14 11:41:20 2011 Received.
1055 Mon Feb 14 11:41:20 2011 Performing 300 seconds pretest warmup.
1056 Mon Feb 14 11:46:20 2011 Completed.
1057 Mon Feb 14 11:46:20 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1058 Mon Feb 14 11:46:20 2011 Completed.
1059 Mon Feb 14 11:46:20 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1060 Mon Feb 14 11:46:21 2011 Received.
1061 Mon Feb 14 11:46:21 2011 Starting 300 seconds test run.
1062 SFS Single Client (c09-44) Results, Mon Feb 14 11:51:31 2011
1063 --------------------------------------------------------------------------------------
1064 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
1065 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
1066 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1067            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
1068 --------------------------------------------------------------------------------------
1069 getattr     26.0%    26.3%    15833    15833      0      0.21     0.72      0.01  0.7%
1070 setattr      4.0%     4.0%     2431     2431      0      7.14    28.82      0.21  3.9%
1071 lookup      24.0%    23.8%    14340    14340      0      0.21     0.74      0.01  0.7%
1072 readlink     1.0%     1.0%      606      606      0      0.21     0.86      0.07  0.0%
1073 read        18.0%    18.0%    10861    13344      0     23.08   214.99      0.28 55.7%
1074 write       10.0%    10.0%     6004     7251      0     19.82   162.83      0.32 26.5%
1075 create       1.0%     1.1%      658      658      0     11.38    43.27      0.50  1.7%
1076 remove       1.0%     1.0%      615      615      0      9.52    29.82      0.43  1.3%
1077 readdir      1.0%     0.9%      571      571      0      0.40     0.55      0.06  0.1%
1078 fsstat       1.0%     1.0%      579      579      0      0.24     1.40      0.10  0.0%
1079 access      11.0%    10.9%     6574     6574      0      0.20     0.76      0.02  0.3%
1080 commit       0.0%     0.0%        0     3167      0      0.00     0.00      0.00  9.0%
1081 readdirplus  2.0%     2.0%     1188     1188      0      0.69     0.57      0.04  0.2%
1082 --------------------------------------------------------------------------------------
1083
1084       --------------------------------------------------
1085       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1086       --------------------------+-----------------------
1087 SFS NFS V3 THROUGHPUT:  201.53 Ops/Sec   AVG. RESPONSE TIME:    7.46 Msec/Op
1088 TCP PROTOCOL
1089 FAST CALLS: 0
1090 NFS V3 MIXFILE: [ SFS Default ]
1091 CLIENT REQUESTED LOAD: 200 Ops/Sec 
1092 TOTAL LOGICAL NFS V3 OPERATIONS:  60260          TEST TIME: 299 Sec 
1093 TOTAL PHYSICAL NFS V3 OPERATIONS: 67157    
1094 PHYSICAL NFS V3 THROUGHPUT:  224.60 Ops/Sec
1095 FILE SET SIZE CREATED: 10622124.0 KB
1096 FILE SET SIZE ACCESSED: 3188124.0 - 3327292.0 KB  (100.00% to 104.37% of Base)
1097
1098 ------------------------------------------------------------------------
1099
1100 Mon Feb 14 11:51:31 2011 Completed.
1101
1102 Client Test Parameters: 
1103         Number of processes = 4
1104         Requested Load (NFS V3 operations/second) = 200
1105         Maximum number of outstanding biod writes = 2
1106         Maximum number of outstanding biod reads = 2
1107         Warm-up time (seconds) = 300
1108         Run time (seconds) = 300
1109         File Set = 20004 Files created for I/O operations
1110                    6000 Files accessed for I/O operations
1111                     404 Files for non-I/O operations
1112                      24 Symlinks
1113                     664 Directories
1114                         Additional non-I/O files created as necessary
1115
1116
1117 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1118 Mon Feb 14 11:51:31 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1119 Mon Feb 14 11:51:31 2011 Completed.
1120 Mon Feb 14 11:51:31 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1121
1122 ************************************************************************
1123 Mon Feb 14 11:51:32 2011 Received.
1124 Mon Feb 14 11:51:32 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1125 Mon Feb 14 11:51:32 2011 Completed.
1126 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 400  -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 
1127 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1128 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1129
1130 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1131 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1132 NFS V3 Protocol Version
1133
1134 ************************************************************************
1135
1136 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 11:51:34 2011
1137         Client hostname = c09-44
1138         Prime Client hostname = c09-44.sysnet.ucsd.edu
1139
1140 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1141 NFS V3 Protocol
1142 Mon Feb 14 11:51:34 2011 Mounting 4 remote test directories.
1143 Child[000]: NFS negotiated block size 32768
1144 Child[001]: NFS negotiated block size 32768
1145 Child[002]: NFS negotiated block size 32768
1146 Child[003]: NFS negotiated block size 32768
1147 Mon Feb 14 11:51:45 2011 Completed.
1148 Mon Feb 14 11:51:45 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1149 Mon Feb 14 11:51:45 2011 Completed.
1150 Mon Feb 14 11:51:45 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1151 Mon Feb 14 11:51:50 2011 Received.
1152
1153 Mon Feb 14 11:51:50 2011 Initializing test directories.
1154 Mon Feb 14 11:51:50 2011 Child 3 will create 167 directories.
1155 Mon Feb 14 11:51:50 2011 Child 0 will create 167 directories.
1156 Mon Feb 14 11:51:50 2011 Child 2 will create 167 directories.
1157 Mon Feb 14 11:51:50 2011 Child 1 will create 167 directories.
1158 Mon Feb 14 11:51:55 2011 Child 1 finished creating 167 directories.
1159 Mon Feb 14 11:51:55 2011 Child 1 will create 5102 files.
1160 Mon Feb 14 11:51:57 2011 Child 2 finished creating 167 directories.
1161 Mon Feb 14 11:51:57 2011 Child 2 will create 5102 files.
1162 Mon Feb 14 11:51:58 2011 Child 1 verified 5102 files, created 23
1163 Mon Feb 14 11:51:58 2011 Child 1 will create 6 symlinks.
1164 Mon Feb 14 11:51:58 2011 Child 1 finished creating 6 symlinks.
1165 Mon Feb 14 11:52:00 2011 Child 3 finished creating 167 directories.
1166 Mon Feb 14 11:52:00 2011 Child 3 will create 5102 files.
1167 Mon Feb 14 11:52:01 2011 Child 2 verified 5102 files, created 22
1168 Mon Feb 14 11:52:01 2011 Child 2 will create 6 symlinks.
1169 Mon Feb 14 11:52:01 2011 Child 2 finished creating 6 symlinks.
1170 Mon Feb 14 11:52:03 2011 Child 0 finished creating 167 directories.
1171 Mon Feb 14 11:52:03 2011 Child 0 will create 5102 files.
1172 Mon Feb 14 11:52:04 2011 Child 3 verified 5102 files, created 26
1173 Mon Feb 14 11:52:04 2011 Child 3 will create 6 symlinks.
1174 Mon Feb 14 11:52:04 2011 Child 3 finished creating 6 symlinks.
1175 Mon Feb 14 11:52:06 2011 Child 0 verified 5102 files, created 24
1176 Mon Feb 14 11:52:06 2011 Child 0 will create 6 symlinks.
1177 Mon Feb 14 11:52:06 2011 Child 0 finished creating 6 symlinks.
1178 Mon Feb 14 11:52:06 2011 Completed.
1179 Mon Feb 14 11:52:06 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1180 Mon Feb 14 11:52:06 2011 Completed.
1181 Mon Feb 14 11:52:06 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1182 Mon Feb 14 11:52:07 2011 Received.
1183 Mon Feb 14 11:52:07 2011 Performing 300 seconds pretest warmup.
1184 Mon Feb 14 11:57:07 2011 Completed.
1185 Mon Feb 14 11:57:07 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1186 Mon Feb 14 11:57:07 2011 Completed.
1187 Mon Feb 14 11:57:07 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1188 Mon Feb 14 11:57:08 2011 Received.
1189 Mon Feb 14 11:57:08 2011 Starting 300 seconds test run.
1190 SFS Single Client (c09-44) Results, Mon Feb 14 12:02:19 2011
1191 --------------------------------------------------------------------------------------
1192 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
1193 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
1194 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1195            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
1196 --------------------------------------------------------------------------------------
1197 getattr     26.0%    25.9%    31212    31212      0      0.18     0.16      0.00  2.3%
1198 setattr      4.0%     4.0%     4841     4841      0      3.36     5.68      0.07  6.7%
1199 lookup      24.0%    24.1%    28974    28974      0      0.18     0.05      0.00  2.2%
1200 readlink     1.0%     1.0%     1191     1191      0      0.18     0.03      0.01  0.1%
1201 read        18.0%    18.0%    21656    26396      0      3.46    29.38      0.07 30.8%
1202 write       10.0%     9.8%    11854    14245      0      8.41    33.10      0.10 41.1%
1203 create       1.0%     1.0%     1183     1183      0      4.90     6.38      0.14  2.4%
1204 remove       1.0%     1.0%     1171     1171      0      3.37     5.60      0.14  1.6%
1205 readdir      1.0%     0.9%     1141     1141      0      0.37     0.08      0.02  0.2%
1206 fsstat       1.0%     1.0%     1211     1211      0      0.18     0.04      0.01  0.1%
1207 access      11.0%    11.2%    13466    13466      0      0.18     0.29      0.01  1.0%
1208 commit       0.0%     0.0%        0     6806      0      0.00     0.00      0.00 10.8%
1209 readdirplus  2.0%     2.1%     2471     2471      0      0.67     0.08      0.01  0.7%
1210 --------------------------------------------------------------------------------------
1211
1212       --------------------------------------------------
1213       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1214       --------------------------+-----------------------
1215 SFS NFS V3 THROUGHPUT:  401.23 Ops/Sec   AVG. RESPONSE TIME:    2.01 Msec/Op
1216 TCP PROTOCOL
1217 FAST CALLS: 0
1218 NFS V3 MIXFILE: [ SFS Default ]
1219 CLIENT REQUESTED LOAD: 400 Ops/Sec 
1220 TOTAL LOGICAL NFS V3 OPERATIONS:  120371         TEST TIME: 300 Sec 
1221 TOTAL PHYSICAL NFS V3 OPERATIONS: 134308   
1222 PHYSICAL NFS V3 THROUGHPUT:  447.69 Ops/Sec
1223 FILE SET SIZE CREATED: 10622124.0 KB
1224 FILE SET SIZE ACCESSED: 3188124.0 - 3458931.0 KB  (100.00% to 108.49% of Base)
1225
1226 ------------------------------------------------------------------------
1227
1228 Mon Feb 14 12:02:19 2011 Completed.
1229
1230 Client Test Parameters: 
1231         Number of processes = 4
1232         Requested Load (NFS V3 operations/second) = 400
1233         Maximum number of outstanding biod writes = 2
1234         Maximum number of outstanding biod reads = 2
1235         Warm-up time (seconds) = 300
1236         Run time (seconds) = 300
1237         File Set = 20004 Files created for I/O operations
1238                    6000 Files accessed for I/O operations
1239                     404 Files for non-I/O operations
1240                      24 Symlinks
1241                     664 Directories
1242                         Additional non-I/O files created as necessary
1243
1244
1245 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1246 Mon Feb 14 12:02:19 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1247 Mon Feb 14 12:02:19 2011 Completed.
1248 Mon Feb 14 12:02:19 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1249
1250 ************************************************************************
1251 Mon Feb 14 12:02:19 2011 Received.
1252 Mon Feb 14 12:02:19 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1253 Mon Feb 14 12:02:19 2011 Completed.
1254 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 600  -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 
1255 NFS V3 Protocol Version
1256
1257 ************************************************************************
1258 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1259 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1260
1261 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1262 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1263
1264 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 12:02:21 2011
1265         Client hostname = c09-44
1266         Prime Client hostname = c09-44.sysnet.ucsd.edu
1267
1268 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1269 NFS V3 Protocol
1270 Mon Feb 14 12:02:21 2011 Mounting 4 remote test directories.
1271 Child[001]: NFS negotiated block size 32768
1272 Child[002]: NFS negotiated block size 32768
1273 Child[003]: NFS negotiated block size 32768
1274 Child[000]: NFS negotiated block size 32768
1275 Mon Feb 14 12:02:37 2011 Completed.
1276 Mon Feb 14 12:02:37 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1277 Mon Feb 14 12:02:37 2011 Completed.
1278 Mon Feb 14 12:02:37 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1279 Mon Feb 14 12:02:37 2011 Received.
1280
1281 Mon Feb 14 12:02:37 2011 Initializing test directories.
1282 Mon Feb 14 12:02:37 2011 Child 2 will create 167 directories.
1283 Mon Feb 14 12:02:37 2011 Child 1 will create 167 directories.
1284 Mon Feb 14 12:02:37 2011 Child 3 will create 167 directories.
1285 Mon Feb 14 12:02:37 2011 Child 0 will create 167 directories.
1286 Mon Feb 14 12:02:38 2011 Child 2 finished creating 167 directories.
1287 Mon Feb 14 12:02:38 2011 Child 2 will create 5102 files.
1288 Mon Feb 14 12:02:41 2011 Child 3 finished creating 167 directories.
1289 Mon Feb 14 12:02:41 2011 Child 3 will create 5102 files.
1290 Mon Feb 14 12:02:42 2011 Child 2 verified 5102 files, created 20
1291 Mon Feb 14 12:02:42 2011 Child 2 will create 6 symlinks.
1292 Mon Feb 14 12:02:42 2011 Child 2 finished creating 6 symlinks.
1293 Mon Feb 14 12:02:44 2011 Child 3 verified 5102 files, created 31
1294 Mon Feb 14 12:02:44 2011 Child 3 will create 6 symlinks.
1295 Mon Feb 14 12:02:45 2011 Child 3 finished creating 6 symlinks.
1296 Mon Feb 14 12:02:46 2011 Child 0 finished creating 167 directories.
1297 Mon Feb 14 12:02:46 2011 Child 0 will create 5102 files.
1298 Mon Feb 14 12:02:49 2011 Child 0 verified 5102 files, created 14
1299 Mon Feb 14 12:02:49 2011 Child 0 will create 6 symlinks.
1300 Mon Feb 14 12:02:49 2011 Child 0 finished creating 6 symlinks.
1301 Mon Feb 14 12:02:52 2011 Child 1 finished creating 167 directories.
1302 Mon Feb 14 12:02:52 2011 Child 1 will create 5102 files.
1303 Mon Feb 14 12:02:56 2011 Child 1 verified 5102 files, created 10
1304 Mon Feb 14 12:02:56 2011 Child 1 will create 6 symlinks.
1305 Mon Feb 14 12:02:56 2011 Child 1 finished creating 6 symlinks.
1306 Mon Feb 14 12:02:57 2011 Completed.
1307 Mon Feb 14 12:02:57 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1308 Mon Feb 14 12:02:57 2011 Completed.
1309 Mon Feb 14 12:02:57 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1310 Mon Feb 14 12:02:58 2011 Received.
1311 Mon Feb 14 12:02:58 2011 Performing 300 seconds pretest warmup.
1312 Child 3 - 50 aborted ops
1313 Child 3 - 100 aborted ops
1314 Child 1 - 50 aborted ops
1315 Child 1 - 100 aborted ops
1316 Child 1 - 150 aborted ops
1317 Child 1 - 200 aborted ops
1318 Mon Feb 14 12:07:58 2011 Completed.
1319 Mon Feb 14 12:07:58 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1320 Mon Feb 14 12:07:58 2011 Completed.
1321 Mon Feb 14 12:07:58 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1322 Mon Feb 14 12:07:59 2011 Received.
1323 Mon Feb 14 12:07:59 2011 Starting 300 seconds test run.
1324 Child 1 - 250 aborted ops
1325 Child 1 - 300 aborted ops
1326 Child 1 - 350 aborted ops
1327 Child 1 - 400 aborted ops
1328 Child 0 - 50 aborted ops
1329 SFS Single Client (c09-44) Results, Mon Feb 14 12:13:09 2011
1330 --------------------------------------------------------------------------------------
1331 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
1332 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
1333 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1334            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
1335 --------------------------------------------------------------------------------------
1336 getattr     26.0%    26.1%    47554    47554      0      0.18     0.07      0.00  2.5%
1337 setattr      4.0%     4.1%     7422     7422      0      4.32     6.72      0.06  9.1%
1338 lookup      24.0%    23.9%    43612    43612      0      0.19     0.07      0.00  2.3%
1339 readlink     1.0%     1.0%     1803     1803      0      0.18     0.06      0.01  0.1%
1340 read        18.0%    17.9%    32605    39958      0      2.71    25.37      0.05 25.2%
1341 write       10.0%    10.0%    18199    22076      0      7.85    33.74      0.08 40.8%
1342 create       1.0%     1.0%     1905     1905      0      5.53     7.57      0.12  3.0%
1343 remove       1.0%     0.9%     1669     1669      0      4.00     5.90      0.12  1.9%
1344 readdir      1.0%     1.0%     1845     1845      0      0.38     0.10      0.01  0.2%
1345 fsstat       1.0%     1.0%     1801     1801      0      0.18     0.05      0.01  0.1%
1346 access      11.0%    11.0%    20045    20045      0      0.18     0.07      0.00  1.0%
1347 commit       0.0%     0.0%        0    10721      0      0.00     0.00      0.00 13.1%
1348 readdirplus  2.0%     2.0%     3668     3668      0      0.67     0.10      0.01  0.7%
1349 --------------------------------------------------------------------------------------
1350
1351       --------------------------------------------------
1352       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1353       --------------------------+-----------------------
1354 SFS NFS V3 THROUGHPUT:  609.12 Ops/Sec   AVG. RESPONSE TIME:    1.92 Msec/Op
1355 TCP PROTOCOL
1356 FAST CALLS: 0
1357 NFS V3 MIXFILE: [ SFS Default ]
1358 CLIENT REQUESTED LOAD: 600 Ops/Sec 
1359 TOTAL LOGICAL NFS V3 OPERATIONS:  182128         TEST TIME: 299 Sec 
1360 TOTAL PHYSICAL NFS V3 OPERATIONS: 204079   
1361 PHYSICAL NFS V3 THROUGHPUT:  682.53 Ops/Sec
1362 FILE SET SIZE CREATED: 10622124.0 KB
1363 FILE SET SIZE ACCESSED: 3188124.0 - 3513167.0 KB  (100.00% to 110.20% of Base)
1364
1365 ------------------------------------------------------------------------
1366
1367 Mon Feb 14 12:13:09 2011 Completed.
1368
1369 Client Test Parameters: 
1370         Number of processes = 4
1371         Requested Load (NFS V3 operations/second) = 600
1372         Maximum number of outstanding biod writes = 2
1373         Maximum number of outstanding biod reads = 2
1374         Warm-up time (seconds) = 300
1375         Run time (seconds) = 300
1376         File Set = 20004 Files created for I/O operations
1377                    6000 Files accessed for I/O operations
1378                     404 Files for non-I/O operations
1379                      24 Symlinks
1380                     664 Directories
1381                         Additional non-I/O files created as necessary
1382
1383
1384 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1385 Mon Feb 14 12:13:09 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1386 Mon Feb 14 12:13:09 2011 Completed.
1387 Mon Feb 14 12:13:09 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1388
1389 ************************************************************************
1390 Mon Feb 14 12:13:10 2011 Received.
1391 Mon Feb 14 12:13:10 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1392 Mon Feb 14 12:13:10 2011 Completed.
1393 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 800  -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 
1394 NFS V3 Protocol Version
1395
1396 ************************************************************************
1397 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1398 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1399
1400 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1401 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1402
1403 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 12:13:12 2011
1404         Client hostname = c09-44
1405         Prime Client hostname = c09-44.sysnet.ucsd.edu
1406
1407 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1408 NFS V3 Protocol
1409 Mon Feb 14 12:13:12 2011 Mounting 4 remote test directories.
1410 Child[001]: NFS negotiated block size 32768
1411 Child[002]: NFS negotiated block size 32768
1412 Child[003]: NFS negotiated block size 32768
1413 Child[000]: NFS negotiated block size 32768
1414 Mon Feb 14 12:13:28 2011 Completed.
1415 Mon Feb 14 12:13:28 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1416 Mon Feb 14 12:13:28 2011 Completed.
1417 Mon Feb 14 12:13:28 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1418 Mon Feb 14 12:13:28 2011 Received.
1419
1420 Mon Feb 14 12:13:28 2011 Initializing test directories.
1421 Mon Feb 14 12:13:28 2011 Child 2 will create 167 directories.
1422 Mon Feb 14 12:13:28 2011 Child 0 will create 167 directories.
1423 Mon Feb 14 12:13:28 2011 Child 3 will create 167 directories.
1424 Mon Feb 14 12:13:28 2011 Child 1 will create 167 directories.
1425 Mon Feb 14 12:13:31 2011 Child 2 finished creating 167 directories.
1426 Mon Feb 14 12:13:31 2011 Child 2 will create 5102 files.
1427 Mon Feb 14 12:13:35 2011 Child 2 verified 5102 files, created 51
1428 Mon Feb 14 12:13:35 2011 Child 2 will create 6 symlinks.
1429 Mon Feb 14 12:13:35 2011 Child 2 finished creating 6 symlinks.
1430 Mon Feb 14 12:13:42 2011 Child 3 finished creating 167 directories.
1431 Mon Feb 14 12:13:42 2011 Child 3 will create 5102 files.
1432 Mon Feb 14 12:13:43 2011 Child 0 finished creating 167 directories.
1433 Mon Feb 14 12:13:43 2011 Child 0 will create 5102 files.
1434 Mon Feb 14 12:13:45 2011 Child 1 finished creating 167 directories.
1435 Mon Feb 14 12:13:45 2011 Child 1 will create 5102 files.
1436 Mon Feb 14 12:13:48 2011 Child 3 verified 5102 files, created 45
1437 Mon Feb 14 12:13:48 2011 Child 3 will create 6 symlinks.
1438 Mon Feb 14 12:13:48 2011 Child 3 finished creating 6 symlinks.
1439 Mon Feb 14 12:13:49 2011 Child 0 verified 5102 files, created 51
1440 Mon Feb 14 12:13:49 2011 Child 0 will create 6 symlinks.
1441 Mon Feb 14 12:13:49 2011 Child 0 finished creating 6 symlinks.
1442 Mon Feb 14 12:13:50 2011 Child 1 verified 5102 files, created 43
1443 Mon Feb 14 12:13:50 2011 Child 1 will create 6 symlinks.
1444 Mon Feb 14 12:13:50 2011 Child 1 finished creating 6 symlinks.
1445 Mon Feb 14 12:13:50 2011 Completed.
1446 Mon Feb 14 12:13:50 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1447 Mon Feb 14 12:13:50 2011 Completed.
1448 Mon Feb 14 12:13:50 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1449 Mon Feb 14 12:13:51 2011 Received.
1450 Mon Feb 14 12:13:51 2011 Performing 300 seconds pretest warmup.
1451 Child 2 - 50 aborted ops
1452 Mon Feb 14 12:18:51 2011 Completed.
1453 Mon Feb 14 12:18:51 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1454 Mon Feb 14 12:18:51 2011 Completed.
1455 Mon Feb 14 12:18:51 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1456 Mon Feb 14 12:18:52 2011 Received.
1457 Mon Feb 14 12:18:52 2011 Starting 300 seconds test run.
1458 Child 0 - 50 aborted ops
1459 Child 2 - 100 aborted ops
1460 Child 0 - 100 aborted ops
1461 Child 3 - 50 aborted ops
1462 Child 2 - 150 aborted ops
1463 Child 0 - 150 aborted ops
1464 Child 1 - 50 aborted ops
1465 Child 3 - 100 aborted ops
1466 Child 0 - 200 aborted ops
1467 Child 2 - 200 aborted ops
1468 Child 1 - 100 aborted ops
1469 Child 3 - 150 aborted ops
1470 Child 0 - 250 aborted ops
1471 Child 2 - 250 aborted ops
1472 Child 1 - 150 aborted ops
1473 Child 3 - 200 aborted ops
1474 Child 2 - 300 aborted ops
1475 Child 1 - 200 aborted ops
1476 SFS Single Client (c09-44) Results, Mon Feb 14 12:24:02 2011
1477 --------------------------------------------------------------------------------------
1478 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
1479 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
1480 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1481            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
1482 --------------------------------------------------------------------------------------
1483 getattr     26.0%    26.2%    63753    63753      0      0.19     0.08      0.00  3.1%
1484 setattr      4.0%     4.0%     9790     9790      0      4.02     6.18      0.05 10.5%
1485 lookup      24.0%    24.2%    58923    58923      0      0.19     0.08      0.00  3.0%
1486 readlink     1.0%     1.0%     2356     2356      0      0.19     0.09      0.01  0.1%
1487 read        18.0%    18.0%    43863    53575      0      1.91    20.96      0.04 22.3%
1488 write       10.0%    10.0%    24378    29662      0      5.83    23.67      0.06 37.8%
1489 create       1.0%     1.0%     2516     2516      0      5.06     6.50      0.10  3.4%
1490 remove       1.0%     0.6%     1530     1530      0      3.73     6.09      0.12  1.5%
1491 readdir      1.0%     1.0%     2438     2438      0      0.38     0.11      0.01  0.2%
1492 fsstat       1.0%     1.0%     2436     2436      0      0.19     0.07      0.01  0.1%
1493 access      11.0%    11.0%    26812    26812      0      0.18     0.08      0.00  1.3%
1494 commit       0.0%     0.0%        0    14442      0      0.00     0.00      0.00 15.7%
1495 readdirplus  2.0%     2.0%     4915     4915      0      0.66     0.12      0.01  0.9%
1496 --------------------------------------------------------------------------------------
1497
1498       --------------------------------------------------
1499       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1500       --------------------------+-----------------------
1501 SFS NFS V3 THROUGHPUT:  815.08 Ops/Sec   AVG. RESPONSE TIME:    1.54 Msec/Op
1502 TCP PROTOCOL
1503 FAST CALLS: 0
1504 NFS V3 MIXFILE: [ SFS Default ]
1505 CLIENT REQUESTED LOAD: 800 Ops/Sec 
1506 TOTAL LOGICAL NFS V3 OPERATIONS:  243710         TEST TIME: 299 Sec 
1507 TOTAL PHYSICAL NFS V3 OPERATIONS: 273148   
1508 PHYSICAL NFS V3 THROUGHPUT:  913.53 Ops/Sec
1509 FILE SET SIZE CREATED: 10622124.0 KB
1510 FILE SET SIZE ACCESSED: 3188124.0 - 3512159.0 KB  (100.00% to 110.16% of Base)
1511
1512 ------------------------------------------------------------------------
1513
1514 Mon Feb 14 12:24:02 2011 Completed.
1515
1516 Client Test Parameters: 
1517         Number of processes = 4
1518         Requested Load (NFS V3 operations/second) = 800
1519         Maximum number of outstanding biod writes = 2
1520         Maximum number of outstanding biod reads = 2
1521         Warm-up time (seconds) = 300
1522         Run time (seconds) = 300
1523         File Set = 20004 Files created for I/O operations
1524                    6000 Files accessed for I/O operations
1525                     404 Files for non-I/O operations
1526                      24 Symlinks
1527                     664 Directories
1528                         Additional non-I/O files created as necessary
1529
1530
1531 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1532 Mon Feb 14 12:24:02 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1533 Mon Feb 14 12:24:02 2011 Completed.
1534 Mon Feb 14 12:24:02 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1535
1536 ************************************************************************
1537 Mon Feb 14 12:24:03 2011 Received.
1538 Mon Feb 14 12:24:03 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1539 Mon Feb 14 12:24:03 2011 Completed.
1540 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1000  -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 
1541 NFS V3 Protocol Version
1542
1543 ************************************************************************
1544 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1545 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1546
1547 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1548 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1549
1550 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 12:24:05 2011
1551         Client hostname = c09-44
1552         Prime Client hostname = c09-44.sysnet.ucsd.edu
1553
1554 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1555 NFS V3 Protocol
1556 Mon Feb 14 12:24:05 2011 Mounting 4 remote test directories.
1557 Child[000]: NFS negotiated block size 32768
1558 Child[001]: NFS negotiated block size 32768
1559 Child[002]: NFS negotiated block size 32768
1560 Child[003]: NFS negotiated block size 32768
1561 Mon Feb 14 12:24:16 2011 Completed.
1562 Mon Feb 14 12:24:16 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1563 Mon Feb 14 12:24:16 2011 Completed.
1564 Mon Feb 14 12:24:16 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1565 Mon Feb 14 12:24:21 2011 Received.
1566
1567 Mon Feb 14 12:24:21 2011 Initializing test directories.
1568 Mon Feb 14 12:24:21 2011 Child 1 will create 167 directories.
1569 Mon Feb 14 12:24:21 2011 Child 0 will create 167 directories.
1570 Mon Feb 14 12:24:21 2011 Child 3 will create 167 directories.
1571 Mon Feb 14 12:24:21 2011 Child 2 will create 167 directories.
1572 Mon Feb 14 12:24:26 2011 Child 0 finished creating 167 directories.
1573 Mon Feb 14 12:24:26 2011 Child 0 will create 5102 files.
1574 Mon Feb 14 12:24:30 2011 Child 0 verified 5102 files, created 40
1575 Mon Feb 14 12:24:30 2011 Child 0 will create 6 symlinks.
1576 Mon Feb 14 12:24:30 2011 Child 0 finished creating 6 symlinks.
1577 Mon Feb 14 12:24:31 2011 Child 1 finished creating 167 directories.
1578 Mon Feb 14 12:24:31 2011 Child 1 will create 5102 files.
1579 Mon Feb 14 12:24:34 2011 Child 2 finished creating 167 directories.
1580 Mon Feb 14 12:24:34 2011 Child 2 will create 5102 files.
1581 Mon Feb 14 12:24:35 2011 Child 1 verified 5102 files, created 51
1582 Mon Feb 14 12:24:35 2011 Child 1 will create 6 symlinks.
1583 Mon Feb 14 12:24:35 2011 Child 1 finished creating 6 symlinks.
1584 Mon Feb 14 12:24:37 2011 Child 3 finished creating 167 directories.
1585 Mon Feb 14 12:24:37 2011 Child 3 will create 5102 files.
1586 Mon Feb 14 12:24:38 2011 Child 2 verified 5102 files, created 51
1587 Mon Feb 14 12:24:38 2011 Child 2 will create 6 symlinks.
1588 Mon Feb 14 12:24:38 2011 Child 2 finished creating 6 symlinks.
1589 Mon Feb 14 12:24:41 2011 Child 3 verified 5102 files, created 44
1590 Mon Feb 14 12:24:41 2011 Child 3 will create 6 symlinks.
1591 Mon Feb 14 12:24:41 2011 Child 3 finished creating 6 symlinks.
1592 Mon Feb 14 12:24:41 2011 Completed.
1593 Mon Feb 14 12:24:41 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1594 Mon Feb 14 12:24:41 2011 Completed.
1595 Mon Feb 14 12:24:41 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1596 Mon Feb 14 12:24:42 2011 Received.
1597 Mon Feb 14 12:24:42 2011 Performing 300 seconds pretest warmup.
1598 Child 2 - 50 aborted ops
1599 Child 2 - 100 aborted ops
1600 Mon Feb 14 12:29:42 2011 Completed.
1601 Mon Feb 14 12:29:42 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1602 Mon Feb 14 12:29:42 2011 Completed.
1603 Mon Feb 14 12:29:42 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1604 Mon Feb 14 12:29:43 2011 Received.
1605 Mon Feb 14 12:29:43 2011 Starting 300 seconds test run.
1606 Child 1 - 50 aborted ops
1607 Child 3 - 50 aborted ops
1608 Child 1 - 100 aborted ops
1609 Child 3 - 100 aborted ops
1610 Child 2 - 150 aborted ops
1611 Child 0 - 50 aborted ops
1612 Child 1 - 150 aborted ops
1613 Child 2 - 200 aborted ops
1614 Child 3 - 150 aborted ops
1615 Child 0 - 100 aborted ops
1616 Child 1 - 200 aborted ops
1617 Child 2 - 250 aborted ops
1618 Child 0 - 150 aborted ops
1619 Child 3 - 200 aborted ops
1620 Child 2 - 300 aborted ops
1621 Child 1 - 250 aborted ops
1622 Child 0 - 200 aborted ops
1623 Child 1 - 300 aborted ops
1624 Child 3 - 250 aborted ops
1625 Child 0 - 250 aborted ops
1626 Child 2 - 350 aborted ops
1627 Child 3 - 300 aborted ops
1628 Child 1 - 350 aborted ops
1629 Child 2 - 400 aborted ops
1630 Child 0 - 300 aborted ops
1631 Child 3 - 350 aborted ops
1632 Child 1 - 400 aborted ops
1633 Child 0 - 350 aborted ops
1634 SFS Single Client (c09-44) Results, Mon Feb 14 12:34:53 2011
1635 --------------------------------------------------------------------------------------
1636 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
1637 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
1638 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1639            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
1640 --------------------------------------------------------------------------------------
1641 getattr     26.0%    26.2%    79977    79977      0      0.19     0.11      0.00  3.1%
1642 setattr      4.0%     4.0%    12365    12365      0      4.31     9.15      0.05 10.8%
1643 lookup      24.0%    24.0%    73267    73267      0      0.19     0.09      0.00  2.9%
1644 readlink     1.0%     1.0%     2991     2991      0      0.19     0.08      0.01  0.1%
1645 read        18.0%    18.1%    55404    68306      0      2.28    21.82      0.04 25.7%
1646 write       10.0%    10.1%    30737    37285      0      5.41    24.43      0.06 33.8%
1647 create       1.0%     1.0%     3071     3071      0      5.23     7.36      0.10  3.3%
1648 remove       1.0%     0.5%     1626     1626      0      3.99     7.25      0.13  1.3%
1649 readdir      1.0%     1.0%     3041     3041      0      0.39     0.13      0.01  0.2%
1650 fsstat       1.0%     1.0%     3086     3086      0      0.19     0.08      0.01  0.1%
1651 access      11.0%    11.1%    33846    33846      0      0.19     0.10      0.00  1.3%
1652 commit       0.0%     0.0%        0    18253      0      0.00     0.00      0.00 16.5%
1653 readdirplus  2.0%     2.0%     6197     6197      0      0.66     0.13      0.01  0.8%
1654 --------------------------------------------------------------------------------------
1655
1656       --------------------------------------------------
1657       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1658       --------------------------+-----------------------
1659 SFS NFS V3 THROUGHPUT: 1022.10 Ops/Sec   AVG. RESPONSE TIME:    1.61 Msec/Op
1660 TCP PROTOCOL
1661 FAST CALLS: 0
1662 NFS V3 MIXFILE: [ SFS Default ]
1663 CLIENT REQUESTED LOAD: 1000 Ops/Sec 
1664 TOTAL LOGICAL NFS V3 OPERATIONS:  305608         TEST TIME: 299 Sec 
1665 TOTAL PHYSICAL NFS V3 OPERATIONS: 343311   
1666 PHYSICAL NFS V3 THROUGHPUT: 1148.19 Ops/Sec
1667 FILE SET SIZE CREATED: 10622124.0 KB
1668 FILE SET SIZE ACCESSED: 3188124.0 - 3515489.0 KB  (100.00% to 110.27% of Base)
1669
1670 ------------------------------------------------------------------------
1671
1672 Mon Feb 14 12:34:53 2011 Completed.
1673
1674 Client Test Parameters: 
1675         Number of processes = 4
1676         Requested Load (NFS V3 operations/second) = 1000
1677         Maximum number of outstanding biod writes = 2
1678         Maximum number of outstanding biod reads = 2
1679         Warm-up time (seconds) = 300
1680         Run time (seconds) = 300
1681         File Set = 20004 Files created for I/O operations
1682                    6000 Files accessed for I/O operations
1683                     404 Files for non-I/O operations
1684                      24 Symlinks
1685                     664 Directories
1686                         Additional non-I/O files created as necessary
1687
1688
1689 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1690 Mon Feb 14 12:34:53 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1691 Mon Feb 14 12:34:53 2011 Completed.
1692 Mon Feb 14 12:34:53 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1693
1694 ************************************************************************
1695 Mon Feb 14 12:34:54 2011 Received.
1696 Mon Feb 14 12:34:54 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1697 Mon Feb 14 12:34:54 2011 Completed.
1698 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1200  -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 
1699 NFS V3 Protocol Version
1700
1701 ************************************************************************
1702 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1703 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1704
1705 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1706 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1707
1708 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 12:34:56 2011
1709         Client hostname = c09-44
1710         Prime Client hostname = c09-44.sysnet.ucsd.edu
1711
1712 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1713 NFS V3 Protocol
1714 Mon Feb 14 12:34:56 2011 Mounting 4 remote test directories.
1715 Child[000]: NFS negotiated block size 32768
1716 Child[001]: NFS negotiated block size 32768
1717 Child[002]: NFS negotiated block size 32768
1718 Child[003]: NFS negotiated block size 32768
1719 Mon Feb 14 12:35:07 2011 Completed.
1720 Mon Feb 14 12:35:07 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1721 Mon Feb 14 12:35:07 2011 Completed.
1722 Mon Feb 14 12:35:07 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1723 Mon Feb 14 12:35:12 2011 Received.
1724
1725 Mon Feb 14 12:35:12 2011 Initializing test directories.
1726 Mon Feb 14 12:35:12 2011 Child 2 will create 167 directories.
1727 Mon Feb 14 12:35:12 2011 Child 3 will create 167 directories.
1728 Mon Feb 14 12:35:12 2011 Child 1 will create 167 directories.
1729 Mon Feb 14 12:35:12 2011 Child 0 will create 167 directories.
1730 Mon Feb 14 12:35:16 2011 Child 1 finished creating 167 directories.
1731 Mon Feb 14 12:35:16 2011 Child 1 will create 5102 files.
1732 Mon Feb 14 12:35:19 2011 Child 2 finished creating 167 directories.
1733 Mon Feb 14 12:35:19 2011 Child 2 will create 5102 files.
1734 Mon Feb 14 12:35:21 2011 Child 1 verified 5102 files, created 51
1735 Mon Feb 14 12:35:21 2011 Child 1 will create 6 symlinks.
1736 Mon Feb 14 12:35:21 2011 Child 1 finished creating 6 symlinks.
1737 Mon Feb 14 12:35:22 2011 Child 3 finished creating 167 directories.
1738 Mon Feb 14 12:35:22 2011 Child 3 will create 5102 files.
1739 Mon Feb 14 12:35:23 2011 Child 0 finished creating 167 directories.
1740 Mon Feb 14 12:35:23 2011 Child 0 will create 5102 files.
1741 Mon Feb 14 12:35:25 2011 Child 2 verified 5102 files, created 50
1742 Mon Feb 14 12:35:25 2011 Child 2 will create 6 symlinks.
1743 Mon Feb 14 12:35:25 2011 Child 2 finished creating 6 symlinks.
1744 Mon Feb 14 12:35:28 2011 Child 3 verified 5102 files, created 51
1745 Mon Feb 14 12:35:28 2011 Child 3 will create 6 symlinks.
1746 Mon Feb 14 12:35:28 2011 Child 3 finished creating 6 symlinks.
1747 Mon Feb 14 12:35:29 2011 Child 0 verified 5102 files, created 51
1748 Mon Feb 14 12:35:29 2011 Child 0 will create 6 symlinks.
1749 Mon Feb 14 12:35:29 2011 Child 0 finished creating 6 symlinks.
1750 Mon Feb 14 12:35:29 2011 Completed.
1751 Mon Feb 14 12:35:29 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1752 Mon Feb 14 12:35:29 2011 Completed.
1753 Mon Feb 14 12:35:29 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1754 Mon Feb 14 12:35:30 2011 Received.
1755 Mon Feb 14 12:35:30 2011 Performing 300 seconds pretest warmup.
1756 Child 2 - 50 aborted ops
1757 Child 3 - 50 aborted ops
1758 Mon Feb 14 12:40:30 2011 Completed.
1759 Mon Feb 14 12:40:30 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1760 Mon Feb 14 12:40:30 2011 Completed.
1761 Mon Feb 14 12:40:30 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1762 Mon Feb 14 12:40:31 2011 Received.
1763 Mon Feb 14 12:40:31 2011 Starting 300 seconds test run.
1764 Child 2 - 100 aborted ops
1765 Child 1 - 50 aborted ops
1766 Child 3 - 100 aborted ops
1767 Child 1 - 100 aborted ops
1768 Child 0 - 50 aborted ops
1769 Child 3 - 150 aborted ops
1770 Child 2 - 150 aborted ops
1771 Child 1 - 150 aborted ops
1772 Child 3 - 200 aborted ops
1773 Child 0 - 100 aborted ops
1774 Child 3 - 250 aborted ops
1775 Child 2 - 200 aborted ops
1776 Child 0 - 150 aborted ops
1777 Child 1 - 200 aborted ops
1778 Child 3 - 300 aborted ops
1779 Child 0 - 200 aborted ops
1780 Child 2 - 250 aborted ops
1781 Child 3 - 350 aborted ops
1782 Child 0 - 250 aborted ops
1783 Child 2 - 300 aborted ops
1784 Child 3 - 400 aborted ops
1785 Child 1 - 250 aborted ops
1786 Child 2 - 350 aborted ops
1787 Child 1 - 300 aborted ops
1788 Child 0 - 300 aborted ops
1789 Child 2 - 400 aborted ops
1790 Child 3 - 450 aborted ops
1791 Child 3 - 500 aborted ops
1792 Child 0 - 350 aborted ops
1793 Child 1 - 350 aborted ops
1794 Child 3 - 550 aborted ops
1795 Child 2 - 450 aborted ops
1796 Child 0 - 400 aborted ops
1797 Child 3 - 600 aborted ops
1798 SFS Single Client (c09-44) Results, Mon Feb 14 12:45:41 2011
1799 --------------------------------------------------------------------------------------
1800 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
1801 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
1802 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1803            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
1804 --------------------------------------------------------------------------------------
1805 getattr     26.0%    26.1%    95798    95798      0      0.19     0.11      0.00  3.0%
1806 setattr      4.0%     4.0%    14684    14684      0      4.41     9.62      0.05 10.9%
1807 lookup      24.0%    24.1%    88350    88350      0      0.20     0.10      0.00  2.9%
1808 readlink     1.0%     1.0%     3627     3627      0      0.19     0.10      0.01  0.1%
1809 read        18.0%    18.1%    66534    81900      0      2.16    19.77      0.03 24.2%
1810 write       10.0%    10.0%    36648    44542      0      5.54    19.68      0.05 34.1%
1811 create       1.0%     1.0%     3745     3745      0      5.50    10.23      0.10  3.5%
1812 remove       1.0%     0.5%     1936     1936      0      3.78     6.62      0.11  1.2%
1813 readdir      1.0%     1.0%     3687     3687      0      0.39     0.14      0.01  0.2%
1814 fsstat       1.0%     1.0%     3637     3637      0      0.19     0.11      0.01  0.1%
1815 access      11.0%    11.1%    40896    40896      0      0.19     0.11      0.00  1.3%
1816 commit       0.0%     0.0%        0    21874      0      0.00     0.00      0.00 17.7%
1817 readdirplus  2.0%     2.0%     7323     7323      0      0.66     0.13      0.01  0.8%
1818 --------------------------------------------------------------------------------------
1819
1820       --------------------------------------------------
1821       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1822       --------------------------+-----------------------
1823 SFS NFS V3 THROUGHPUT: 1226.97 Ops/Sec   AVG. RESPONSE TIME:    1.62 Msec/Op
1824 TCP PROTOCOL
1825 FAST CALLS: 0
1826 NFS V3 MIXFILE: [ SFS Default ]
1827 CLIENT REQUESTED LOAD: 1200 Ops/Sec 
1828 TOTAL LOGICAL NFS V3 OPERATIONS:  366865         TEST TIME: 299 Sec 
1829 TOTAL PHYSICAL NFS V3 OPERATIONS: 411999   
1830 PHYSICAL NFS V3 THROUGHPUT: 1377.92 Ops/Sec
1831 FILE SET SIZE CREATED: 10622124.0 KB
1832 FILE SET SIZE ACCESSED: 3188124.0 - 3517143.0 KB  (100.00% to 110.32% of Base)
1833
1834 ------------------------------------------------------------------------
1835
1836 Mon Feb 14 12:45:41 2011 Completed.
1837
1838 Client Test Parameters: 
1839         Number of processes = 4
1840         Requested Load (NFS V3 operations/second) = 1200
1841         Maximum number of outstanding biod writes = 2
1842         Maximum number of outstanding biod reads = 2
1843         Warm-up time (seconds) = 300
1844         Run time (seconds) = 300
1845         File Set = 20004 Files created for I/O operations
1846                    6000 Files accessed for I/O operations
1847                     404 Files for non-I/O operations
1848                      24 Symlinks
1849                     664 Directories
1850                         Additional non-I/O files created as necessary
1851
1852
1853 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1854 Mon Feb 14 12:45:41 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1855 Mon Feb 14 12:45:41 2011 Completed.
1856 Mon Feb 14 12:45:41 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1857
1858 ************************************************************************
1859 Mon Feb 14 12:45:42 2011 Received.
1860 Mon Feb 14 12:45:42 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1861 Mon Feb 14 12:45:42 2011 Completed.
1862 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1400  -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 
1863 NFS V3 Protocol Version
1864
1865 ************************************************************************
1866 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1867 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1868
1869 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1870 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1871
1872 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 12:45:44 2011
1873         Client hostname = c09-44
1874         Prime Client hostname = c09-44.sysnet.ucsd.edu
1875
1876 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1877 NFS V3 Protocol
1878 Mon Feb 14 12:45:44 2011 Mounting 4 remote test directories.
1879 Child[000]: NFS negotiated block size 32768
1880 Child[001]: NFS negotiated block size 32768
1881 Child[002]: NFS negotiated block size 32768
1882 Child[003]: NFS negotiated block size 32768
1883 Mon Feb 14 12:45:55 2011 Completed.
1884 Mon Feb 14 12:45:55 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1885 Mon Feb 14 12:45:55 2011 Completed.
1886 Mon Feb 14 12:45:55 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1887 Mon Feb 14 12:46:00 2011 Received.
1888
1889 Mon Feb 14 12:46:00 2011 Initializing test directories.
1890 Mon Feb 14 12:46:00 2011 Child 2 will create 167 directories.
1891 Mon Feb 14 12:46:00 2011 Child 1 will create 167 directories.
1892 Mon Feb 14 12:46:00 2011 Child 0 will create 167 directories.
1893 Mon Feb 14 12:46:00 2011 Child 3 will create 167 directories.
1894 Mon Feb 14 12:46:00 2011 Child 0 finished creating 167 directories.
1895 Mon Feb 14 12:46:00 2011 Child 0 will create 5102 files.
1896 Mon Feb 14 12:46:00 2011 Child 2 finished creating 167 directories.
1897 Mon Feb 14 12:46:00 2011 Child 2 will create 5102 files.
1898 Mon Feb 14 12:46:03 2011 Child 3 finished creating 167 directories.
1899 Mon Feb 14 12:46:03 2011 Child 3 will create 5102 files.
1900 Mon Feb 14 12:46:14 2011 Child 1 finished creating 167 directories.
1901 Mon Feb 14 12:46:14 2011 Child 1 will create 5102 files.
1902 Mon Feb 14 12:46:18 2011 Child 0 verified 5102 files, created 51
1903 Mon Feb 14 12:46:18 2011 Child 0 will create 6 symlinks.
1904 Mon Feb 14 12:46:18 2011 Child 2 verified 5102 files, created 48
1905 Mon Feb 14 12:46:18 2011 Child 2 will create 6 symlinks.
1906 Mon Feb 14 12:46:18 2011 Child 0 finished creating 6 symlinks.
1907 Mon Feb 14 12:46:18 2011 Child 2 finished creating 6 symlinks.
1908 Mon Feb 14 12:46:22 2011 Child 3 verified 5102 files, created 51
1909 Mon Feb 14 12:46:22 2011 Child 3 will create 6 symlinks.
1910 Mon Feb 14 12:46:22 2011 Child 3 finished creating 6 symlinks.
1911 Mon Feb 14 12:46:27 2011 Child 1 verified 5102 files, created 51
1912 Mon Feb 14 12:46:27 2011 Child 1 will create 6 symlinks.
1913 Mon Feb 14 12:46:27 2011 Child 1 finished creating 6 symlinks.
1914 Mon Feb 14 12:46:27 2011 Completed.
1915 Mon Feb 14 12:46:27 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1916 Mon Feb 14 12:46:27 2011 Completed.
1917 Mon Feb 14 12:46:27 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1918 Mon Feb 14 12:46:28 2011 Received.
1919 Mon Feb 14 12:46:28 2011 Performing 300 seconds pretest warmup.
1920 Child 0 - 50 aborted ops
1921 Child 1 - 50 aborted ops
1922 Child 0 - 100 aborted ops
1923 Child 2 - 50 aborted ops
1924 Child 2 - 100 aborted ops
1925 Child 0 - 150 aborted ops
1926 Child 3 - 50 aborted ops
1927 Child 2 - 150 aborted ops
1928 Mon Feb 14 12:51:28 2011 Completed.
1929 Mon Feb 14 12:51:28 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1930 Mon Feb 14 12:51:28 2011 Completed.
1931 Mon Feb 14 12:51:28 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1932 Mon Feb 14 12:51:29 2011 Received.
1933 Mon Feb 14 12:51:29 2011 Starting 300 seconds test run.
1934 Child 1 - 100 aborted ops
1935 Child 0 - 200 aborted ops
1936 Child 2 - 200 aborted ops
1937 Child 3 - 100 aborted ops
1938 Child 1 - 150 aborted ops
1939 Child 0 - 250 aborted ops
1940 Child 2 - 250 aborted ops
1941 Child 3 - 150 aborted ops
1942 Child 0 - 300 aborted ops
1943 Child 2 - 300 aborted ops
1944 Child 3 - 200 aborted ops
1945 Child 1 - 200 aborted ops
1946 Child 2 - 350 aborted ops
1947 Child 0 - 350 aborted ops
1948 Child 1 - 250 aborted ops
1949 Child 2 - 400 aborted ops
1950 Child 3 - 250 aborted ops
1951 Child 0 - 400 aborted ops
1952 Child 1 - 300 aborted ops
1953 Child 2 - 450 aborted ops
1954 Child 0 - 450 aborted ops
1955 Child 3 - 300 aborted ops
1956 Child 1 - 350 aborted ops
1957 Child 2 - 500 aborted ops
1958 Child 0 - 500 aborted ops
1959 Child 3 - 350 aborted ops
1960 Child 1 - 400 aborted ops
1961 Child 2 - 550 aborted ops
1962 Child 0 - 550 aborted ops
1963 Child 3 - 400 aborted ops
1964 Child 1 - 450 aborted ops
1965 Child 2 - 600 aborted ops
1966 Child 3 - 450 aborted ops
1967 Child 0 - 600 aborted ops
1968 Child 1 - 500 aborted ops
1969 Child 2 - 650 aborted ops
1970 Child 3 - 500 aborted ops
1971 Child 0 - 650 aborted ops
1972 Child 1 - 550 aborted ops
1973 Child 1 - 600 aborted ops
1974 Child 3 - 550 aborted ops
1975 Child 0 - 700 aborted ops
1976 Child 2 - 700 aborted ops
1977 SFS Single Client (c09-44) Results, Mon Feb 14 12:56:39 2011
1978 --------------------------------------------------------------------------------------
1979 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
1980 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
1981 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1982            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
1983 --------------------------------------------------------------------------------------
1984 getattr     26.0%    26.1%   113310   113310      0      0.19     0.15      0.00  3.0%
1985 setattr      4.0%     4.0%    17413    17413      0      3.99    12.69      0.05  9.5%
1986 lookup      24.0%    24.1%   104444   104444      0      0.20     0.25      0.00  2.9%
1987 readlink     1.0%     1.0%     4356     4356      0      0.20     0.10      0.01  0.1%
1988 read        18.0%    18.1%    78680    96554      0      2.25    19.32      0.03 24.1%
1989 write       10.0%    10.1%    43698    52601      0      5.83    22.74      0.04 34.7%
1990 create       1.0%     1.0%     4397     4397      0      5.21    14.47      0.11  3.1%
1991 remove       1.0%     0.5%     2261     2261      0      3.74    10.10      0.13  1.2%
1992 readdir      1.0%     1.0%     4344     4344      0      0.40     0.15      0.01  0.2%
1993 fsstat       1.0%     1.0%     4493     4493      0      0.20     0.19      0.01  0.1%
1994 access      11.0%    11.1%    48056    48056      0      0.20     0.16      0.00  1.3%
1995 commit       0.0%     0.0%        0    26208      0      0.00     0.00      0.00 19.0%
1996 readdirplus  2.0%     2.0%     8710     8710      0      0.68     0.19      0.01  0.8%
1997 --------------------------------------------------------------------------------------
1998
1999       --------------------------------------------------
2000       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
2001       --------------------------+-----------------------
2002 SFS NFS V3 THROUGHPUT: 1447.20 Ops/Sec   AVG. RESPONSE TIME:    1.69 Msec/Op
2003 TCP PROTOCOL
2004 FAST CALLS: 0
2005 NFS V3 MIXFILE: [ SFS Default ]
2006 CLIENT REQUESTED LOAD: 1400 Ops/Sec 
2007 TOTAL LOGICAL NFS V3 OPERATIONS:  434162         TEST TIME: 300 Sec 
2008 TOTAL PHYSICAL NFS V3 OPERATIONS: 487147   
2009 PHYSICAL NFS V3 THROUGHPUT: 1623.82 Ops/Sec
2010 FILE SET SIZE CREATED: 10622124.0 KB
2011 FILE SET SIZE ACCESSED: 3188124.0 - 3523007.0 KB  (100.00% to 110.50% of Base)
2012
2013 ------------------------------------------------------------------------
2014
2015 Mon Feb 14 12:56:39 2011 Completed.
2016
2017 Client Test Parameters: 
2018         Number of processes = 4
2019         Requested Load (NFS V3 operations/second) = 1400
2020         Maximum number of outstanding biod writes = 2
2021         Maximum number of outstanding biod reads = 2
2022         Warm-up time (seconds) = 300
2023         Run time (seconds) = 300
2024         File Set = 20004 Files created for I/O operations
2025                    6000 Files accessed for I/O operations
2026                     404 Files for non-I/O operations
2027                      24 Symlinks
2028                     664 Directories
2029                         Additional non-I/O files created as necessary
2030
2031
2032 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
2033 Mon Feb 14 12:56:39 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
2034 Mon Feb 14 12:56:39 2011 Completed.
2035 Mon Feb 14 12:56:39 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
2036
2037 ************************************************************************
2038 Mon Feb 14 12:56:40 2011 Received.
2039 Mon Feb 14 12:56:40 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
2040 Mon Feb 14 12:56:40 2011 Completed.
2041 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1600  -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 
2042 NFS V3 Protocol Version
2043
2044 ************************************************************************
2045 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
2046 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
2047
2048 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
2049 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2050
2051 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 12:56:42 2011
2052         Client hostname = c09-44
2053         Prime Client hostname = c09-44.sysnet.ucsd.edu
2054
2055 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2056 NFS V3 Protocol
2057 Mon Feb 14 12:56:42 2011 Mounting 4 remote test directories.
2058 Child[000]: NFS negotiated block size 32768
2059 Child[002]: NFS negotiated block size 32768
2060 Child[003]: NFS negotiated block size 32768
2061 Child[001]: NFS negotiated block size 32768
2062 Mon Feb 14 12:56:58 2011 Completed.
2063 Mon Feb 14 12:56:58 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
2064 Mon Feb 14 12:56:58 2011 Completed.
2065 Mon Feb 14 12:56:58 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
2066 Mon Feb 14 12:56:58 2011 Received.
2067
2068 Mon Feb 14 12:56:58 2011 Initializing test directories.
2069 Mon Feb 14 12:56:58 2011 Child 1 will create 167 directories.
2070 Mon Feb 14 12:56:58 2011 Child 2 will create 167 directories.
2071 Mon Feb 14 12:56:58 2011 Child 0 will create 167 directories.
2072 Mon Feb 14 12:56:58 2011 Child 3 will create 167 directories.
2073 Mon Feb 14 12:57:06 2011 Child 1 finished creating 167 directories.
2074 Mon Feb 14 12:57:06 2011 Child 1 will create 5102 files.
2075 Mon Feb 14 12:57:09 2011 Child 2 finished creating 167 directories.
2076 Mon Feb 14 12:57:09 2011 Child 2 will create 5102 files.
2077 Mon Feb 14 12:57:12 2011 Child 3 finished creating 167 directories.
2078 Mon Feb 14 12:57:12 2011 Child 3 will create 5102 files.
2079 Mon Feb 14 12:57:15 2011 Child 0 finished creating 167 directories.
2080 Mon Feb 14 12:57:15 2011 Child 0 will create 5102 files.
2081 Mon Feb 14 12:57:26 2011 Child 1 verified 5102 files, created 44
2082 Mon Feb 14 12:57:26 2011 Child 1 will create 6 symlinks.
2083 Mon Feb 14 12:57:26 2011 Child 1 finished creating 6 symlinks.
2084 Mon Feb 14 12:57:33 2011 Child 2 verified 5102 files, created 45
2085 Mon Feb 14 12:57:33 2011 Child 2 will create 6 symlinks.
2086 Mon Feb 14 12:57:33 2011 Child 2 finished creating 6 symlinks.
2087 Mon Feb 14 12:57:35 2011 Child 3 verified 5102 files, created 51
2088 Mon Feb 14 12:57:35 2011 Child 3 will create 6 symlinks.
2089 Mon Feb 14 12:57:35 2011 Child 3 finished creating 6 symlinks.
2090 Mon Feb 14 12:57:36 2011 Child 0 verified 5102 files, created 48
2091 Mon Feb 14 12:57:36 2011 Child 0 will create 6 symlinks.
2092 Mon Feb 14 12:57:36 2011 Child 0 finished creating 6 symlinks.
2093 Mon Feb 14 12:57:37 2011 Completed.
2094 Mon Feb 14 12:57:37 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
2095 Mon Feb 14 12:57:37 2011 Completed.
2096 Mon Feb 14 12:57:37 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
2097 Mon Feb 14 12:57:38 2011 Received.
2098 Mon Feb 14 12:57:38 2011 Performing 300 seconds pretest warmup.
2099 Child 3 - 50 aborted ops
2100 Child 0 - 50 aborted ops
2101 Child 0 - 100 aborted ops
2102 Child 0 - 150 aborted ops
2103 Child 1 - 50 aborted ops
2104 Child 0 - 200 aborted ops
2105 Child 2 - 50 aborted ops
2106 Child 1 - 100 aborted ops
2107 Child 0 - 250 aborted ops
2108 Child 1 - 150 aborted ops
2109 Mon Feb 14 13:02:38 2011 Completed.
2110 Mon Feb 14 13:02:38 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
2111 Mon Feb 14 13:02:38 2011 Completed.
2112 Mon Feb 14 13:02:38 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
2113 Child 0 - 300 aborted ops
2114 Mon Feb 14 13:02:39 2011 Received.
2115 Mon Feb 14 13:02:39 2011 Starting 300 seconds test run.
2116 Child 2 - 100 aborted ops
2117 Child 1 - 200 aborted ops
2118 Child 3 - 100 aborted ops
2119 Child 0 - 350 aborted ops
2120 Child 3 - 150 aborted ops
2121 Child 2 - 150 aborted ops
2122 Child 0 - 400 aborted ops
2123 Child 1 - 250 aborted ops
2124 Child 2 - 200 aborted ops
2125 Child 1 - 300 aborted ops
2126 Child 3 - 200 aborted ops
2127 Child 2 - 250 aborted ops
2128 Child 0 - 450 aborted ops
2129 Child 1 - 350 aborted ops
2130 Child 2 - 300 aborted ops
2131 Child 3 - 250 aborted ops
2132 Child 0 - 500 aborted ops
2133 Child 1 - 400 aborted ops
2134 Child 2 - 350 aborted ops
2135 Child 3 - 300 aborted ops
2136 Child 0 - 550 aborted ops
2137 Child 2 - 400 aborted ops
2138 Child 1 - 450 aborted ops
2139 Child 3 - 350 aborted ops
2140 Child 3 - 400 aborted ops
2141 Child 2 - 450 aborted ops
2142 Child 0 - 600 aborted ops
2143 Child 1 - 500 aborted ops
2144 Child 0 - 650 aborted ops
2145 Child 3 - 450 aborted ops
2146 Child 2 - 500 aborted ops
2147 Child 2 - 550 aborted ops
2148 Child 1 - 550 aborted ops
2149 Child 3 - 500 aborted ops
2150 Child 0 - 700 aborted ops
2151 Child 0 - 750 aborted ops
2152 Child 2 - 600 aborted ops
2153 Child 3 - 550 aborted ops
2154 Child 1 - 600 aborted ops
2155 Child 0 - 800 aborted ops
2156 Child 2 - 650 aborted ops
2157 Child 3 - 600 aborted ops
2158 Child 0 - 850 aborted ops
2159 Child 3 - 650 aborted ops
2160 Child 1 - 650 aborted ops
2161 Child 2 - 700 aborted ops
2162 Child 1 - 700 aborted ops
2163 Child 3 - 700 aborted ops
2164 SFS Single Client (c09-44) Results, Mon Feb 14 13:07:49 2011
2165 --------------------------------------------------------------------------------------
2166 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
2167 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
2168 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
2169            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
2170 --------------------------------------------------------------------------------------
2171 getattr     26.0%    26.1%   124502   124502      0      0.20     0.16      0.00  2.4%
2172 setattr      4.0%     4.0%    19206    19206      0      5.20    17.53      0.06  9.6%
2173 lookup      24.0%    24.2%   115324   115324      0      0.21     0.16      0.00  2.3%
2174 readlink     1.0%     1.0%     4888     4888      0      0.20     0.11      0.01  0.1%
2175 read        18.0%    18.1%    86418   106382      0      3.32    54.03      0.05 27.7%
2176 write       10.0%    10.0%    47811    58074      0      6.52   100.18      0.09 30.0%
2177 create       1.0%     1.0%     4844     4844      0      6.83    17.97      0.12  3.2%
2178 remove       1.0%     0.5%     2510     2510      0      5.81    18.42      0.17  1.4%
2179 readdir      1.0%     1.0%     4647     4647      0      0.41     0.18      0.01  0.2%
2180 fsstat       1.0%     1.0%     4833     4833      0      0.20     0.11      0.01  0.1%
2181 access      11.0%    10.9%    52074    52074      0      0.20     0.16      0.00  1.0%
2182 commit       0.0%     0.0%        0    28640      0      0.00     0.00      0.00 21.4%
2183 readdirplus  2.0%     2.0%     9719     9719      0      0.69     0.17      0.01  0.6%
2184 --------------------------------------------------------------------------------------
2185
2186       --------------------------------------------------
2187       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
2188       --------------------------+-----------------------
2189 SFS NFS V3 THROUGHPUT: 1589.25 Ops/Sec   AVG. RESPONSE TIME:    2.17 Msec/Op
2190 TCP PROTOCOL
2191 FAST CALLS: 0
2192 NFS V3 MIXFILE: [ SFS Default ]
2193 CLIENT REQUESTED LOAD: 1600 Ops/Sec 
2194 TOTAL LOGICAL NFS V3 OPERATIONS:  476776         TEST TIME: 300 Sec 
2195 TOTAL PHYSICAL NFS V3 OPERATIONS: 535643   
2196 PHYSICAL NFS V3 THROUGHPUT: 1785.47 Ops/Sec
2197 FILE SET SIZE CREATED: 10622124.0 KB
2198 FILE SET SIZE ACCESSED: 3188124.0 - 3514152.0 KB  (100.00% to 110.23% of Base)
2199
2200 ------------------------------------------------------------------------
2201
2202 Mon Feb 14 13:07:49 2011 Completed.
2203
2204 Client Test Parameters: 
2205         Number of processes = 4
2206         Requested Load (NFS V3 operations/second) = 1600
2207         Maximum number of outstanding biod writes = 2
2208         Maximum number of outstanding biod reads = 2
2209         Warm-up time (seconds) = 300
2210         Run time (seconds) = 300
2211         File Set = 20004 Files created for I/O operations
2212                    6000 Files accessed for I/O operations
2213                     404 Files for non-I/O operations
2214                      24 Symlinks
2215                     664 Directories
2216                         Additional non-I/O files created as necessary
2217
2218
2219 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
2220 Mon Feb 14 13:07:49 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
2221 Mon Feb 14 13:07:49 2011 Completed.
2222 Mon Feb 14 13:07:49 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
2223
2224 ************************************************************************
2225 Mon Feb 14 13:07:50 2011 Received.
2226 Mon Feb 14 13:07:50 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
2227 Mon Feb 14 13:07:50 2011 Completed.
2228 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1800  -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 
2229 NFS V3 Protocol Version
2230
2231 ************************************************************************
2232 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
2233 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
2234
2235 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
2236 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2237
2238 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 13:07:52 2011
2239         Client hostname = c09-44
2240         Prime Client hostname = c09-44.sysnet.ucsd.edu
2241
2242 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2243 NFS V3 Protocol
2244 Mon Feb 14 13:07:52 2011 Mounting 4 remote test directories.
2245 Child[000]: NFS negotiated block size 32768
2246 Child[001]: NFS negotiated block size 32768
2247 Child[002]: NFS negotiated block size 32768
2248 Child[003]: NFS negotiated block size 32768
2249 Mon Feb 14 13:08:03 2011 Completed.
2250 Mon Feb 14 13:08:03 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
2251 Mon Feb 14 13:08:03 2011 Completed.
2252 Mon Feb 14 13:08:03 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
2253 Mon Feb 14 13:08:08 2011 Received.
2254
2255 Mon Feb 14 13:08:08 2011 Initializing test directories.
2256 Mon Feb 14 13:08:08 2011 Child 0 will create 167 directories.
2257 Mon Feb 14 13:08:08 2011 Child 3 will create 167 directories.
2258 Mon Feb 14 13:08:08 2011 Child 2 will create 167 directories.
2259 Mon Feb 14 13:08:08 2011 Child 1 will create 167 directories.
2260 Mon Feb 14 13:08:10 2011 Child 1 finished creating 167 directories.
2261 Mon Feb 14 13:08:10 2011 Child 1 will create 5102 files.
2262 Mon Feb 14 13:08:12 2011 Child 0 finished creating 167 directories.
2263 Mon Feb 14 13:08:12 2011 Child 0 will create 5102 files.
2264 Mon Feb 14 13:08:12 2011 Child 2 finished creating 167 directories.
2265 Mon Feb 14 13:08:12 2011 Child 2 will create 5102 files.
2266 Mon Feb 14 13:08:15 2011 Child 3 finished creating 167 directories.
2267 Mon Feb 14 13:08:15 2011 Child 3 will create 5102 files.
2268 Mon Feb 14 13:08:40 2011 Child 1 verified 5102 files, created 51
2269 Mon Feb 14 13:08:40 2011 Child 1 will create 6 symlinks.
2270 Mon Feb 14 13:08:41 2011 Child 1 finished creating 6 symlinks.
2271 Mon Feb 14 13:08:45 2011 Child 0 verified 5102 files, created 37
2272 Mon Feb 14 13:08:45 2011 Child 0 will create 6 symlinks.
2273 Mon Feb 14 13:08:45 2011 Child 0 finished creating 6 symlinks.
2274 Mon Feb 14 13:08:45 2011 Child 2 verified 5102 files, created 51
2275 Mon Feb 14 13:08:45 2011 Child 2 will create 6 symlinks.
2276 Mon Feb 14 13:08:45 2011 Child 2 finished creating 6 symlinks.
2277 Mon Feb 14 13:08:46 2011 Child 3 verified 5102 files, created 51
2278 Mon Feb 14 13:08:46 2011 Child 3 will create 6 symlinks.
2279 Mon Feb 14 13:08:46 2011 Child 3 finished creating 6 symlinks.
2280 Mon Feb 14 13:08:46 2011 Completed.
2281 Mon Feb 14 13:08:46 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
2282 Mon Feb 14 13:08:46 2011 Completed.
2283 Mon Feb 14 13:08:46 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
2284 Mon Feb 14 13:08:47 2011 Received.
2285 Mon Feb 14 13:08:47 2011 Performing 300 seconds pretest warmup.
2286 Child 3 - 50 aborted ops
2287 Child 0 - 50 aborted ops
2288 Child 3 - 100 aborted ops
2289 Mon Feb 14 13:13:47 2011 Completed.
2290 Mon Feb 14 13:13:47 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
2291 Mon Feb 14 13:13:47 2011 Completed.
2292 Mon Feb 14 13:13:47 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
2293 Mon Feb 14 13:13:48 2011 Received.
2294 Mon Feb 14 13:13:48 2011 Starting 300 seconds test run.
2295 Child 1 - 50 aborted ops
2296 Child 0 - 100 aborted ops
2297 Child 1 - 100 aborted ops
2298 Child 3 - 150 aborted ops
2299 Child 2 - 50 aborted ops
2300 Child 3 - 200 aborted ops
2301 Child 0 - 150 aborted ops
2302 Child 1 - 150 aborted ops
2303 Child 3 - 250 aborted ops
2304 Child 1 - 200 aborted ops
2305 Child 0 - 200 aborted ops
2306 Child 2 - 100 aborted ops
2307 Child 3 - 300 aborted ops
2308 Child 1 - 250 aborted ops
2309 Child 0 - 250 aborted ops
2310 Child 2 - 150 aborted ops
2311 Child 3 - 350 aborted ops
2312 Child 2 - 200 aborted ops
2313 Child 0 - 300 aborted ops
2314 Child 1 - 300 aborted ops
2315 Child 2 - 250 aborted ops
2316 Child 3 - 400 aborted ops
2317 Child 2 - 300 aborted ops
2318 Child 1 - 350 aborted ops
2319 Child 0 - 350 aborted ops
2320 Child 3 - 450 aborted ops
2321 Child 2 - 350 aborted ops
2322 Child 0 - 400 aborted ops
2323 Child 1 - 400 aborted ops
2324 Child 3 - 500 aborted ops
2325 Child 0 - 450 aborted ops
2326 Child 2 - 400 aborted ops
2327 Child 3 - 550 aborted ops
2328 Child 1 - 450 aborted ops
2329 Child 0 - 500 aborted ops
2330 Child 1 - 500 aborted ops
2331 Child 2 - 450 aborted ops
2332 Child 3 - 600 aborted ops
2333 Child 0 - 550 aborted ops
2334 Child 1 - 550 aborted ops
2335 Child 2 - 500 aborted ops
2336 Child 3 - 650 aborted ops
2337 Child 0 - 600 aborted ops
2338 Child 1 - 600 aborted ops
2339 Child 2 - 550 aborted ops
2340 Child 3 - 700 aborted ops
2341 Child 1 - 650 aborted ops
2342 Child 2 - 600 aborted ops
2343 Child 3 - 750 aborted ops
2344 Child 0 - 650 aborted ops
2345 SFS Single Client (c09-44) Results, Mon Feb 14 13:18:58 2011
2346 --------------------------------------------------------------------------------------
2347 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
2348 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
2349 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
2350            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
2351 --------------------------------------------------------------------------------------
2352 getattr     26.0%    26.1%   132615   132615      0      0.21     0.21      0.00  2.3%
2353 setattr      4.0%     4.1%    20629    20629      0      6.39    18.00      0.06 10.8%
2354 lookup      24.0%    24.1%   122346   122346      0      0.22     0.15      0.00  2.2%
2355 readlink     1.0%     1.0%     5075     5075      0      0.21     0.12      0.01  0.1%
2356 read        18.0%    18.2%    92360   113490      0      3.40    22.91      0.03 25.7%
2357 write       10.0%    10.1%    51116    61821      0      6.69    23.38      0.04 28.0%
2358 create       1.0%     1.0%     5137     5137      0      8.76    22.24      0.13  3.7%
2359 remove       1.0%     0.5%     2609     2609      0      6.99    18.54      0.17  1.5%
2360 readdir      1.0%     1.0%     5124     5124      0      0.42     0.23      0.01  0.2%
2361 fsstat       1.0%     1.0%     5061     5061      0      0.21     0.15      0.01  0.1%
2362 access      11.0%    11.0%    55819    55819      0      0.21     0.14      0.00  1.0%
2363 commit       0.0%     0.0%        0    30639      0      0.00     0.00      0.00 24.1%
2364 readdirplus  2.0%     2.0%    10419    10419      0      0.71     0.18      0.01  0.6%
2365 --------------------------------------------------------------------------------------
2366
2367       --------------------------------------------------
2368       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
2369       --------------------------+-----------------------
2370 SFS NFS V3 THROUGHPUT: 1694.36 Ops/Sec   AVG. RESPONSE TIME:    2.40 Msec/Op
2371 TCP PROTOCOL
2372 FAST CALLS: 0
2373 NFS V3 MIXFILE: [ SFS Default ]
2374 CLIENT REQUESTED LOAD: 1800 Ops/Sec 
2375 TOTAL LOGICAL NFS V3 OPERATIONS:  508310         TEST TIME: 300 Sec 
2376 TOTAL PHYSICAL NFS V3 OPERATIONS: 570784   
2377 PHYSICAL NFS V3 THROUGHPUT: 1902.61 Ops/Sec
2378 FILE SET SIZE CREATED: 10622124.0 KB
2379 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
2380
2381 ------------------------------------------------------------------------
2382
2383 Mon Feb 14 13:18:58 2011 Completed.
2384
2385 Client Test Parameters: 
2386         Number of processes = 4
2387         Requested Load (NFS V3 operations/second) = 1800
2388         Maximum number of outstanding biod writes = 2
2389         Maximum number of outstanding biod reads = 2
2390         Warm-up time (seconds) = 300
2391         Run time (seconds) = 300
2392         File Set = 20004 Files created for I/O operations
2393                    6000 Files accessed for I/O operations
2394                     404 Files for non-I/O operations
2395                      24 Symlinks
2396                     664 Directories
2397                         Additional non-I/O files created as necessary
2398
2399
2400 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
2401 Mon Feb 14 13:18:58 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
2402 Mon Feb 14 13:18:58 2011 Completed.
2403 Mon Feb 14 13:18:58 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
2404
2405 ************************************************************************
2406 Mon Feb 14 13:18:59 2011 Received.
2407 Mon Feb 14 13:18:59 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
2408 Mon Feb 14 13:18:59 2011 Completed.
2409 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 2000  -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 
2410 NFS V3 Protocol Version
2411
2412 ************************************************************************
2413 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
2414 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
2415
2416 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
2417 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2418
2419 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 13:19:01 2011
2420         Client hostname = c09-44
2421         Prime Client hostname = c09-44.sysnet.ucsd.edu
2422
2423 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2424 NFS V3 Protocol
2425 Mon Feb 14 13:19:01 2011 Mounting 4 remote test directories.
2426 Child[000]: NFS negotiated block size 32768
2427 Child[001]: NFS negotiated block size 32768
2428 Child[002]: NFS negotiated block size 32768
2429 Child[003]: NFS negotiated block size 32768
2430 Mon Feb 14 13:19:17 2011 Completed.
2431 Mon Feb 14 13:19:17 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
2432 Mon Feb 14 13:19:17 2011 Completed.
2433 Mon Feb 14 13:19:17 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
2434 Mon Feb 14 13:19:17 2011 Received.
2435
2436 Mon Feb 14 13:19:17 2011 Initializing test directories.
2437 Mon Feb 14 13:19:17 2011 Child 2 will create 167 directories.
2438 Mon Feb 14 13:19:17 2011 Child 3 will create 167 directories.
2439 Mon Feb 14 13:19:17 2011 Child 1 will create 167 directories.
2440 Mon Feb 14 13:19:17 2011 Child 0 will create 167 directories.
2441 Mon Feb 14 13:19:18 2011 Child 3 finished creating 167 directories.
2442 Mon Feb 14 13:19:18 2011 Child 3 will create 5102 files.
2443 Mon Feb 14 13:19:19 2011 Child 0 finished creating 167 directories.
2444 Mon Feb 14 13:19:19 2011 Child 0 will create 5102 files.
2445 Mon Feb 14 13:19:20 2011 Child 1 finished creating 167 directories.
2446 Mon Feb 14 13:19:20 2011 Child 1 will create 5102 files.
2447 Mon Feb 14 13:19:32 2011 Child 2 finished creating 167 directories.
2448 Mon Feb 14 13:19:32 2011 Child 2 will create 5102 files.
2449 Mon Feb 14 13:19:48 2011 Child 3 verified 5102 files, created 51
2450 Mon Feb 14 13:19:48 2011 Child 3 will create 6 symlinks.
2451 Mon Feb 14 13:19:48 2011 Child 3 finished creating 6 symlinks.
2452 Mon Feb 14 13:19:50 2011 Child 0 verified 5102 files, created 51
2453 Mon Feb 14 13:19:50 2011 Child 0 will create 6 symlinks.
2454 Mon Feb 14 13:19:50 2011 Child 0 finished creating 6 symlinks.
2455 Mon Feb 14 13:19:50 2011 Child 1 verified 5102 files, created 50
2456 Mon Feb 14 13:19:50 2011 Child 1 will create 6 symlinks.
2457 Mon Feb 14 13:19:50 2011 Child 1 finished creating 6 symlinks.
2458 Mon Feb 14 13:19:55 2011 Child 2 verified 5102 files, created 50
2459 Mon Feb 14 13:19:55 2011 Child 2 will create 6 symlinks.
2460 Mon Feb 14 13:19:55 2011 Child 2 finished creating 6 symlinks.
2461 Mon Feb 14 13:19:55 2011 Completed.
2462 Mon Feb 14 13:19:55 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
2463 Mon Feb 14 13:19:55 2011 Completed.
2464 Mon Feb 14 13:19:55 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
2465 Mon Feb 14 13:19:56 2011 Received.
2466 Mon Feb 14 13:19:56 2011 Performing 300 seconds pretest warmup.
2467 Mon Feb 14 13:24:56 2011 Completed.
2468 Mon Feb 14 13:24:56 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
2469 Mon Feb 14 13:24:56 2011 Completed.
2470 Mon Feb 14 13:24:56 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
2471 Mon Feb 14 13:24:57 2011 Received.
2472 Mon Feb 14 13:24:57 2011 Starting 300 seconds test run.
2473 Child 3 - 50 aborted ops
2474 Child 3 - 100 aborted ops
2475 Child 1 - 50 aborted ops
2476 Child 0 - 50 aborted ops
2477 Child 2 - 50 aborted ops
2478 Child 1 - 100 aborted ops
2479 Child 3 - 150 aborted ops
2480 Child 2 - 100 aborted ops
2481 Child 0 - 100 aborted ops
2482 Child 1 - 150 aborted ops
2483 Child 0 - 150 aborted ops
2484 Child 3 - 200 aborted ops
2485 Child 2 - 150 aborted ops
2486 Child 3 - 250 aborted ops
2487 Child 0 - 200 aborted ops
2488 Child 1 - 200 aborted ops
2489 Child 3 - 300 aborted ops
2490 Child 2 - 200 aborted ops
2491 Child 1 - 250 aborted ops
2492 Child 0 - 250 aborted ops
2493 Child 3 - 350 aborted ops
2494 Child 2 - 250 aborted ops
2495 Child 1 - 300 aborted ops
2496 Child 3 - 400 aborted ops
2497 Child 0 - 300 aborted ops
2498 Child 1 - 350 aborted ops
2499 Child 2 - 300 aborted ops
2500 Child 3 - 450 aborted ops
2501 Child 0 - 350 aborted ops
2502 Child 1 - 400 aborted ops
2503 Child 2 - 350 aborted ops
2504 Child 0 - 400 aborted ops
2505 Child 3 - 500 aborted ops
2506 Child 1 - 450 aborted ops
2507 Child 2 - 400 aborted ops
2508 Child 3 - 550 aborted ops
2509 Child 2 - 450 aborted ops
2510 Child 1 - 500 aborted ops
2511 Child 0 - 450 aborted ops
2512 Child 2 - 500 aborted ops
2513 Child 3 - 600 aborted ops
2514 Child 1 - 550 aborted ops
2515 Child 2 - 550 aborted ops
2516 Child 0 - 500 aborted ops
2517 Child 3 - 650 aborted ops
2518 Child 1 - 600 aborted ops
2519 Child 2 - 600 aborted ops
2520 Child 3 - 700 aborted ops
2521 Child 0 - 550 aborted ops
2522 SFS Single Client (c09-44) Results, Mon Feb 14 13:30:07 2011
2523 --------------------------------------------------------------------------------------
2524 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
2525 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
2526 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
2527            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
2528 --------------------------------------------------------------------------------------
2529 getattr     26.0%    26.1%   141832   141832      0      0.21     0.15      0.00  2.2%
2530 setattr      4.0%     4.0%    21781    21781      0      5.93    20.09      0.06  9.8%
2531 lookup      24.0%    24.1%   131094   131094      0      0.22     0.19      0.00  2.2%
2532 readlink     1.0%     1.0%     5439     5439      0      0.21     0.13      0.01  0.1%
2533 read        18.0%    18.1%    98355   120825      0      3.85    27.10      0.03 28.8%
2534 write       10.0%    10.0%    54424    65881      0      6.72    24.65      0.04 27.8%
2535 create       1.0%     1.0%     5505     5505      0      7.84    19.48      0.12  3.3%
2536 remove       1.0%     0.5%     2890     2890      0      6.38    21.15      0.17  1.4%
2537 readdir      1.0%     1.0%     5677     5677      0      0.43     0.16      0.01  0.2%
2538 fsstat       1.0%     1.0%     5401     5401      0      0.21     0.13      0.01  0.1%
2539 access      11.0%    11.0%    59948    59948      0      0.21     0.15      0.00  1.0%
2540 commit       0.0%     0.0%        0    32566      0      0.00     0.00      0.00 22.7%
2541 readdirplus  2.0%     2.0%    10839    10839      0      0.72     0.55      0.01  0.6%
2542 --------------------------------------------------------------------------------------
2543
2544       --------------------------------------------------
2545       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
2546       --------------------------+-----------------------
2547 SFS NFS V3 THROUGHPUT: 1810.61 Ops/Sec   AVG. RESPONSE TIME:    2.42 Msec/Op
2548 TCP PROTOCOL
2549 FAST CALLS: 0
2550 NFS V3 MIXFILE: [ SFS Default ]
2551 CLIENT REQUESTED LOAD: 2000 Ops/Sec 
2552 TOTAL LOGICAL NFS V3 OPERATIONS:  543185         TEST TIME: 300 Sec 
2553 TOTAL PHYSICAL NFS V3 OPERATIONS: 609678   
2554 PHYSICAL NFS V3 THROUGHPUT: 2032.26 Ops/Sec
2555 FILE SET SIZE CREATED: 10622124.0 KB
2556 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
2557
2558 ------------------------------------------------------------------------
2559
2560 Mon Feb 14 13:30:07 2011 Completed.
2561
2562 Client Test Parameters: 
2563         Number of processes = 4
2564         Requested Load (NFS V3 operations/second) = 2000
2565         Maximum number of outstanding biod writes = 2
2566         Maximum number of outstanding biod reads = 2
2567         Warm-up time (seconds) = 300
2568         Run time (seconds) = 300
2569         File Set = 20004 Files created for I/O operations
2570                    6000 Files accessed for I/O operations
2571                     404 Files for non-I/O operations
2572                      24 Symlinks
2573                     664 Directories
2574                         Additional non-I/O files created as necessary
2575
2576
2577 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
2578 Mon Feb 14 13:30:07 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
2579 Mon Feb 14 13:30:07 2011 Completed.
2580 Mon Feb 14 13:30:07 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
2581
2582 ************************************************************************
2583 Mon Feb 14 13:30:08 2011 Received.
2584 Mon Feb 14 13:30:08 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
2585 Mon Feb 14 13:30:08 2011 Completed.
2586 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 2200  -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 
2587 NFS V3 Protocol Version
2588
2589 ************************************************************************
2590 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
2591 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
2592
2593 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
2594 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2595
2596 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 13:30:10 2011
2597         Client hostname = c09-44
2598         Prime Client hostname = c09-44.sysnet.ucsd.edu
2599
2600 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2601 NFS V3 Protocol
2602 Mon Feb 14 13:30:10 2011 Mounting 4 remote test directories.
2603 Child[000]: NFS negotiated block size 32768
2604 Child[001]: NFS negotiated block size 32768
2605 Child[002]: NFS negotiated block size 32768
2606 Child[003]: NFS negotiated block size 32768
2607 Mon Feb 14 13:30:21 2011 Completed.
2608 Mon Feb 14 13:30:21 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
2609 Mon Feb 14 13:30:21 2011 Completed.
2610 Mon Feb 14 13:30:21 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
2611 Mon Feb 14 13:30:26 2011 Received.
2612
2613 Mon Feb 14 13:30:26 2011 Initializing test directories.
2614 Mon Feb 14 13:30:26 2011 Child 1 will create 167 directories.
2615 Mon Feb 14 13:30:26 2011 Child 0 will create 167 directories.
2616 Mon Feb 14 13:30:26 2011 Child 2 will create 167 directories.
2617 Mon Feb 14 13:30:26 2011 Child 3 will create 167 directories.
2618 Mon Feb 14 13:30:28 2011 Child 3 finished creating 167 directories.
2619 Mon Feb 14 13:30:28 2011 Child 3 will create 5102 files.
2620 Mon Feb 14 13:30:32 2011 Child 0 finished creating 167 directories.
2621 Mon Feb 14 13:30:32 2011 Child 0 will create 5102 files.
2622 Mon Feb 14 13:30:40 2011 Child 1 finished creating 167 directories.
2623 Mon Feb 14 13:30:40 2011 Child 1 will create 5102 files.
2624 Mon Feb 14 13:30:42 2011 Child 2 finished creating 167 directories.
2625 Mon Feb 14 13:30:42 2011 Child 2 will create 5102 files.
2626 Mon Feb 14 13:30:46 2011 Child 3 verified 5102 files, created 50
2627 Mon Feb 14 13:30:46 2011 Child 3 will create 6 symlinks.
2628 Mon Feb 14 13:30:46 2011 Child 3 finished creating 6 symlinks.
2629 Mon Feb 14 13:30:55 2011 Child 0 verified 5102 files, created 51
2630 Mon Feb 14 13:30:55 2011 Child 0 will create 6 symlinks.
2631 Mon Feb 14 13:30:55 2011 Child 0 finished creating 6 symlinks.
2632 Mon Feb 14 13:31:03 2011 Child 1 verified 5102 files, created 50
2633 Mon Feb 14 13:31:03 2011 Child 1 will create 6 symlinks.
2634 Mon Feb 14 13:31:03 2011 Child 1 finished creating 6 symlinks.
2635 Mon Feb 14 13:31:04 2011 Child 2 verified 5102 files, created 51
2636 Mon Feb 14 13:31:04 2011 Child 2 will create 6 symlinks.
2637 Mon Feb 14 13:31:04 2011 Child 2 finished creating 6 symlinks.
2638 Mon Feb 14 13:31:04 2011 Completed.
2639 Mon Feb 14 13:31:04 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
2640 Mon Feb 14 13:31:04 2011 Completed.
2641 Mon Feb 14 13:31:04 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
2642 Mon Feb 14 13:31:05 2011 Received.
2643 Mon Feb 14 13:31:05 2011 Performing 300 seconds pretest warmup.
2644 Child 0 - 50 aborted ops
2645 Child 0 - 100 aborted ops
2646 Child 1 - 50 aborted ops
2647 Mon Feb 14 13:36:05 2011 Completed.
2648 Mon Feb 14 13:36:05 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
2649 Mon Feb 14 13:36:05 2011 Completed.
2650 Mon Feb 14 13:36:05 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
2651 Mon Feb 14 13:36:06 2011 Received.
2652 Mon Feb 14 13:36:06 2011 Starting 300 seconds test run.
2653 Child 3 - 50 aborted ops
2654 Child 1 - 100 aborted ops
2655 Child 2 - 50 aborted ops
2656 Child 3 - 100 aborted ops
2657 Child 2 - 100 aborted ops
2658 Child 1 - 150 aborted ops
2659 Child 3 - 150 aborted ops
2660 Child 0 - 150 aborted ops
2661 Child 2 - 150 aborted ops
2662 Child 1 - 200 aborted ops
2663 Child 3 - 200 aborted ops
2664 Child 0 - 200 aborted ops
2665 Child 1 - 250 aborted ops
2666 Child 2 - 200 aborted ops
2667 Child 1 - 300 aborted ops
2668 Child 3 - 250 aborted ops
2669 Child 2 - 250 aborted ops
2670 Child 0 - 250 aborted ops
2671 Child 1 - 350 aborted ops
2672 Child 3 - 300 aborted ops
2673 Child 0 - 300 aborted ops
2674 Child 1 - 400 aborted ops
2675 Child 2 - 300 aborted ops
2676 Child 3 - 350 aborted ops
2677 Child 0 - 350 aborted ops
2678 Child 2 - 350 aborted ops
2679 Child 1 - 450 aborted ops
2680 Child 3 - 400 aborted ops
2681 Child 0 - 400 aborted ops
2682 Child 2 - 400 aborted ops
2683 Child 1 - 500 aborted ops
2684 Child 3 - 450 aborted ops
2685 Child 0 - 450 aborted ops
2686 Child 2 - 450 aborted ops
2687 Child 1 - 550 aborted ops
2688 Child 3 - 500 aborted ops
2689 Child 0 - 500 aborted ops
2690 Child 2 - 500 aborted ops
2691 Child 1 - 600 aborted ops
2692 Child 3 - 550 aborted ops
2693 Child 0 - 550 aborted ops
2694 Child 2 - 550 aborted ops
2695 Child 1 - 650 aborted ops
2696 Child 3 - 600 aborted ops
2697 Child 0 - 600 aborted ops
2698 Child 2 - 600 aborted ops
2699 Child 3 - 650 aborted ops
2700 Child 1 - 700 aborted ops
2701 Child 2 - 650 aborted ops
2702 SFS Single Client (c09-44) Results, Mon Feb 14 13:41:16 2011
2703 --------------------------------------------------------------------------------------
2704 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
2705 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
2706 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
2707            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
2708 --------------------------------------------------------------------------------------
2709 getattr     26.0%    26.2%   129075   129075      0      0.21     0.27      0.00  2.0%
2710 setattr      4.0%     4.1%    20016    20016      0      6.77    18.87      0.06 10.1%
2711 lookup      24.0%    24.0%   118194   118194      0      0.21     0.17      0.00  1.9%
2712 readlink     1.0%     1.0%     5007     5007      0      0.21     0.21      0.01  0.1%
2713 read        18.0%    18.1%    89188   109822      0      4.43   104.30      0.07 29.3%
2714 write       10.0%    10.1%    49609    60089      0      7.60    98.59      0.09 28.0%
2715 create       1.0%     1.0%     5003     5003      0      8.98    21.90      0.13  3.3%
2716 remove       1.0%     0.5%     2464     2464      0      7.65    25.94      0.20  1.4%
2717 readdir      1.0%     1.0%     4950     4950      0      0.43     0.36      0.02  0.2%
2718 fsstat       1.0%     1.0%     4985     4985      0      0.20     0.11      0.01  0.1%
2719 access      11.0%    11.0%    53987    53987      0      0.21     0.26      0.00  0.8%
2720 commit       0.0%     0.0%        0    29630      0      0.00     0.00      0.00 22.4%
2721 readdirplus  2.0%     2.0%    10019    10019      0      0.71     0.42      0.01  0.5%
2722 --------------------------------------------------------------------------------------
2723
2724       --------------------------------------------------
2725       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
2726       --------------------------+-----------------------
2727 SFS NFS V3 THROUGHPUT: 1647.14 Ops/Sec   AVG. RESPONSE TIME:    2.73 Msec/Op
2728 TCP PROTOCOL
2729 FAST CALLS: 0
2730 NFS V3 MIXFILE: [ SFS Default ]
2731 CLIENT REQUESTED LOAD: 2200 Ops/Sec 
2732 TOTAL LOGICAL NFS V3 OPERATIONS:  492497         TEST TIME: 299 Sec 
2733 TOTAL PHYSICAL NFS V3 OPERATIONS: 553241   
2734 PHYSICAL NFS V3 THROUGHPUT: 1850.30 Ops/Sec
2735 FILE SET SIZE CREATED: 10622124.0 KB
2736 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
2737
2738 ------------------------------------------------------------------------
2739
2740 Mon Feb 14 13:41:16 2011 Completed.
2741
2742 Client Test Parameters: 
2743         Number of processes = 4
2744         Requested Load (NFS V3 operations/second) = 2200
2745         Maximum number of outstanding biod writes = 2
2746         Maximum number of outstanding biod reads = 2
2747         Warm-up time (seconds) = 300
2748         Run time (seconds) = 300
2749         File Set = 20004 Files created for I/O operations
2750                    6000 Files accessed for I/O operations
2751                     404 Files for non-I/O operations
2752                      24 Symlinks
2753                     664 Directories
2754                         Additional non-I/O files created as necessary
2755
2756
2757 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
2758 Mon Feb 14 13:41:16 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
2759 Mon Feb 14 13:41:16 2011 Completed.
2760 Mon Feb 14 13:41:16 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
2761
2762 ************************************************************************
2763 Mon Feb 14 13:41:17 2011 Received.
2764 Mon Feb 14 13:41:17 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
2765 Mon Feb 14 13:41:17 2011 Completed.
2766 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 2400  -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 
2767 NFS V3 Protocol Version
2768
2769 ************************************************************************
2770 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
2771 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
2772
2773 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
2774 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2775
2776 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 13:41:19 2011
2777         Client hostname = c09-44
2778         Prime Client hostname = c09-44.sysnet.ucsd.edu
2779
2780 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2781 NFS V3 Protocol
2782 Mon Feb 14 13:41:19 2011 Mounting 4 remote test directories.
2783 Child[001]: NFS negotiated block size 32768
2784 Child[002]: NFS negotiated block size 32768
2785 Child[003]: NFS negotiated block size 32768
2786 Child[000]: NFS negotiated block size 32768
2787 Mon Feb 14 13:41:35 2011 Completed.
2788 Mon Feb 14 13:41:35 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
2789 Mon Feb 14 13:41:35 2011 Completed.
2790 Mon Feb 14 13:41:35 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
2791 Mon Feb 14 13:41:35 2011 Received.
2792
2793 Mon Feb 14 13:41:35 2011 Initializing test directories.
2794 Mon Feb 14 13:41:35 2011 Child 2 will create 167 directories.
2795 Mon Feb 14 13:41:35 2011 Child 3 will create 167 directories.
2796 Mon Feb 14 13:41:35 2011 Child 1 will create 167 directories.
2797 Mon Feb 14 13:41:35 2011 Child 0 will create 167 directories.
2798 Mon Feb 14 13:41:41 2011 Child 0 finished creating 167 directories.
2799 Mon Feb 14 13:41:41 2011 Child 0 will create 5102 files.
2800 Mon Feb 14 13:41:42 2011 Child 1 finished creating 167 directories.
2801 Mon Feb 14 13:41:42 2011 Child 1 will create 5102 files.
2802 Mon Feb 14 13:41:45 2011 Child 2 finished creating 167 directories.
2803 Mon Feb 14 13:41:45 2011 Child 2 will create 5102 files.
2804 Mon Feb 14 13:41:48 2011 Child 3 finished creating 167 directories.
2805 Mon Feb 14 13:41:48 2011 Child 3 will create 5102 files.
2806 Mon Feb 14 13:42:13 2011 Child 0 verified 5102 files, created 51
2807 Mon Feb 14 13:42:13 2011 Child 0 will create 6 symlinks.
2808 Mon Feb 14 13:42:13 2011 Child 0 finished creating 6 symlinks.
2809 Mon Feb 14 13:42:16 2011 Child 1 verified 5102 files, created 51
2810 Mon Feb 14 13:42:16 2011 Child 1 will create 6 symlinks.
2811 Mon Feb 14 13:42:16 2011 Child 1 finished creating 6 symlinks.
2812 Mon Feb 14 13:42:19 2011 Child 2 verified 5102 files, created 50
2813 Mon Feb 14 13:42:19 2011 Child 2 will create 6 symlinks.
2814 Mon Feb 14 13:42:19 2011 Child 2 finished creating 6 symlinks.
2815 Mon Feb 14 13:42:20 2011 Child 3 verified 5102 files, created 50
2816 Mon Feb 14 13:42:20 2011 Child 3 will create 6 symlinks.
2817 Mon Feb 14 13:42:20 2011 Child 3 finished creating 6 symlinks.
2818 Mon Feb 14 13:42:20 2011 Completed.
2819 Mon Feb 14 13:42:20 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
2820 Mon Feb 14 13:42:20 2011 Completed.
2821 Mon Feb 14 13:42:20 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
2822 Mon Feb 14 13:42:21 2011 Received.
2823 Mon Feb 14 13:42:21 2011 Performing 300 seconds pretest warmup.
2824 Child 0 - 50 aborted ops
2825 Mon Feb 14 13:47:21 2011 Completed.
2826 Mon Feb 14 13:47:21 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
2827 Mon Feb 14 13:47:21 2011 Completed.
2828 Mon Feb 14 13:47:21 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
2829 Mon Feb 14 13:47:22 2011 Received.
2830 Mon Feb 14 13:47:22 2011 Starting 300 seconds test run.
2831 Child 0 - 100 aborted ops
2832 Child 1 - 50 aborted ops
2833 Child 2 - 50 aborted ops
2834 Child 0 - 150 aborted ops
2835 Child 1 - 100 aborted ops
2836 Child 2 - 100 aborted ops
2837 Child 0 - 200 aborted ops
2838 Child 2 - 150 aborted ops
2839 Child 1 - 150 aborted ops
2840 Child 3 - 50 aborted ops
2841 Child 1 - 200 aborted ops
2842 Child 0 - 250 aborted ops
2843 Child 2 - 200 aborted ops
2844 Child 0 - 300 aborted ops
2845 Child 3 - 100 aborted ops
2846 Child 2 - 250 aborted ops
2847 Child 1 - 250 aborted ops
2848 Child 3 - 150 aborted ops
2849 Child 0 - 350 aborted ops
2850 Child 1 - 300 aborted ops
2851 Child 2 - 300 aborted ops
2852 Child 0 - 400 aborted ops
2853 Child 1 - 350 aborted ops
2854 Child 2 - 350 aborted ops
2855 Child 3 - 200 aborted ops
2856 Child 1 - 400 aborted ops
2857 Child 0 - 450 aborted ops
2858 Child 2 - 400 aborted ops
2859 Child 3 - 250 aborted ops
2860 Child 2 - 450 aborted ops
2861 Child 0 - 500 aborted ops
2862 Child 1 - 450 aborted ops
2863 Child 3 - 300 aborted ops
2864 Child 2 - 500 aborted ops
2865 Child 0 - 550 aborted ops
2866 Child 1 - 500 aborted ops
2867 Child 3 - 350 aborted ops
2868 Child 2 - 550 aborted ops
2869 Child 0 - 600 aborted ops
2870 Child 3 - 400 aborted ops
2871 Child 1 - 550 aborted ops
2872 Child 0 - 650 aborted ops
2873 Child 2 - 600 aborted ops
2874 Child 3 - 450 aborted ops
2875 Child 1 - 600 aborted ops
2876 Child 2 - 650 aborted ops
2877 SFS Single Client (c09-44) Results, Mon Feb 14 13:52:33 2011
2878 --------------------------------------------------------------------------------------
2879 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
2880 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
2881 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
2882            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
2883 --------------------------------------------------------------------------------------
2884 getattr     26.0%    26.1%   132800   132800      0      0.21     0.26      0.00  2.0%
2885 setattr      4.0%     4.0%    20526    20526      0      6.81    25.23      0.07 10.1%
2886 lookup      24.0%    24.1%   122503   122503      0      0.22     0.16      0.00  1.9%
2887 readlink     1.0%     1.0%     5270     5270      0      0.22     0.52      0.02  0.1%
2888 read        18.0%    18.0%    91726   113049      0      4.54    34.22      0.04 30.1%
2889 write       10.0%    10.0%    50942    61939      0      7.35    26.28      0.04 27.1%
2890 create       1.0%     1.0%     5189     5189      0      8.85    22.59      0.13  3.3%
2891 remove       1.0%     0.5%     2673     2673      0      6.71    16.02      0.15  1.3%
2892 readdir      1.0%     1.0%     5117     5117      0      0.43     0.16      0.01  0.2%
2893 fsstat       1.0%     1.0%     5009     5009      0      0.22     0.36      0.02  0.1%
2894 access      11.0%    11.1%    56180    56180      0      0.21     0.41      0.01  0.9%
2895 commit       0.0%     0.0%        0    30433      0      0.00     0.00      0.00 22.5%
2896 readdirplus  2.0%     2.0%    10360    10360      0      0.72     0.46      0.01  0.5%
2897 --------------------------------------------------------------------------------------
2898
2899       --------------------------------------------------
2900       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
2901       --------------------------+-----------------------
2902 SFS NFS V3 THROUGHPUT: 1699.98 Ops/Sec   AVG. RESPONSE TIME:    2.72 Msec/Op
2903 TCP PROTOCOL
2904 FAST CALLS: 0
2905 NFS V3 MIXFILE: [ SFS Default ]
2906 CLIENT REQUESTED LOAD: 2400 Ops/Sec 
2907 TOTAL LOGICAL NFS V3 OPERATIONS:  508295         TEST TIME: 299 Sec 
2908 TOTAL PHYSICAL NFS V3 OPERATIONS: 571048   
2909 PHYSICAL NFS V3 THROUGHPUT: 1909.85 Ops/Sec
2910 FILE SET SIZE CREATED: 10622124.0 KB
2911 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
2912
2913 ------------------------------------------------------------------------
2914
2915 Mon Feb 14 13:52:33 2011 Completed.
2916
2917 Client Test Parameters: 
2918         Number of processes = 4
2919         Requested Load (NFS V3 operations/second) = 2400
2920         Maximum number of outstanding biod writes = 2
2921         Maximum number of outstanding biod reads = 2
2922         Warm-up time (seconds) = 300
2923         Run time (seconds) = 300
2924         File Set = 20004 Files created for I/O operations
2925                    6000 Files accessed for I/O operations
2926                     404 Files for non-I/O operations
2927                      24 Symlinks
2928                     664 Directories
2929                         Additional non-I/O files created as necessary
2930
2931
2932 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
2933 Mon Feb 14 13:52:33 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
2934 Mon Feb 14 13:52:33 2011 Completed.
2935 Mon Feb 14 13:52:33 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
2936
2937 ************************************************************************
2938 Mon Feb 14 13:52:33 2011 Received.
2939 Mon Feb 14 13:52:33 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
2940 Mon Feb 14 13:52:33 2011 Completed.
2941 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 2600  -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 
2942 NFS V3 Protocol Version
2943
2944 ************************************************************************
2945 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
2946 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
2947
2948 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
2949 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2950
2951 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 13:52:35 2011
2952         Client hostname = c09-44
2953         Prime Client hostname = c09-44.sysnet.ucsd.edu
2954
2955 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
2956 NFS V3 Protocol
2957 Mon Feb 14 13:52:35 2011 Mounting 4 remote test directories.
2958 Child[000]: NFS negotiated block size 32768
2959 Child[002]: NFS negotiated block size 32768
2960 Child[003]: NFS negotiated block size 32768
2961 Child[001]: NFS negotiated block size 32768
2962 Mon Feb 14 13:52:52 2011 Completed.
2963 Mon Feb 14 13:52:52 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
2964 Mon Feb 14 13:52:52 2011 Completed.
2965 Mon Feb 14 13:52:52 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
2966 Mon Feb 14 13:52:52 2011 Received.
2967
2968 Mon Feb 14 13:52:52 2011 Initializing test directories.
2969 Mon Feb 14 13:52:52 2011 Child 2 will create 167 directories.
2970 Mon Feb 14 13:52:52 2011 Child 1 will create 167 directories.
2971 Mon Feb 14 13:52:52 2011 Child 0 will create 167 directories.
2972 Mon Feb 14 13:52:52 2011 Child 3 will create 167 directories.
2973 Mon Feb 14 13:52:52 2011 Child 1 finished creating 167 directories.
2974 Mon Feb 14 13:52:52 2011 Child 1 will create 5102 files.
2975 Mon Feb 14 13:52:55 2011 Child 2 finished creating 167 directories.
2976 Mon Feb 14 13:52:55 2011 Child 2 will create 5102 files.
2977 Mon Feb 14 13:52:58 2011 Child 3 finished creating 167 directories.
2978 Mon Feb 14 13:52:58 2011 Child 3 will create 5102 files.
2979 Mon Feb 14 13:52:59 2011 Child 0 finished creating 167 directories.
2980 Mon Feb 14 13:52:59 2011 Child 0 will create 5102 files.
2981 Mon Feb 14 13:53:24 2011 Child 1 verified 5102 files, created 51
2982 Mon Feb 14 13:53:24 2011 Child 1 will create 6 symlinks.
2983 Mon Feb 14 13:53:24 2011 Child 1 finished creating 6 symlinks.
2984 Mon Feb 14 13:53:30 2011 Child 2 verified 5102 files, created 50
2985 Mon Feb 14 13:53:30 2011 Child 2 will create 6 symlinks.
2986 Mon Feb 14 13:53:30 2011 Child 2 finished creating 6 symlinks.
2987 Mon Feb 14 13:53:32 2011 Child 3 verified 5102 files, created 51
2988 Mon Feb 14 13:53:32 2011 Child 3 will create 6 symlinks.
2989 Mon Feb 14 13:53:32 2011 Child 3 finished creating 6 symlinks.
2990 Mon Feb 14 13:53:33 2011 Child 0 verified 5102 files, created 49
2991 Mon Feb 14 13:53:33 2011 Child 0 will create 6 symlinks.
2992 Mon Feb 14 13:53:33 2011 Child 0 finished creating 6 symlinks.
2993 Mon Feb 14 13:53:34 2011 Completed.
2994 Mon Feb 14 13:53:34 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
2995 Mon Feb 14 13:53:34 2011 Completed.
2996 Mon Feb 14 13:53:34 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
2997 Mon Feb 14 13:53:34 2011 Received.
2998 Mon Feb 14 13:53:34 2011 Performing 300 seconds pretest warmup.
2999 Child 1 - 50 aborted ops
3000 Child 1 - 100 aborted ops
3001 Child 0 - 50 aborted ops
3002 Child 1 - 150 aborted ops
3003 Child 1 - 200 aborted ops
3004 Child 0 - 100 aborted ops
3005 Child 0 - 150 aborted ops
3006 Mon Feb 14 13:58:34 2011 Completed.
3007 Mon Feb 14 13:58:34 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
3008 Mon Feb 14 13:58:34 2011 Completed.
3009 Mon Feb 14 13:58:34 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
3010 Mon Feb 14 13:58:35 2011 Received.
3011 Mon Feb 14 13:58:35 2011 Starting 300 seconds test run.
3012 Child 0 - 200 aborted ops
3013 Child 1 - 250 aborted ops
3014 Child 3 - 50 aborted ops
3015 Child 0 - 250 aborted ops
3016 Child 2 - 50 aborted ops
3017 Child 1 - 300 aborted ops
3018 Child 0 - 300 aborted ops
3019 Child 3 - 100 aborted ops
3020 Child 2 - 100 aborted ops
3021 Child 1 - 350 aborted ops
3022 Child 0 - 350 aborted ops
3023 Child 3 - 150 aborted ops
3024 Child 1 - 400 aborted ops
3025 Child 2 - 150 aborted ops
3026 Child 3 - 200 aborted ops
3027 Child 0 - 400 aborted ops
3028 Child 2 - 200 aborted ops
3029 Child 1 - 450 aborted ops
3030 Child 3 - 250 aborted ops
3031 Child 2 - 250 aborted ops
3032 Child 3 - 300 aborted ops
3033 Child 1 - 500 aborted ops
3034 Child 0 - 450 aborted ops
3035 Child 2 - 300 aborted ops
3036 Child 3 - 350 aborted ops
3037 Child 0 - 500 aborted ops
3038 Child 2 - 350 aborted ops
3039 Child 1 - 550 aborted ops
3040 Child 3 - 400 aborted ops
3041 Child 2 - 400 aborted ops
3042 Child 3 - 450 aborted ops
3043 Child 1 - 600 aborted ops
3044 Child 0 - 550 aborted ops
3045 Child 3 - 500 aborted ops
3046 Child 2 - 450 aborted ops
3047 Child 1 - 650 aborted ops
3048 Child 0 - 600 aborted ops
3049 Child 3 - 550 aborted ops
3050 Child 1 - 700 aborted ops
3051 Child 2 - 500 aborted ops
3052 Child 0 - 650 aborted ops
3053 Child 1 - 750 aborted ops
3054 Child 3 - 600 aborted ops
3055 Child 0 - 700 aborted ops
3056 Child 1 - 800 aborted ops
3057 SFS Single Client (c09-44) Results, Mon Feb 14 14:03:45 2011
3058 --------------------------------------------------------------------------------------
3059 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
3060 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
3061 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
3062            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
3063 --------------------------------------------------------------------------------------
3064 getattr     26.0%    26.2%   123365   123365      0      0.21     0.33      0.00  1.9%
3065 setattr      4.0%     4.0%    18910    18910      0      7.93    29.16      0.08 11.0%
3066 lookup      24.0%    24.0%   113235   113235      0      0.22     0.29      0.00  1.8%
3067 readlink     1.0%     1.0%     4892     4892      0      0.21     0.17      0.01  0.1%
3068 read        18.0%    18.1%    85504   105008      0      4.38    31.21      0.04 27.6%
3069 write       10.0%    10.0%    47237    57350      0      7.26    25.18      0.05 25.3%
3070 create       1.0%     1.0%     4773     4773      0     11.40    48.14      0.20  4.0%
3071 remove       1.0%     0.5%     2431     2431      0      8.22    23.00      0.19  1.5%
3072 readdir      1.0%     1.0%     4656     4656      0      0.43     0.17      0.01  0.1%
3073 fsstat       1.0%     1.0%     4739     4739      0      0.21     0.13      0.01  0.1%
3074 access      11.0%    11.0%    52032    52032      0      0.21     0.19      0.00  0.8%
3075 commit       0.0%     0.0%        0    28304      0      0.00     0.00      0.00 25.2%
3076 readdirplus  2.0%     2.0%     9446     9446      0      0.73     0.60      0.02  0.5%
3077 --------------------------------------------------------------------------------------
3078
3079       --------------------------------------------------
3080       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
3081       --------------------------+-----------------------
3082 SFS NFS V3 THROUGHPUT: 1575.98 Ops/Sec   AVG. RESPONSE TIME:    2.87 Msec/Op
3083 TCP PROTOCOL
3084 FAST CALLS: 0
3085 NFS V3 MIXFILE: [ SFS Default ]
3086 CLIENT REQUESTED LOAD: 2600 Ops/Sec 
3087 TOTAL LOGICAL NFS V3 OPERATIONS:  471220         TEST TIME: 299 Sec 
3088 TOTAL PHYSICAL NFS V3 OPERATIONS: 529141   
3089 PHYSICAL NFS V3 THROUGHPUT: 1769.70 Ops/Sec
3090 FILE SET SIZE CREATED: 10622124.0 KB
3091 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
3092
3093 ------------------------------------------------------------------------
3094
3095 Mon Feb 14 14:03:45 2011 Completed.
3096
3097 Client Test Parameters: 
3098         Number of processes = 4
3099         Requested Load (NFS V3 operations/second) = 2600
3100         Maximum number of outstanding biod writes = 2
3101         Maximum number of outstanding biod reads = 2
3102         Warm-up time (seconds) = 300
3103         Run time (seconds) = 300
3104         File Set = 20004 Files created for I/O operations
3105                    6000 Files accessed for I/O operations
3106                     404 Files for non-I/O operations
3107                      24 Symlinks
3108                     664 Directories
3109                         Additional non-I/O files created as necessary
3110
3111
3112 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
3113 Mon Feb 14 14:03:45 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
3114 Mon Feb 14 14:03:45 2011 Completed.
3115 Mon Feb 14 14:03:45 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
3116
3117 ************************************************************************
3118 Mon Feb 14 14:03:46 2011 Received.
3119 Mon Feb 14 14:03:46 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
3120 Mon Feb 14 14:03:46 2011 Completed.
3121 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 2800  -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 
3122 NFS V3 Protocol Version
3123
3124 ************************************************************************
3125 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
3126 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
3127
3128 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
3129 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3130
3131 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 14:03:48 2011
3132         Client hostname = c09-44
3133         Prime Client hostname = c09-44.sysnet.ucsd.edu
3134
3135 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3136 NFS V3 Protocol
3137 Mon Feb 14 14:03:48 2011 Mounting 4 remote test directories.
3138 Child[000]: NFS negotiated block size 32768
3139 Child[001]: NFS negotiated block size 32768
3140 Child[002]: NFS negotiated block size 32768
3141 Child[003]: NFS negotiated block size 32768
3142 Mon Feb 14 14:03:59 2011 Completed.
3143 Mon Feb 14 14:03:59 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
3144 Mon Feb 14 14:03:59 2011 Completed.
3145 Mon Feb 14 14:03:59 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
3146 Mon Feb 14 14:04:04 2011 Received.
3147
3148 Mon Feb 14 14:04:04 2011 Initializing test directories.
3149 Mon Feb 14 14:04:04 2011 Child 1 will create 167 directories.
3150 Mon Feb 14 14:04:04 2011 Child 0 will create 167 directories.
3151 Mon Feb 14 14:04:04 2011 Child 2 will create 167 directories.
3152 Mon Feb 14 14:04:04 2011 Child 3 will create 167 directories.
3153 Mon Feb 14 14:04:10 2011 Child 0 finished creating 167 directories.
3154 Mon Feb 14 14:04:10 2011 Child 0 will create 5102 files.
3155 Mon Feb 14 14:04:14 2011 Child 1 finished creating 167 directories.
3156 Mon Feb 14 14:04:14 2011 Child 1 will create 5102 files.
3157 Mon Feb 14 14:04:17 2011 Child 2 finished creating 167 directories.
3158 Mon Feb 14 14:04:17 2011 Child 2 will create 5102 files.
3159 Mon Feb 14 14:04:20 2011 Child 3 finished creating 167 directories.
3160 Mon Feb 14 14:04:20 2011 Child 3 will create 5102 files.
3161 Mon Feb 14 14:04:39 2011 Child 0 verified 5102 files, created 51
3162 Mon Feb 14 14:04:39 2011 Child 0 will create 6 symlinks.
3163 Mon Feb 14 14:04:40 2011 Child 0 finished creating 6 symlinks.
3164 Mon Feb 14 14:04:50 2011 Child 1 verified 5102 files, created 49
3165 Mon Feb 14 14:04:50 2011 Child 1 will create 6 symlinks.
3166 Mon Feb 14 14:04:50 2011 Child 1 finished creating 6 symlinks.
3167 Mon Feb 14 14:04:52 2011 Child 2 verified 5102 files, created 51
3168 Mon Feb 14 14:04:52 2011 Child 2 will create 6 symlinks.
3169 Mon Feb 14 14:04:52 2011 Child 2 finished creating 6 symlinks.
3170 Mon Feb 14 14:04:53 2011 Child 3 verified 5102 files, created 51
3171 Mon Feb 14 14:04:53 2011 Child 3 will create 6 symlinks.
3172 Mon Feb 14 14:04:53 2011 Child 3 finished creating 6 symlinks.
3173 Mon Feb 14 14:04:54 2011 Completed.
3174 Mon Feb 14 14:04:54 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
3175 Mon Feb 14 14:04:54 2011 Completed.
3176 Mon Feb 14 14:04:54 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
3177 Mon Feb 14 14:04:55 2011 Received.
3178 Mon Feb 14 14:04:55 2011 Performing 300 seconds pretest warmup.
3179 Child 2 - 50 aborted ops
3180 Child 0 - 50 aborted ops
3181 Child 0 - 100 aborted ops
3182 Child 0 - 150 aborted ops
3183 Child 0 - 200 aborted ops
3184 Child 3 - 50 aborted ops
3185 Mon Feb 14 14:09:55 2011 Completed.
3186 Mon Feb 14 14:09:55 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
3187 Mon Feb 14 14:09:55 2011 Completed.
3188 Mon Feb 14 14:09:55 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
3189 Mon Feb 14 14:09:56 2011 Received.
3190 Mon Feb 14 14:09:56 2011 Starting 300 seconds test run.
3191 Child 1 - 50 aborted ops
3192 Child 3 - 100 aborted ops
3193 Child 3 - 150 aborted ops
3194 Child 1 - 100 aborted ops
3195 Child 2 - 100 aborted ops
3196 Child 0 - 250 aborted ops
3197 Child 3 - 200 aborted ops
3198 Child 1 - 150 aborted ops
3199 Child 2 - 150 aborted ops
3200 Child 0 - 300 aborted ops
3201 Child 2 - 200 aborted ops
3202 Child 3 - 250 aborted ops
3203 Child 1 - 200 aborted ops
3204 Child 0 - 350 aborted ops
3205 Child 3 - 300 aborted ops
3206 Child 2 - 250 aborted ops
3207 Child 1 - 250 aborted ops
3208 Child 3 - 350 aborted ops
3209 Child 0 - 400 aborted ops
3210 Child 2 - 300 aborted ops
3211 Child 3 - 400 aborted ops
3212 Child 0 - 450 aborted ops
3213 Child 1 - 300 aborted ops
3214 Child 2 - 350 aborted ops
3215 Child 1 - 350 aborted ops
3216 Child 0 - 500 aborted ops
3217 Child 3 - 450 aborted ops
3218 Child 0 - 550 aborted ops
3219 Child 1 - 400 aborted ops
3220 Child 3 - 500 aborted ops
3221 Child 2 - 400 aborted ops
3222 Child 3 - 550 aborted ops
3223 Child 2 - 450 aborted ops
3224 Child 1 - 450 aborted ops
3225 Child 0 - 600 aborted ops
3226 Child 3 - 600 aborted ops
3227 Child 2 - 500 aborted ops
3228 Child 1 - 500 aborted ops
3229 Child 0 - 650 aborted ops
3230 Child 2 - 550 aborted ops
3231 Child 3 - 650 aborted ops
3232 Child 0 - 700 aborted ops
3233 Child 1 - 550 aborted ops
3234 Child 2 - 600 aborted ops
3235 Child 3 - 700 aborted ops
3236 Child 1 - 600 aborted ops
3237 Child 2 - 650 aborted ops
3238 Child 0 - 750 aborted ops
3239 SFS Single Client (c09-44) Results, Mon Feb 14 14:15:06 2011
3240 --------------------------------------------------------------------------------------
3241 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
3242 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
3243 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
3244            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
3245 --------------------------------------------------------------------------------------
3246 getattr     26.0%    26.2%   124988   124988      0      0.21     0.16      0.00  1.9%
3247 setattr      4.0%     4.0%    19035    19035      0      7.78    24.66      0.07 10.9%
3248 lookup      24.0%    24.2%   115396   115396      0      0.22     0.26      0.00  1.9%
3249 readlink     1.0%     1.0%     4728     4728      0      0.21     0.14      0.01  0.1%
3250 read        18.0%    18.1%    86314   106215      0      4.10    26.98      0.03 26.2%
3251 write       10.0%    10.1%    48047    57690      0      7.39    28.65      0.05 26.2%
3252 create       1.0%     1.0%     4697     4697      0     10.48    27.00      0.15  3.6%
3253 remove       1.0%     0.5%     2363     2363      0      8.18    20.25      0.18  1.4%
3254 readdir      1.0%     1.0%     4771     4771      0      0.43     0.16      0.01  0.2%
3255 fsstat       1.0%     1.0%     4727     4727      0      0.22     0.16      0.01  0.1%
3256 access      11.0%    11.1%    52960    52960      0      0.21     0.38      0.01  0.8%
3257 commit       0.0%     0.0%        0    28747      0      0.00     0.00      0.00 26.2%
3258 readdirplus  2.0%     2.0%     9649     9649      0      0.72     0.42      0.01  0.5%
3259 --------------------------------------------------------------------------------------
3260
3261       --------------------------------------------------
3262       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
3263       --------------------------+-----------------------
3264 SFS NFS V3 THROUGHPUT: 1592.25 Ops/Sec   AVG. RESPONSE TIME:    2.83 Msec/Op
3265 TCP PROTOCOL
3266 FAST CALLS: 0
3267 NFS V3 MIXFILE: [ SFS Default ]
3268 CLIENT REQUESTED LOAD: 2800 Ops/Sec 
3269 TOTAL LOGICAL NFS V3 OPERATIONS:  477675         TEST TIME: 300 Sec 
3270 TOTAL PHYSICAL NFS V3 OPERATIONS: 535966   
3271 PHYSICAL NFS V3 THROUGHPUT: 1786.55 Ops/Sec
3272 FILE SET SIZE CREATED: 10622124.0 KB
3273 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
3274
3275 ------------------------------------------------------------------------
3276
3277 Mon Feb 14 14:15:06 2011 Completed.
3278
3279 Client Test Parameters: 
3280         Number of processes = 4
3281         Requested Load (NFS V3 operations/second) = 2800
3282         Maximum number of outstanding biod writes = 2
3283         Maximum number of outstanding biod reads = 2
3284         Warm-up time (seconds) = 300
3285         Run time (seconds) = 300
3286         File Set = 20004 Files created for I/O operations
3287                    6000 Files accessed for I/O operations
3288                     404 Files for non-I/O operations
3289                      24 Symlinks
3290                     664 Directories
3291                         Additional non-I/O files created as necessary
3292
3293
3294 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
3295 Mon Feb 14 14:15:06 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
3296 Mon Feb 14 14:15:06 2011 Completed.
3297 Mon Feb 14 14:15:06 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
3298
3299 ************************************************************************
3300 Mon Feb 14 14:15:07 2011 Received.
3301 Mon Feb 14 14:15:07 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
3302 Mon Feb 14 14:15:07 2011 Completed.
3303 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 3000  -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 
3304 NFS V3 Protocol Version
3305
3306 ************************************************************************
3307 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
3308 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
3309
3310 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
3311 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3312
3313 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 14:15:09 2011
3314         Client hostname = c09-44
3315         Prime Client hostname = c09-44.sysnet.ucsd.edu
3316
3317 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3318 NFS V3 Protocol
3319 Mon Feb 14 14:15:09 2011 Mounting 4 remote test directories.
3320 Child[000]: NFS negotiated block size 32768
3321 Child[001]: NFS negotiated block size 32768
3322 Child[002]: NFS negotiated block size 32768
3323 Child[003]: NFS negotiated block size 32768
3324 Mon Feb 14 14:15:20 2011 Completed.
3325 Mon Feb 14 14:15:20 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
3326 Mon Feb 14 14:15:20 2011 Completed.
3327 Mon Feb 14 14:15:20 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
3328 Mon Feb 14 14:15:25 2011 Received.
3329
3330 Mon Feb 14 14:15:25 2011 Initializing test directories.
3331 Mon Feb 14 14:15:25 2011 Child 0 will create 167 directories.
3332 Mon Feb 14 14:15:25 2011 Child 3 will create 167 directories.
3333 Mon Feb 14 14:15:25 2011 Child 2 will create 167 directories.
3334 Mon Feb 14 14:15:25 2011 Child 1 will create 167 directories.
3335 Mon Feb 14 14:15:26 2011 Child 0 finished creating 167 directories.
3336 Mon Feb 14 14:15:26 2011 Child 0 will create 5102 files.
3337 Mon Feb 14 14:15:29 2011 Child 1 finished creating 167 directories.
3338 Mon Feb 14 14:15:29 2011 Child 1 will create 5102 files.
3339 Mon Feb 14 14:15:32 2011 Child 2 finished creating 167 directories.
3340 Mon Feb 14 14:15:32 2011 Child 2 will create 5102 files.
3341 Mon Feb 14 14:15:35 2011 Child 3 finished creating 167 directories.
3342 Mon Feb 14 14:15:35 2011 Child 3 will create 5102 files.
3343 Mon Feb 14 14:15:54 2011 Child 0 verified 5102 files, created 50
3344 Mon Feb 14 14:15:54 2011 Child 0 will create 6 symlinks.
3345 Mon Feb 14 14:15:54 2011 Child 0 finished creating 6 symlinks.
3346 Mon Feb 14 14:16:01 2011 Child 1 verified 5102 files, created 51
3347 Mon Feb 14 14:16:01 2011 Child 1 will create 6 symlinks.
3348 Mon Feb 14 14:16:02 2011 Child 1 finished creating 6 symlinks.
3349 Mon Feb 14 14:16:03 2011 Child 2 verified 5102 files, created 51
3350 Mon Feb 14 14:16:03 2011 Child 2 will create 6 symlinks.
3351 Mon Feb 14 14:16:03 2011 Child 2 finished creating 6 symlinks.
3352 Mon Feb 14 14:16:05 2011 Child 3 verified 5102 files, created 50
3353 Mon Feb 14 14:16:05 2011 Child 3 will create 6 symlinks.
3354 Mon Feb 14 14:16:05 2011 Child 3 finished creating 6 symlinks.
3355 Mon Feb 14 14:16:06 2011 Completed.
3356 Mon Feb 14 14:16:06 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
3357 Mon Feb 14 14:16:06 2011 Completed.
3358 Mon Feb 14 14:16:06 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
3359 Mon Feb 14 14:16:07 2011 Received.
3360 Mon Feb 14 14:16:07 2011 Performing 300 seconds pretest warmup.
3361 Child 1 - 50 aborted ops
3362 Child 1 - 100 aborted ops
3363 Child 2 - 50 aborted ops
3364 Child 1 - 150 aborted ops
3365 Mon Feb 14 14:21:07 2011 Completed.
3366 Mon Feb 14 14:21:07 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
3367 Mon Feb 14 14:21:07 2011 Completed.
3368 Mon Feb 14 14:21:07 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
3369 Mon Feb 14 14:21:08 2011 Received.
3370 Mon Feb 14 14:21:08 2011 Starting 300 seconds test run.
3371 Child 2 - 100 aborted ops
3372 Child 1 - 200 aborted ops
3373 Child 2 - 150 aborted ops
3374 Child 0 - 50 aborted ops
3375 Child 1 - 250 aborted ops
3376 Child 2 - 200 aborted ops
3377 Child 3 - 50 aborted ops
3378 Child 0 - 100 aborted ops
3379 Child 2 - 250 aborted ops
3380 Child 1 - 300 aborted ops
3381 Child 3 - 100 aborted ops
3382 Child 0 - 150 aborted ops
3383 Child 1 - 350 aborted ops
3384 Child 2 - 300 aborted ops
3385 Child 0 - 200 aborted ops
3386 Child 1 - 400 aborted ops
3387 Child 3 - 150 aborted ops
3388 Child 2 - 350 aborted ops
3389 Child 0 - 250 aborted ops
3390 Child 3 - 200 aborted ops
3391 Child 1 - 450 aborted ops
3392 Child 1 - 500 aborted ops
3393 Child 3 - 250 aborted ops
3394 Child 2 - 400 aborted ops
3395 Child 0 - 300 aborted ops
3396 Child 2 - 450 aborted ops
3397 Child 1 - 550 aborted ops
3398 Child 3 - 300 aborted ops
3399 Child 0 - 350 aborted ops
3400 Child 2 - 500 aborted ops
3401 Child 3 - 350 aborted ops
3402 Child 1 - 600 aborted ops
3403 Child 0 - 400 aborted ops
3404 Child 2 - 550 aborted ops
3405 Child 1 - 650 aborted ops
3406 Child 3 - 400 aborted ops
3407 Child 0 - 450 aborted ops
3408 Child 2 - 600 aborted ops
3409 Child 1 - 700 aborted ops
3410 Child 0 - 500 aborted ops
3411 Child 3 - 450 aborted ops
3412 SFS Single Client (c09-44) Results, Mon Feb 14 14:26:18 2011
3413 --------------------------------------------------------------------------------------
3414 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
3415 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
3416 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
3417            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
3418 --------------------------------------------------------------------------------------
3419 getattr     26.0%    26.1%   107105   107105      0      0.21     0.32      0.00  1.6%
3420 setattr      4.0%     4.0%    16525    16525      0      8.90    27.36      0.08 10.7%
3421 lookup      24.0%    24.1%    98893    98893      0      0.22     0.48      0.00  1.5%
3422 readlink     1.0%     1.0%     4019     4019      0      0.21     0.11      0.01  0.1%
3423 read        18.0%    18.1%    74032    91244      0      5.42    32.02      0.04 29.2%
3424 write       10.0%    10.0%    41131    49644      0      8.68   104.98      0.10 26.0%
3425 create       1.0%     1.0%     4168     4168      0     12.40    34.79      0.18  3.8%
3426 remove       1.0%     0.5%     2017     2017      0     10.16    33.74      0.25  1.5%
3427 readdir      1.0%     1.0%     4071     4071      0      0.42     0.14      0.01  0.1%
3428 fsstat       1.0%     1.0%     4161     4161      0      0.21     0.37      0.02  0.1%
3429 access      11.0%    11.1%    45428    45428      0      0.21     0.21      0.00  0.7%
3430 commit       0.0%     0.0%        0    24622      0      0.00     0.00      0.00 24.4%
3431 readdirplus  2.0%     2.0%     8133     8133      0      0.75     2.07      0.03  0.4%
3432 --------------------------------------------------------------------------------------
3433
3434       --------------------------------------------------
3435       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
3436       --------------------------+-----------------------
3437 SFS NFS V3 THROUGHPUT: 1365.61 Ops/Sec   AVG. RESPONSE TIME:    3.35 Msec/Op
3438 TCP PROTOCOL
3439 FAST CALLS: 0
3440 NFS V3 MIXFILE: [ SFS Default ]
3441 CLIENT REQUESTED LOAD: 3000 Ops/Sec 
3442 TOTAL LOGICAL NFS V3 OPERATIONS:  409683         TEST TIME: 300 Sec 
3443 TOTAL PHYSICAL NFS V3 OPERATIONS: 460030   
3444 PHYSICAL NFS V3 THROUGHPUT: 1533.43 Ops/Sec
3445 FILE SET SIZE CREATED: 10622124.0 KB
3446 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
3447
3448 ------------------------------------------------------------------------
3449
3450 Mon Feb 14 14:26:18 2011 Completed.
3451
3452 Client Test Parameters: 
3453         Number of processes = 4
3454         Requested Load (NFS V3 operations/second) = 3000
3455         Maximum number of outstanding biod writes = 2
3456         Maximum number of outstanding biod reads = 2
3457         Warm-up time (seconds) = 300
3458         Run time (seconds) = 300
3459         File Set = 20004 Files created for I/O operations
3460                    6000 Files accessed for I/O operations
3461                     404 Files for non-I/O operations
3462                      24 Symlinks
3463                     664 Directories
3464                         Additional non-I/O files created as necessary
3465
3466
3467 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
3468 Mon Feb 14 14:26:18 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
3469 Mon Feb 14 14:26:18 2011 Completed.
3470 Mon Feb 14 14:26:18 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
3471
3472 ************************************************************************
3473 Mon Feb 14 14:26:19 2011 Received.
3474 Mon Feb 14 14:26:19 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
3475 Mon Feb 14 14:26:19 2011 Completed.
3476 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 3200  -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 
3477 NFS V3 Protocol Version
3478
3479 ************************************************************************
3480 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
3481 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
3482
3483 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
3484 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3485
3486 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 14:26:21 2011
3487         Client hostname = c09-44
3488         Prime Client hostname = c09-44.sysnet.ucsd.edu
3489
3490 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3491 NFS V3 Protocol
3492 Mon Feb 14 14:26:21 2011 Mounting 4 remote test directories.
3493 Child[000]: NFS negotiated block size 32768
3494 Child[001]: NFS negotiated block size 32768
3495 Child[002]: NFS negotiated block size 32768
3496 Child[003]: NFS negotiated block size 32768
3497 Mon Feb 14 14:26:32 2011 Completed.
3498 Mon Feb 14 14:26:32 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
3499 Mon Feb 14 14:26:32 2011 Completed.
3500 Mon Feb 14 14:26:32 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
3501 Mon Feb 14 14:26:37 2011 Received.
3502
3503 Mon Feb 14 14:26:37 2011 Initializing test directories.
3504 Mon Feb 14 14:26:37 2011 Child 2 will create 167 directories.
3505 Mon Feb 14 14:26:37 2011 Child 3 will create 167 directories.
3506 Mon Feb 14 14:26:37 2011 Child 1 will create 167 directories.
3507 Mon Feb 14 14:26:37 2011 Child 0 will create 167 directories.
3508 Mon Feb 14 14:26:37 2011 Child 2 finished creating 167 directories.
3509 Mon Feb 14 14:26:37 2011 Child 2 will create 5102 files.
3510 Mon Feb 14 14:26:40 2011 Child 3 finished creating 167 directories.
3511 Mon Feb 14 14:26:40 2011 Child 3 will create 5102 files.
3512 Mon Feb 14 14:26:51 2011 Child 0 finished creating 167 directories.
3513 Mon Feb 14 14:26:51 2011 Child 0 will create 5102 files.
3514 Mon Feb 14 14:26:51 2011 Child 1 finished creating 167 directories.
3515 Mon Feb 14 14:26:51 2011 Child 1 will create 5102 files.
3516 Mon Feb 14 14:26:58 2011 Child 2 verified 5102 files, created 49
3517 Mon Feb 14 14:26:58 2011 Child 2 will create 6 symlinks.
3518 Mon Feb 14 14:26:58 2011 Child 2 finished creating 6 symlinks.
3519 Mon Feb 14 14:27:05 2011 Child 3 verified 5102 files, created 51
3520 Mon Feb 14 14:27:05 2011 Child 3 will create 6 symlinks.
3521 Mon Feb 14 14:27:05 2011 Child 3 finished creating 6 symlinks.
3522 Mon Feb 14 14:27:18 2011 Child 1 verified 5102 files, created 51
3523 Mon Feb 14 14:27:18 2011 Child 1 will create 6 symlinks.
3524 Mon Feb 14 14:27:18 2011 Child 0 verified 5102 files, created 51
3525 Mon Feb 14 14:27:18 2011 Child 0 will create 6 symlinks.
3526 Mon Feb 14 14:27:18 2011 Child 1 finished creating 6 symlinks.
3527 Mon Feb 14 14:27:18 2011 Child 0 finished creating 6 symlinks.
3528 Mon Feb 14 14:27:19 2011 Completed.
3529 Mon Feb 14 14:27:19 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
3530 Mon Feb 14 14:27:19 2011 Completed.
3531 Mon Feb 14 14:27:19 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
3532 Mon Feb 14 14:27:19 2011 Received.
3533 Mon Feb 14 14:27:19 2011 Performing 300 seconds pretest warmup.
3534 Child 1 - 50 aborted ops
3535 Child 1 - 100 aborted ops
3536 Child 0 - 50 aborted ops
3537 Child 1 - 150 aborted ops
3538 Mon Feb 14 14:32:19 2011 Completed.
3539 Mon Feb 14 14:32:19 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
3540 Mon Feb 14 14:32:19 2011 Completed.
3541 Mon Feb 14 14:32:19 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
3542 Mon Feb 14 14:32:20 2011 Received.
3543 Mon Feb 14 14:32:20 2011 Starting 300 seconds test run.
3544 Child 1 - 200 aborted ops
3545 Child 0 - 100 aborted ops
3546 Child 1 - 250 aborted ops
3547 Child 1 - 300 aborted ops
3548 Child 2 - 50 aborted ops
3549 Child 0 - 150 aborted ops
3550 Child 2 - 100 aborted ops
3551 Child 0 - 200 aborted ops
3552 Child 3 - 50 aborted ops
3553 Child 3 - 100 aborted ops
3554 Child 2 - 150 aborted ops
3555 Child 1 - 350 aborted ops
3556 Child 0 - 250 aborted ops
3557 Child 3 - 150 aborted ops
3558 Child 2 - 200 aborted ops
3559 Child 1 - 400 aborted ops
3560 Child 0 - 300 aborted ops
3561 Child 2 - 250 aborted ops
3562 Child 3 - 200 aborted ops
3563 Child 1 - 450 aborted ops
3564 Child 0 - 350 aborted ops
3565 Child 2 - 300 aborted ops
3566 Child 3 - 250 aborted ops
3567 Child 1 - 500 aborted ops
3568 Child 0 - 400 aborted ops
3569 Child 2 - 350 aborted ops
3570 Child 1 - 550 aborted ops
3571 Child 3 - 300 aborted ops
3572 Child 2 - 400 aborted ops
3573 Child 0 - 450 aborted ops
3574 Child 3 - 350 aborted ops
3575 Child 2 - 450 aborted ops
3576 Child 1 - 600 aborted ops
3577 SFS Single Client (c09-44) Results, Mon Feb 14 14:37:30 2011
3578 --------------------------------------------------------------------------------------
3579 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
3580 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
3581 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
3582            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
3583 --------------------------------------------------------------------------------------
3584 getattr     26.0%    26.3%    90208    90208      0      0.21     0.35      0.00  1.4%
3585 setattr      4.0%     4.0%    13883    13883      0     11.40    30.05      0.09 11.5%
3586 lookup      24.0%    24.0%    82521    82521      0      0.21     0.24      0.00  1.3%
3587 readlink     1.0%     1.0%     3482     3482      0      0.21     0.11      0.01  0.1%
3588 read        18.0%    18.1%    62018    76725      0      6.72    34.73      0.05 30.3%
3589 write       10.0%    10.0%    34220    41382      0      9.33    31.26      0.06 23.2%
3590 create       1.0%     1.0%     3363     3363      0     17.61    53.36      0.25  4.3%
3591 remove       1.0%     0.5%     1803     1803      0     13.49    42.55      0.30  1.8%
3592 readdir      1.0%     1.0%     3448     3448      0      0.42     0.15      0.01  0.1%
3593 fsstat       1.0%     1.0%     3441     3441      0      0.21     0.18      0.01  0.1%
3594 access      11.0%    11.0%    37812    37812      0      0.21     0.20      0.00  0.6%
3595 commit       0.0%     0.0%        0    20400      0      0.00     0.00      0.00 25.2%
3596 readdirplus  2.0%     2.0%     6961     6961      0      0.71     0.48      0.02  0.4%
3597 --------------------------------------------------------------------------------------
3598
3599       --------------------------------------------------
3600       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
3601       --------------------------+-----------------------
3602 SFS NFS V3 THROUGHPUT: 1147.69 Ops/Sec   AVG. RESPONSE TIME:    4.01 Msec/Op
3603 TCP PROTOCOL
3604 FAST CALLS: 0
3605 NFS V3 MIXFILE: [ SFS Default ]
3606 CLIENT REQUESTED LOAD: 3200 Ops/Sec 
3607 TOTAL LOGICAL NFS V3 OPERATIONS:  343160         TEST TIME: 299 Sec 
3608 TOTAL PHYSICAL NFS V3 OPERATIONS: 385429   
3609 PHYSICAL NFS V3 THROUGHPUT: 1289.06 Ops/Sec
3610 FILE SET SIZE CREATED: 10622124.0 KB
3611 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
3612
3613 ------------------------------------------------------------------------
3614
3615 Mon Feb 14 14:37:30 2011 Completed.
3616
3617 Client Test Parameters: 
3618         Number of processes = 4
3619         Requested Load (NFS V3 operations/second) = 3200
3620         Maximum number of outstanding biod writes = 2
3621         Maximum number of outstanding biod reads = 2
3622         Warm-up time (seconds) = 300
3623         Run time (seconds) = 300
3624         File Set = 20004 Files created for I/O operations
3625                    6000 Files accessed for I/O operations
3626                     404 Files for non-I/O operations
3627                      24 Symlinks
3628                     664 Directories
3629                         Additional non-I/O files created as necessary
3630
3631
3632 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
3633 Mon Feb 14 14:37:30 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
3634 Mon Feb 14 14:37:30 2011 Completed.
3635 Mon Feb 14 14:37:30 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
3636
3637 ************************************************************************
3638 Mon Feb 14 14:37:31 2011 Received.
3639 Mon Feb 14 14:37:31 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
3640 Mon Feb 14 14:37:31 2011 Completed.
3641 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 3400  -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 
3642 NFS V3 Protocol Version
3643
3644 ************************************************************************
3645 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
3646 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
3647
3648 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
3649 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3650
3651 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 14:37:33 2011
3652         Client hostname = c09-44
3653         Prime Client hostname = c09-44.sysnet.ucsd.edu
3654
3655 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3656 NFS V3 Protocol
3657 Mon Feb 14 14:37:33 2011 Mounting 4 remote test directories.
3658 Child[000]: NFS negotiated block size 32768
3659 Child[001]: NFS negotiated block size 32768
3660 Child[002]: NFS negotiated block size 32768
3661 Child[003]: NFS negotiated block size 32768
3662 Mon Feb 14 14:37:44 2011 Completed.
3663 Mon Feb 14 14:37:44 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
3664 Mon Feb 14 14:37:44 2011 Completed.
3665 Mon Feb 14 14:37:44 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
3666 Mon Feb 14 14:37:49 2011 Received.
3667
3668 Mon Feb 14 14:37:49 2011 Initializing test directories.
3669 Mon Feb 14 14:37:49 2011 Child 0 will create 167 directories.
3670 Mon Feb 14 14:37:49 2011 Child 3 will create 167 directories.
3671 Mon Feb 14 14:37:49 2011 Child 1 will create 167 directories.
3672 Mon Feb 14 14:37:49 2011 Child 2 will create 167 directories.
3673 Mon Feb 14 14:37:51 2011 Child 2 finished creating 167 directories.
3674 Mon Feb 14 14:37:51 2011 Child 2 will create 5102 files.
3675 Mon Feb 14 14:37:54 2011 Child 0 finished creating 167 directories.
3676 Mon Feb 14 14:37:54 2011 Child 0 will create 5102 files.
3677 Mon Feb 14 14:38:03 2011 Child 3 finished creating 167 directories.
3678 Mon Feb 14 14:38:03 2011 Child 3 will create 5102 files.
3679 Mon Feb 14 14:38:05 2011 Child 1 finished creating 167 directories.
3680 Mon Feb 14 14:38:05 2011 Child 1 will create 5102 files.
3681 Mon Feb 14 14:38:23 2011 Child 2 verified 5102 files, created 49
3682 Mon Feb 14 14:38:23 2011 Child 2 will create 6 symlinks.
3683 Mon Feb 14 14:38:23 2011 Child 2 finished creating 6 symlinks.
3684 Mon Feb 14 14:38:30 2011 Child 0 verified 5102 files, created 50
3685 Mon Feb 14 14:38:30 2011 Child 0 will create 6 symlinks.
3686 Mon Feb 14 14:38:30 2011 Child 0 finished creating 6 symlinks.
3687 Mon Feb 14 14:38:38 2011 Child 3 verified 5102 files, created 51
3688 Mon Feb 14 14:38:38 2011 Child 3 will create 6 symlinks.
3689 Mon Feb 14 14:38:38 2011 Child 3 finished creating 6 symlinks.
3690 Mon Feb 14 14:38:39 2011 Child 1 verified 5102 files, created 51
3691 Mon Feb 14 14:38:39 2011 Child 1 will create 6 symlinks.
3692 Mon Feb 14 14:38:39 2011 Child 1 finished creating 6 symlinks.
3693 Mon Feb 14 14:38:39 2011 Completed.
3694 Mon Feb 14 14:38:39 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
3695 Mon Feb 14 14:38:39 2011 Completed.
3696 Mon Feb 14 14:38:39 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
3697 Mon Feb 14 14:38:40 2011 Received.
3698 Mon Feb 14 14:38:40 2011 Performing 300 seconds pretest warmup.
3699 Child 2 - 50 aborted ops
3700 Child 2 - 100 aborted ops
3701 Child 3 - 50 aborted ops
3702 Child 0 - 50 aborted ops
3703 Mon Feb 14 14:43:40 2011 Completed.
3704 Mon Feb 14 14:43:40 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
3705 Mon Feb 14 14:43:40 2011 Completed.
3706 Mon Feb 14 14:43:40 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
3707 Mon Feb 14 14:43:41 2011 Received.
3708 Mon Feb 14 14:43:41 2011 Starting 300 seconds test run.
3709 Child 0 - 100 aborted ops
3710 Child 3 - 100 aborted ops
3711 Child 0 - 150 aborted ops
3712 Child 3 - 150 aborted ops
3713 Child 2 - 150 aborted ops
3714 Child 1 - 50 aborted ops
3715 Child 3 - 200 aborted ops
3716 Child 2 - 200 aborted ops
3717 Child 0 - 200 aborted ops
3718 Child 1 - 100 aborted ops
3719 Child 2 - 250 aborted ops
3720 Child 1 - 150 aborted ops
3721 Child 3 - 250 aborted ops
3722 Child 0 - 250 aborted ops
3723 Child 2 - 300 aborted ops
3724 Child 1 - 200 aborted ops
3725 Child 3 - 300 aborted ops
3726 Child 0 - 300 aborted ops
3727 Child 2 - 350 aborted ops
3728 Child 1 - 250 aborted ops
3729 Child 0 - 350 aborted ops
3730 Child 3 - 350 aborted ops
3731 Child 0 - 400 aborted ops
3732 Child 2 - 400 aborted ops
3733 Child 1 - 300 aborted ops
3734 Child 3 - 400 aborted ops
3735 Child 0 - 450 aborted ops
3736 Child 2 - 450 aborted ops
3737 Child 1 - 350 aborted ops
3738 Child 3 - 450 aborted ops
3739 Child 2 - 500 aborted ops
3740 Child 3 - 500 aborted ops
3741 Child 0 - 500 aborted ops
3742 Child 1 - 400 aborted ops
3743 Child 2 - 550 aborted ops
3744 Child 1 - 450 aborted ops
3745 Child 3 - 550 aborted ops
3746 Child 0 - 550 aborted ops
3747 SFS Single Client (c09-44) Results, Mon Feb 14 14:48:51 2011
3748 --------------------------------------------------------------------------------------
3749 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
3750 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
3751 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
3752            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
3753 --------------------------------------------------------------------------------------
3754 getattr     26.0%    26.2%    99664    99664      0      0.21     0.52      0.00  1.5%
3755 setattr      4.0%     4.0%    15081    15081      0     10.10    33.70      0.09 11.2%
3756 lookup      24.0%    24.1%    91758    91758      0      0.21     0.28      0.00  1.4%
3757 readlink     1.0%     1.0%     3820     3820      0      0.21     0.11      0.01  0.1%
3758 read        18.0%    18.1%    68775    84696      0      5.51    31.92      0.04 27.8%
3759 write       10.0%    10.1%    38481    46233      0      8.40    30.23      0.05 23.7%
3760 create       1.0%     1.0%     3792     3792      0     14.23    50.50      0.23  4.0%
3761 remove       1.0%     0.5%     1894     1894      0     10.12    28.63      0.24  1.4%
3762 readdir      1.0%     1.0%     3813     3813      0      0.42     0.18      0.01  0.1%
3763 fsstat       1.0%     1.0%     3806     3806      0      0.21     0.11      0.01  0.1%
3764 access      11.0%    11.0%    42016    42016      0      0.21     0.14      0.00  0.6%
3765 commit       0.0%     0.0%        0    22844      0      0.00     0.00      0.00 27.6%
3766 readdirplus  2.0%     2.0%     7703     7703      0      0.72     0.50      0.02  0.4%
3767 --------------------------------------------------------------------------------------
3768
3769       --------------------------------------------------
3770       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
3771       --------------------------+-----------------------
3772 SFS NFS V3 THROUGHPUT: 1268.67 Ops/Sec   AVG. RESPONSE TIME:    3.57 Msec/Op
3773 TCP PROTOCOL
3774 FAST CALLS: 0
3775 NFS V3 MIXFILE: [ SFS Default ]
3776 CLIENT REQUESTED LOAD: 3400 Ops/Sec 
3777 TOTAL LOGICAL NFS V3 OPERATIONS:  380603         TEST TIME: 300 Sec 
3778 TOTAL PHYSICAL NFS V3 OPERATIONS: 427120   
3779 PHYSICAL NFS V3 THROUGHPUT: 1423.73 Ops/Sec
3780 FILE SET SIZE CREATED: 10622124.0 KB
3781 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
3782
3783 ------------------------------------------------------------------------
3784
3785 Mon Feb 14 14:48:51 2011 Completed.
3786
3787 Client Test Parameters: 
3788         Number of processes = 4
3789         Requested Load (NFS V3 operations/second) = 3400
3790         Maximum number of outstanding biod writes = 2
3791         Maximum number of outstanding biod reads = 2
3792         Warm-up time (seconds) = 300
3793         Run time (seconds) = 300
3794         File Set = 20004 Files created for I/O operations
3795                    6000 Files accessed for I/O operations
3796                     404 Files for non-I/O operations
3797                      24 Symlinks
3798                     664 Directories
3799                         Additional non-I/O files created as necessary
3800
3801
3802 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
3803 Mon Feb 14 14:48:51 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
3804 Mon Feb 14 14:48:51 2011 Completed.
3805 Mon Feb 14 14:48:51 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
3806
3807 ************************************************************************
3808 Mon Feb 14 14:48:52 2011 Received.
3809 Mon Feb 14 14:48:52 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
3810 Mon Feb 14 14:48:52 2011 Completed.
3811 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 3600  -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 
3812 NFS V3 Protocol Version
3813
3814 ************************************************************************
3815 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
3816 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
3817
3818 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
3819 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3820
3821 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 14:48:54 2011
3822         Client hostname = c09-44
3823         Prime Client hostname = c09-44.sysnet.ucsd.edu
3824
3825 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3826 NFS V3 Protocol
3827 Mon Feb 14 14:48:54 2011 Mounting 4 remote test directories.
3828 Child[000]: NFS negotiated block size 32768
3829 Child[002]: NFS negotiated block size 32768
3830 Child[003]: NFS negotiated block size 32768
3831 Child[001]: NFS negotiated block size 32768
3832 Mon Feb 14 14:49:10 2011 Completed.
3833 Mon Feb 14 14:49:10 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
3834 Mon Feb 14 14:49:10 2011 Completed.
3835 Mon Feb 14 14:49:10 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
3836 Mon Feb 14 14:49:10 2011 Received.
3837
3838 Mon Feb 14 14:49:10 2011 Initializing test directories.
3839 Mon Feb 14 14:49:10 2011 Child 2 will create 167 directories.
3840 Mon Feb 14 14:49:10 2011 Child 1 will create 167 directories.
3841 Mon Feb 14 14:49:10 2011 Child 3 will create 167 directories.
3842 Mon Feb 14 14:49:10 2011 Child 0 will create 167 directories.
3843 Mon Feb 14 14:49:14 2011 Child 0 finished creating 167 directories.
3844 Mon Feb 14 14:49:14 2011 Child 0 will create 5102 files.
3845 Mon Feb 14 14:49:20 2011 Child 1 finished creating 167 directories.
3846 Mon Feb 14 14:49:20 2011 Child 1 will create 5102 files.
3847 Mon Feb 14 14:49:22 2011 Child 2 finished creating 167 directories.
3848 Mon Feb 14 14:49:22 2011 Child 2 will create 5102 files.
3849 Mon Feb 14 14:49:25 2011 Child 3 finished creating 167 directories.
3850 Mon Feb 14 14:49:25 2011 Child 3 will create 5102 files.
3851 Mon Feb 14 14:49:38 2011 Child 0 verified 5102 files, created 50
3852 Mon Feb 14 14:49:38 2011 Child 0 will create 6 symlinks.
3853 Mon Feb 14 14:49:38 2011 Child 0 finished creating 6 symlinks.
3854 Mon Feb 14 14:49:50 2011 Child 1 verified 5102 files, created 46
3855 Mon Feb 14 14:49:50 2011 Child 1 will create 6 symlinks.
3856 Mon Feb 14 14:49:51 2011 Child 1 finished creating 6 symlinks.
3857 Mon Feb 14 14:49:53 2011 Child 2 verified 5102 files, created 50
3858 Mon Feb 14 14:49:53 2011 Child 2 will create 6 symlinks.
3859 Mon Feb 14 14:49:53 2011 Child 2 finished creating 6 symlinks.
3860 Mon Feb 14 14:49:54 2011 Child 3 verified 5102 files, created 51
3861 Mon Feb 14 14:49:54 2011 Child 3 will create 6 symlinks.
3862 Mon Feb 14 14:49:54 2011 Child 3 finished creating 6 symlinks.
3863 Mon Feb 14 14:49:55 2011 Completed.
3864 Mon Feb 14 14:49:55 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
3865 Mon Feb 14 14:49:55 2011 Completed.
3866 Mon Feb 14 14:49:55 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
3867 Mon Feb 14 14:49:56 2011 Received.
3868 Mon Feb 14 14:49:56 2011 Performing 300 seconds pretest warmup.
3869 Child 1 - 50 aborted ops
3870 Child 1 - 100 aborted ops
3871 Mon Feb 14 14:54:56 2011 Completed.
3872 Mon Feb 14 14:54:56 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
3873 Mon Feb 14 14:54:56 2011 Completed.
3874 Mon Feb 14 14:54:56 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
3875 Mon Feb 14 14:54:57 2011 Received.
3876 Mon Feb 14 14:54:57 2011 Starting 300 seconds test run.
3877 Child 1 - 150 aborted ops
3878 Child 2 - 50 aborted ops
3879 Child 1 - 200 aborted ops
3880 Child 3 - 50 aborted ops
3881 Child 0 - 50 aborted ops
3882 Child 2 - 100 aborted ops
3883 Child 1 - 250 aborted ops
3884 Child 2 - 150 aborted ops
3885 Child 3 - 100 aborted ops
3886 Child 0 - 100 aborted ops
3887 Child 1 - 300 aborted ops
3888 Child 3 - 150 aborted ops
3889 Child 0 - 150 aborted ops
3890 Child 2 - 200 aborted ops
3891 Child 1 - 350 aborted ops
3892 Child 0 - 200 aborted ops
3893 Child 1 - 400 aborted ops
3894 Child 2 - 250 aborted ops
3895 Child 3 - 200 aborted ops
3896 Child 1 - 450 aborted ops
3897 Child 0 - 250 aborted ops
3898 Child 2 - 300 aborted ops
3899 Child 1 - 500 aborted ops
3900 Child 0 - 300 aborted ops
3901 Child 3 - 250 aborted ops
3902 Child 2 - 350 aborted ops
3903 Child 1 - 550 aborted ops
3904 Child 3 - 300 aborted ops
3905 Child 0 - 350 aborted ops
3906 Child 1 - 600 aborted ops
3907 Child 3 - 350 aborted ops
3908 SFS Single Client (c09-44) Results, Mon Feb 14 15:00:07 2011
3909 --------------------------------------------------------------------------------------
3910 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
3911 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
3912 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
3913            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
3914 --------------------------------------------------------------------------------------
3915 getattr     26.0%    26.2%   100037   100037      0      0.21     0.46      0.00  1.5%
3916 setattr      4.0%     4.0%    15427    15427      0      9.21    34.59      0.09 10.0%
3917 lookup      24.0%    24.1%    92343    92343      0      0.21     0.43      0.00  1.4%
3918 readlink     1.0%     1.0%     3805     3805      0      0.21     0.39      0.02  0.1%
3919 read        18.0%    18.0%    69013    85245      0      6.83   120.38      0.08 33.3%
3920 write       10.0%    10.1%    38450    46607      0      9.05    31.96      0.06 24.6%
3921 create       1.0%     1.0%     3867     3867      0     12.25    27.42      0.17  3.3%
3922 remove       1.0%     0.6%     2254     2254      0     11.23    47.88      0.29  1.8%
3923 readdir      1.0%     1.0%     3813     3813      0      0.42     0.15      0.01  0.1%
3924 fsstat       1.0%     1.0%     3804     3804      0      0.20     0.11      0.01  0.1%
3925 access      11.0%    11.0%    42118    42118      0      0.21     0.72      0.01  0.6%
3926 commit       0.0%     0.0%        0    22867      0      0.00     0.00      0.00 22.9%
3927 readdirplus  2.0%     2.0%     7599     7599      0      0.71     0.27      0.01  0.4%
3928 --------------------------------------------------------------------------------------
3929
3930       --------------------------------------------------
3931       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
3932       --------------------------+-----------------------
3933 SFS NFS V3 THROUGHPUT: 1279.36 Ops/Sec   AVG. RESPONSE TIME:    3.70 Msec/Op
3934 TCP PROTOCOL
3935 FAST CALLS: 0
3936 NFS V3 MIXFILE: [ SFS Default ]
3937 CLIENT REQUESTED LOAD: 3600 Ops/Sec 
3938 TOTAL LOGICAL NFS V3 OPERATIONS:  382530         TEST TIME: 299 Sec 
3939 TOTAL PHYSICAL NFS V3 OPERATIONS: 429786   
3940 PHYSICAL NFS V3 THROUGHPUT: 1437.41 Ops/Sec
3941 FILE SET SIZE CREATED: 10622124.0 KB
3942 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
3943
3944 ------------------------------------------------------------------------
3945
3946 Mon Feb 14 15:00:07 2011 Completed.
3947
3948 Client Test Parameters: 
3949         Number of processes = 4
3950         Requested Load (NFS V3 operations/second) = 3600
3951         Maximum number of outstanding biod writes = 2
3952         Maximum number of outstanding biod reads = 2
3953         Warm-up time (seconds) = 300
3954         Run time (seconds) = 300
3955         File Set = 20004 Files created for I/O operations
3956                    6000 Files accessed for I/O operations
3957                     404 Files for non-I/O operations
3958                      24 Symlinks
3959                     664 Directories
3960                         Additional non-I/O files created as necessary
3961
3962
3963 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
3964 Mon Feb 14 15:00:07 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
3965 Mon Feb 14 15:00:07 2011 Completed.
3966 Mon Feb 14 15:00:07 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
3967
3968 ************************************************************************
3969 Mon Feb 14 15:00:08 2011 Received.
3970 Mon Feb 14 15:00:08 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
3971 Mon Feb 14 15:00:08 2011 Completed.
3972 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 3800  -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 
3973 NFS V3 Protocol Version
3974
3975 ************************************************************************
3976 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
3977 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
3978
3979 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
3980 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3981
3982 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 15:00:10 2011
3983         Client hostname = c09-44
3984         Prime Client hostname = c09-44.sysnet.ucsd.edu
3985
3986 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
3987 NFS V3 Protocol
3988 Mon Feb 14 15:00:10 2011 Mounting 4 remote test directories.
3989 Child[000]: NFS negotiated block size 32768
3990 Child[002]: NFS negotiated block size 32768
3991 Child[003]: NFS negotiated block size 32768
3992 Child[001]: NFS negotiated block size 32768
3993 Mon Feb 14 15:00:26 2011 Completed.
3994 Mon Feb 14 15:00:26 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
3995 Mon Feb 14 15:00:26 2011 Completed.
3996 Mon Feb 14 15:00:26 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
3997 Mon Feb 14 15:00:26 2011 Received.
3998
3999 Mon Feb 14 15:00:26 2011 Initializing test directories.
4000 Mon Feb 14 15:00:26 2011 Child 0 will create 167 directories.
4001 Mon Feb 14 15:00:26 2011 Child 3 will create 167 directories.
4002 Mon Feb 14 15:00:26 2011 Child 1 will create 167 directories.
4003 Mon Feb 14 15:00:26 2011 Child 2 will create 167 directories.
4004 Mon Feb 14 15:00:29 2011 Child 1 finished creating 167 directories.
4005 Mon Feb 14 15:00:29 2011 Child 1 will create 5102 files.
4006 Mon Feb 14 15:00:32 2011 Child 0 finished creating 167 directories.
4007 Mon Feb 14 15:00:32 2011 Child 0 will create 5102 files.
4008 Mon Feb 14 15:00:32 2011 Child 2 finished creating 167 directories.
4009 Mon Feb 14 15:00:32 2011 Child 2 will create 5102 files.
4010 Mon Feb 14 15:00:35 2011 Child 3 finished creating 167 directories.
4011 Mon Feb 14 15:00:35 2011 Child 3 will create 5102 files.
4012 Mon Feb 14 15:01:01 2011 Child 1 verified 5102 files, created 49
4013 Mon Feb 14 15:01:01 2011 Child 1 will create 6 symlinks.
4014 Mon Feb 14 15:01:02 2011 Child 1 finished creating 6 symlinks.
4015 Mon Feb 14 15:01:07 2011 Child 0 verified 5102 files, created 48
4016 Mon Feb 14 15:01:07 2011 Child 0 will create 6 symlinks.
4017 Mon Feb 14 15:01:07 2011 Child 0 finished creating 6 symlinks.
4018 Mon Feb 14 15:01:07 2011 Child 2 verified 5102 files, created 49
4019 Mon Feb 14 15:01:07 2011 Child 2 will create 6 symlinks.
4020 Mon Feb 14 15:01:07 2011 Child 2 finished creating 6 symlinks.
4021 Mon Feb 14 15:01:08 2011 Child 3 verified 5102 files, created 51
4022 Mon Feb 14 15:01:08 2011 Child 3 will create 6 symlinks.
4023 Mon Feb 14 15:01:08 2011 Child 3 finished creating 6 symlinks.
4024 Mon Feb 14 15:01:09 2011 Completed.
4025 Mon Feb 14 15:01:09 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
4026 Mon Feb 14 15:01:09 2011 Completed.
4027 Mon Feb 14 15:01:09 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
4028 Mon Feb 14 15:01:10 2011 Received.
4029 Mon Feb 14 15:01:10 2011 Performing 300 seconds pretest warmup.
4030 Child 3 - 50 aborted ops
4031 Child 3 - 100 aborted ops
4032 Mon Feb 14 15:06:10 2011 Completed.
4033 Mon Feb 14 15:06:10 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
4034 Mon Feb 14 15:06:10 2011 Completed.
4035 Mon Feb 14 15:06:10 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
4036 Mon Feb 14 15:06:11 2011 Received.
4037 Mon Feb 14 15:06:11 2011 Starting 300 seconds test run.
4038 Child 3 - 150 aborted ops
4039 Child 2 - 50 aborted ops
4040 Child 1 - 50 aborted ops
4041 Child 2 - 100 aborted ops
4042 Child 0 - 50 aborted ops
4043 Child 3 - 200 aborted ops
4044 Child 1 - 100 aborted ops
4045 Child 2 - 150 aborted ops
4046 Child 3 - 250 aborted ops
4047 Child 1 - 150 aborted ops
4048 Child 0 - 100 aborted ops
4049 Child 2 - 200 aborted ops
4050 Child 3 - 300 aborted ops
4051 Child 0 - 150 aborted ops
4052 Child 1 - 200 aborted ops
4053 Child 2 - 250 aborted ops
4054 Child 3 - 350 aborted ops
4055 Child 0 - 200 aborted ops
4056 Child 1 - 250 aborted ops
4057 Child 2 - 300 aborted ops
4058 Child 3 - 400 aborted ops
4059 Child 0 - 250 aborted ops
4060 Child 2 - 350 aborted ops
4061 Child 1 - 300 aborted ops
4062 Child 3 - 450 aborted ops
4063 SFS Single Client (c09-44) Results, Mon Feb 14 15:11:21 2011
4064 --------------------------------------------------------------------------------------
4065 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
4066 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
4067 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
4068            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
4069 --------------------------------------------------------------------------------------
4070 getattr     26.0%    26.0%    77582    77582      0      0.21     0.44      0.00  1.2%
4071 setattr      4.0%     4.1%    12137    12137      0     14.50    53.83      0.13 13.0%
4072 lookup      24.0%    24.1%    71884    71884      0      0.22     0.50      0.01  1.2%
4073 readlink     1.0%     1.0%     3028     3028      0      0.21     0.12      0.01  0.0%
4074 read        18.0%    18.1%    54011    66295      0      6.73    37.14      0.05 26.8%
4075 write       10.0%    10.1%    30250    36632      0      9.65    31.79      0.06 21.5%
4076 create       1.0%     1.0%     3015     3015      0     23.04    91.18      0.34  5.1%
4077 remove       1.0%     0.6%     1675     1675      0     18.76    81.98      0.43  2.3%
4078 readdir      1.0%     1.0%     3027     3027      0      0.43     0.16      0.01  0.1%
4079 fsstat       1.0%     1.0%     3013     3013      0      0.21     0.12      0.01  0.0%
4080 access      11.0%    11.1%    33121    33121      0      0.21     0.25      0.01  0.5%
4081 commit       0.0%     0.0%        0    18007      0      0.00     0.00      0.00 27.8%
4082 readdirplus  2.0%     2.0%     6031     6031      0      0.72     0.43      0.02  0.3%
4083 --------------------------------------------------------------------------------------
4084
4085       --------------------------------------------------
4086       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
4087       --------------------------+-----------------------
4088 SFS NFS V3 THROUGHPUT:  995.91 Ops/Sec   AVG. RESPONSE TIME:    4.53 Msec/Op
4089 TCP PROTOCOL
4090 FAST CALLS: 0
4091 NFS V3 MIXFILE: [ SFS Default ]
4092 CLIENT REQUESTED LOAD: 3800 Ops/Sec 
4093 TOTAL LOGICAL NFS V3 OPERATIONS:  298774         TEST TIME: 300 Sec 
4094 TOTAL PHYSICAL NFS V3 OPERATIONS: 335447   
4095 PHYSICAL NFS V3 THROUGHPUT: 1118.15 Ops/Sec
4096 FILE SET SIZE CREATED: 10622124.0 KB
4097 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
4098
4099 ------------------------------------------------------------------------
4100
4101 Mon Feb 14 15:11:21 2011 Completed.
4102
4103 Client Test Parameters: 
4104         Number of processes = 4
4105         Requested Load (NFS V3 operations/second) = 3800
4106         Maximum number of outstanding biod writes = 2
4107         Maximum number of outstanding biod reads = 2
4108         Warm-up time (seconds) = 300
4109         Run time (seconds) = 300
4110         File Set = 20004 Files created for I/O operations
4111                    6000 Files accessed for I/O operations
4112                     404 Files for non-I/O operations
4113                      24 Symlinks
4114                     664 Directories
4115                         Additional non-I/O files created as necessary
4116
4117
4118 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
4119 Mon Feb 14 15:11:21 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
4120 Mon Feb 14 15:11:21 2011 Completed.
4121 Mon Feb 14 15:11:21 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
4122
4123 ************************************************************************
4124 Mon Feb 14 15:11:22 2011 Received.
4125 Mon Feb 14 15:11:22 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
4126 Mon Feb 14 15:11:22 2011 Completed.
4127 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 4000  -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 
4128 NFS V3 Protocol Version
4129
4130 ************************************************************************
4131 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
4132 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
4133
4134 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
4135 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
4136
4137 SFS NFS V3 Benchmark Client Logfile, Mon Feb 14 15:11:24 2011
4138         Client hostname = c09-44
4139         Prime Client hostname = c09-44.sysnet.ucsd.edu
4140
4141 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
4142 NFS V3 Protocol
4143 Mon Feb 14 15:11:24 2011 Mounting 4 remote test directories.
4144 Child[001]: NFS negotiated block size 32768
4145 Child[002]: NFS negotiated block size 32768
4146 Child[003]: NFS negotiated block size 32768
4147 Child[000]: NFS negotiated block size 32768
4148 Mon Feb 14 15:11:40 2011 Completed.
4149 Mon Feb 14 15:11:40 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
4150 Mon Feb 14 15:11:40 2011 Completed.
4151 Mon Feb 14 15:11:40 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
4152 Mon Feb 14 15:11:40 2011 Received.
4153
4154 Mon Feb 14 15:11:40 2011 Initializing test directories.
4155 Mon Feb 14 15:11:40 2011 Child 2 will create 167 directories.
4156 Mon Feb 14 15:11:40 2011 Child 1 will create 167 directories.
4157 Mon Feb 14 15:11:40 2011 Child 3 will create 167 directories.
4158 Mon Feb 14 15:11:40 2011 Child 0 will create 167 directories.
4159 Mon Feb 14 15:11:40 2011 Child 2 finished creating 167 directories.
4160 Mon Feb 14 15:11:40 2011 Child 2 will create 5102 files.
4161 Mon Feb 14 15:11:43 2011 Child 3 finished creating 167 directories.
4162 Mon Feb 14 15:11:43 2011 Child 3 will create 5102 files.
4163 Mon Feb 14 15:11:51 2011 Child 0 finished creating 167 directories.
4164 Mon Feb 14 15:11:51 2011 Child 0 will create 5102 files.
4165 Mon Feb 14 15:11:54 2011 Child 1 finished creating 167 directories.
4166 Mon Feb 14 15:11:54 2011 Child 1 will create 5102 files.
4167 Mon Feb 14 15:12:06 2011 Child 2 verified 5102 files, created 50
4168 Mon Feb 14 15:12:06 2011 Child 2 will create 6 symlinks.
4169 Mon Feb 14 15:12:06 2011 Child 2 finished creating 6 symlinks.
4170 Mon Feb 14 15:12:12 2011 Child 3 verified 5102 files, created 51
4171 Mon Feb 14 15:12:12 2011 Child 3 will create 6 symlinks.
4172 Mon Feb 14 15:12:12 2011 Child 3 finished creating 6 symlinks.
4173 Mon Feb 14 15:12:21 2011 Child 0 verified 5102 files, created 50
4174 Mon Feb 14 15:12:21 2011 Child 0 will create 6 symlinks.
4175 Mon Feb 14 15:12:22 2011 Child 0 finished creating 6 symlinks.
4176 Mon Feb 14 15:12:22 2011 Child 1 verified 5102 files, created 50
4177 Mon Feb 14 15:12:22 2011 Child 1 will create 6 symlinks.
4178 Mon Feb 14 15:12:22 2011 Child 1 finished creating 6 symlinks.
4179 Mon Feb 14 15:12:23 2011 Completed.
4180 Mon Feb 14 15:12:23 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
4181 Mon Feb 14 15:12:23 2011 Completed.
4182 Mon Feb 14 15:12:23 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
4183 Mon Feb 14 15:12:24 2011 Received.
4184 Mon Feb 14 15:12:24 2011 Performing 300 seconds pretest warmup.
4185 Mon Feb 14 15:17:24 2011 Completed.
4186 Mon Feb 14 15:17:24 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
4187 Mon Feb 14 15:17:24 2011 Completed.
4188 Mon Feb 14 15:17:24 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
4189 Mon Feb 14 15:17:25 2011 Received.
4190 Mon Feb 14 15:17:25 2011 Starting 300 seconds test run.
4191 Child 3 - 50 aborted ops
4192 Child 3 - 100 aborted ops
4193 Child 1 - 50 aborted ops
4194 Child 3 - 150 aborted ops
4195 Child 2 - 50 aborted ops
4196 Child 1 - 100 aborted ops
4197 Child 0 - 50 aborted ops
4198 Child 3 - 200 aborted ops
4199 Child 1 - 150 aborted ops
4200 Child 2 - 100 aborted ops
4201 Child 0 - 100 aborted ops
4202 Child 1 - 200 aborted ops
4203 Child 3 - 250 aborted ops
4204 Child 2 - 150 aborted ops
4205 Child 1 - 250 aborted ops
4206 Child 3 - 300 aborted ops
4207 Child 1 - 300 aborted ops
4208 Child 0 - 150 aborted ops
4209 Child 2 - 200 aborted ops
4210 Child 3 - 350 aborted ops
4211 Child 1 - 350 aborted ops
4212 Child 0 - 200 aborted ops
4213 Child 2 - 250 aborted ops
4214 Child 3 - 400 aborted ops
4215 Child 1 - 400 aborted ops
4216 Child 3 - 450 aborted ops
4217 SFS Single Client (c09-44) Results, Mon Feb 14 15:22:36 2011
4218 --------------------------------------------------------------------------------------
4219 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
4220 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of  
4221 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
4222            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
4223 --------------------------------------------------------------------------------------
4224 getattr     26.0%    26.1%    84490    84490      0      0.21     0.24      0.00  1.3%
4225 setattr      4.0%     4.1%    13116    13116      0     11.74    33.60      0.10 11.2%
4226 lookup      24.0%    24.1%    78004    78004      0      0.21     0.21      0.00  1.2%
4227 readlink     1.0%     1.0%     3271     3271      0      0.21     0.11      0.01  0.0%
4228 read        18.0%    18.0%    58333    71504      0      7.04    40.41      0.05 29.9%
4229 write       10.0%    10.0%    32314    39180      0     10.16    33.33      0.06 23.9%
4230 create       1.0%     1.0%     3300     3300      0     17.29    46.34      0.23  4.2%
4231 remove       1.0%     0.6%     1809     1809      0     12.02    26.92      0.24  1.6%
4232 readdir      1.0%     1.0%     3261     3261      0      0.42     0.21      0.02  0.1%
4233 fsstat       1.0%     1.0%     3204     3204      0      0.21     0.12      0.01  0.0%
4234 access      11.0%    11.1%    35956    35956      0      0.21     0.59      0.01  0.6%
4235 commit       0.0%     0.0%        0    19232      0      0.00     0.00      0.00 25.7%
4236 readdirplus  2.0%     2.0%     6479     6479      0      0.71     0.17      0.01  0.3%
4237 --------------------------------------------------------------------------------------
4238
4239       --------------------------------------------------
4240       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
4241       --------------------------+-----------------------
4242 SFS NFS V3 THROUGHPUT: 1078.45 Ops/Sec   AVG. RESPONSE TIME:    4.24 Msec/Op
4243 TCP PROTOCOL
4244 FAST CALLS: 0
4245 NFS V3 MIXFILE: [ SFS Default ]
4246 CLIENT REQUESTED LOAD: 4000 Ops/Sec 
4247 TOTAL LOGICAL NFS V3 OPERATIONS:  323537         TEST TIME: 300 Sec 
4248 TOTAL PHYSICAL NFS V3 OPERATIONS: 362806   
4249 PHYSICAL NFS V3 THROUGHPUT: 1209.35 Ops/Sec
4250 FILE SET SIZE CREATED: 10622124.0 KB
4251 FILE SET SIZE ACCESSED: 3188124.0 - 3506936.0 KB  (100.00% to 110.00% of Base)
4252
4253 ------------------------------------------------------------------------
4254
4255 Mon Feb 14 15:22:36 2011 Completed.
4256
4257 Client Test Parameters: 
4258         Number of processes = 4
4259         Requested Load (NFS V3 operations/second) = 4000
4260         Maximum number of outstanding biod writes = 2
4261         Maximum number of outstanding biod reads = 2
4262         Warm-up time (seconds) = 300
4263         Run time (seconds) = 300
4264         File Set = 20004 Files created for I/O operations
4265                    6000 Files accessed for I/O operations
4266                     404 Files for non-I/O operations
4267                      24 Symlinks
4268                     664 Directories
4269                         Additional non-I/O files created as necessary
4270
4271
4272 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
4273 Mon Feb 14 15:22:36 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
4274 Mon Feb 14 15:22:36 2011 Completed.
4275 Mon Feb 14 15:22:36 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
4276
4277 ************************************************************************
4278 Mon Feb 14 15:22:37 2011 Received.
4279 Mon Feb 14 15:22:37 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
4280 Mon Feb 14 15:22:37 2011 Completed.