Checking in some results with a smaller, slower disk.
[bluesky.git] / results / 20110215 / sfslog.20110214-native
1 Mon Feb 14 09:22:27 PST 2011 Configuration parameters passed validation
2
3 Mon Feb 14 09:22:27 PST 2011 ========================================================================
4 SFS Benchmark Prime Client Logfile.
5         Creation Date: Mon Feb 14 09:22:27 PST 2011
6         Prime Client hostname: c09-44.sysnet.ucsd.edu
7 Mon Feb 14 09:22:32 PST 2011         Number of Clients: 1
8         Client hostname(s): c09-44.sysnet.ucsd.edu 
9
10 Mon Feb 14 09:22:32 PST 2011 SfsManager: Started sfs_syncd on c09-44.sysnet.ucsd.edu
11 Mon Feb 14 09:22:42 PST 2011 
12 ************************************************************************
13 Mon Feb 14 09:22:42 PST 2011 Test Run 1 of 20
14
15 Mon Feb 14 09:22:42 PST 2011 Mon Feb 14 09:22:42 PST 2011 c09-44.sysnet.ucsd.edu start:
16 Mon Feb 14 09:22:42 PST 2011         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 
17
18 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
19 Executing SFS Benchmark on 1 Client(s).
20 Mon Feb 14 09:22:57 2011 Waiting on DONE-MOUNT message from 1 client(s).
21 Mon Feb 14 09:22:58 2011 Received.
22 Mon Feb 14 09:22:58 2011 Sending DO-INIT message to 1 client(s).
23 Mon Feb 14 09:22:58 2011 Completed.
24 Mon Feb 14 09:22:58 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
25
26 ../binaries/linux-x86/sfs_prime: Caught Signal 2 SIGINT
27
28 Sending interupt signal to clients ... c09-44.sysnet.ucsd.edu: RPC: Unable to receive; errno = Connection reset by peer
29 Error calling signal_sfs_clients. Exit(9)
30 Mon Feb 14 10:05:06 PST 2011 INVALID RUN: Configuration parameter FILE_COUNT
31         valid run requires 0
32         configuration file specified 20000
33 Mon Feb 14 10:05:06 PST 2011 ERROR: Configuration parameters failed validation
34
35 Mon Feb 14 10:05:06 PST 2011 ========================================================================
36 SFS Benchmark Prime Client Logfile.
37         Creation Date: Mon Feb 14 10:05:06 PST 2011
38         Prime Client hostname: c09-44.sysnet.ucsd.edu
39 Mon Feb 14 10:05:11 PST 2011         Number of Clients: 1
40         Client hostname(s): c09-44.sysnet.ucsd.edu 
41
42 Mon Feb 14 10:05:11 PST 2011 SfsManager: Started sfs_syncd on c09-44.sysnet.ucsd.edu
43 Mon Feb 14 10:05:21 PST 2011 
44 ************************************************************************
45 Mon Feb 14 10:05:21 PST 2011 Test Run 1 of 20
46
47 Mon Feb 14 10:05:21 PST 2011 Mon Feb 14 10:05:21 PST 2011 c09-44.sysnet.ucsd.edu start:
48 Mon Feb 14 10:05:21 PST 2011         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 
49
50 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
51 Executing SFS Benchmark on 1 Client(s).
52 Mon Feb 14 10:05:36 2011 Waiting on DONE-MOUNT message from 1 client(s).
53 Mon Feb 14 10:05:37 2011 Received.
54 Mon Feb 14 10:05:37 2011 Sending DO-INIT message to 1 client(s).
55 Mon Feb 14 10:05:37 2011 Completed.
56 Mon Feb 14 10:05:37 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
57 Mon Feb 14 10:15:35 2011 Received.
58 Mon Feb 14 10:15:35 2011 Sending DO-WARMUP message to 1 client(s).
59 Mon Feb 14 10:15:35 2011 Completed.
60 Mon Feb 14 10:15:35 2011 Waiting on READY message from 1 client(s).
61 Mon Feb 14 10:20:36 2011 Received.
62 Mon Feb 14 10:20:36 2011 Sending START message to 1 client(s).
63 Mon Feb 14 10:20:36 2011 Completed.
64 Mon Feb 14 10:25:36 2011 Sending STOP message to 1 client(s).
65 Mon Feb 14 10:25:36 2011 Completed.
66 Mon Feb 14 10:25:36 2011 Waiting on DONE-TEST message from 1 client(s).
67 Mon Feb 14 10:25:47 2011 Received.
68 Mon Feb 14 10:25:47 2011 Sending MOVE-DATA message to 1 client(s).
69 Mon Feb 14 10:25:47 2011 Completed.
70 Mon Feb 14 10:25:47 2011 Waiting on SEND-DATA message from 1 client(s).
71 Mon Feb 14 10:25:48 2011 Received.
72 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
73 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 200 -C ../result/sfssum.20110214-native -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu 
74
75 Aggregate Test Parameters: 
76     Number of processes = 4
77     Requested Load (NFS operations/second) = 200
78     Maximum number of outstanding biod writes = 2
79     Maximum number of outstanding biod reads = 2
80     Warm-up time (seconds) = 300
81     Run time (seconds) = 300
82     File Set =  20004 Files created for I/O operations
83                  6000 Files accessed for I/O operations
84                   404 Files for non-I/O operations
85                    24 Symlinks
86                   664 Directories
87                       Additional non-I/O files created as necessary
88
89 SFS Aggregate Results for 1 Client(s), Mon Feb 14 10:25:48 2011
90 NFS Protocol Version 3
91
92 -------------------------------------------------------------------------------------
93 NFS         Target Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
94 Op          NFS    NFS     Logical Physical  Op     Response Response of Mean,  of   
95 Type        Mix    Mix     Success Success   Error  Time     Time     95% Conf  Total
96             Pcnt   Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
97 -------------------------------------------------------------------------------------
98 getattr      26.0%  26.2%    15780    15780      0     0.14     0.02      0.00   2.4%
99 setattr       4.0%   4.0%     2411     2411      0     6.65    59.10      0.31  17.4%
100 lookup       24.0%  23.7%    14289    14289      0     0.14     0.02      0.00   2.2%
101 readlink      1.0%   1.0%      612      612      0     0.14     0.02      0.01   0.1%
102 read         18.0%  18.0%    10855    13345      0     1.81    10.63      0.06  21.3%
103 write        10.0%  10.0%     6010     7224      0     2.59    26.54      0.13  16.9%
104 create        1.0%   1.1%      649      649      0     6.66    45.22      0.52   4.7%
105 remove        1.0%   1.0%      623      623      0     9.94    76.81      0.69   6.7%
106 readdir       1.0%   1.0%      594      594      0     1.60    19.58      0.36   1.0%
107 fsstat        1.0%   1.0%      579      579      0     0.13     0.02      0.01   0.1%
108 access       11.0%  10.9%     6586     6586      0     0.14     0.02      0.00   1.0%
109 commit        0.0%   0.0%        0     3164      0     0.00     0.00      0.00  24.1%
110 readdirplus   2.0%   2.0%     1190     1190      0     1.62    15.50      0.22   2.1%
111 -------------------------------------------------------------------------------------
112
113         ---------------------------------------------
114         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
115         ---------------------------------------------
116 SFS NFS THROUGHPUT:     201 Ops/Sec   AVG. RESPONSE TIME:     1.5 Msec/Op
117 TCP PROTOCOL (IPv4)
118 NFS MIXFILE: [ SFS default ]
119 AGGREGATE REQUESTED LOAD: 200 Ops/Sec 
120 TOTAL LOGICAL NFS OPERATIONS:  60178          TEST TIME: 300 Sec 
121 TOTAL PHYSICAL NFS OPERATIONS: 67046    
122 PHYSICAL NFS IO THROUGHPUT: 223 Ops/sec
123 NUMBER OF SFS CLIENTS: 1
124 TOTAL FILE SET SIZE CREATED: 10373.2 MB
125 TOTAL FILE SET SIZE ACCESSED: 3113.4 - 3249.7 MB  (100.00% to 104.38% of Base)
126
127 ------------------------------------------------------------------------
128
129 Mon Feb 14 10:25:49 PST 2011 
130 ************************************************************************
131 Mon Feb 14 10:25:49 PST 2011 
132 ************************************************************************
133 Mon Feb 14 10:25:49 PST 2011 Test Run 2 of 20
134
135 Mon Feb 14 10:25:49 PST 2011 Mon Feb 14 10:25:49 PST 2011 c09-44.sysnet.ucsd.edu start:
136 Mon Feb 14 10:25:49 PST 2011         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 
137
138 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
139 Executing SFS Benchmark on 1 Client(s).
140 Mon Feb 14 10:26:04 2011 Waiting on DONE-MOUNT message from 1 client(s).
141 Mon Feb 14 10:26:05 2011 Received.
142 Mon Feb 14 10:26:05 2011 Sending DO-INIT message to 1 client(s).
143 Mon Feb 14 10:26:05 2011 Completed.
144 Mon Feb 14 10:26:05 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
145 Mon Feb 14 10:26:22 2011 Received.
146 Mon Feb 14 10:26:22 2011 Sending DO-WARMUP message to 1 client(s).
147 Mon Feb 14 10:26:22 2011 Completed.
148 Mon Feb 14 10:26:22 2011 Waiting on READY message from 1 client(s).
149 Mon Feb 14 10:31:23 2011 Received.
150 Mon Feb 14 10:31:23 2011 Sending START message to 1 client(s).
151 Mon Feb 14 10:31:23 2011 Completed.
152 Mon Feb 14 10:36:23 2011 Sending STOP message to 1 client(s).
153 Mon Feb 14 10:36:23 2011 Completed.
154 Mon Feb 14 10:36:23 2011 Waiting on DONE-TEST message from 1 client(s).
155 Mon Feb 14 10:36:34 2011 Received.
156 Mon Feb 14 10:36:34 2011 Sending MOVE-DATA message to 1 client(s).
157 Mon Feb 14 10:36:34 2011 Completed.
158 Mon Feb 14 10:36:34 2011 Waiting on SEND-DATA message from 1 client(s).
159 Mon Feb 14 10:36:35 2011 Received.
160 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
161 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 400 -C ../result/sfssum.20110214-native -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu 
162
163 Aggregate Test Parameters: 
164     Number of processes = 4
165     Requested Load (NFS operations/second) = 400
166     Maximum number of outstanding biod writes = 2
167     Maximum number of outstanding biod reads = 2
168     Warm-up time (seconds) = 300
169     Run time (seconds) = 300
170     File Set =  20004 Files created for I/O operations
171                  6000 Files accessed for I/O operations
172                   404 Files for non-I/O operations
173                    24 Symlinks
174                   664 Directories
175                       Additional non-I/O files created as necessary
176
177 SFS Aggregate Results for 1 Client(s), Mon Feb 14 10:36:35 2011
178 NFS Protocol Version 3
179
180 -------------------------------------------------------------------------------------
181 NFS         Target Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
182 Op          NFS    NFS     Logical Physical  Op     Response Response of Mean,  of   
183 Type        Mix    Mix     Success Success   Error  Time     Time     95% Conf  Total
184             Pcnt   Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
185 -------------------------------------------------------------------------------------
186 getattr      26.0%  26.0%    31336    31336      0     0.14     0.03      0.00   2.8%
187 setattr       4.0%   4.0%     4826     4826      0     6.09    57.64      0.21  18.9%
188 lookup       24.0%  24.0%    28949    28949      0     0.15     0.03      0.00   2.7%
189 readlink      1.0%   1.0%     1182     1182      0     0.15     0.03      0.01   0.1%
190 read         18.0%  17.9%    21567    26270      0     1.14     8.92      0.04  15.8%
191 write        10.0%   9.9%    11884    14282      0     1.86    21.68      0.08  14.2%
192 create        1.0%   1.0%     1186     1186      0     8.30    67.02      0.47   6.3%
193 remove        1.0%   1.0%     1165     1165      0     9.35    88.91      0.54   7.0%
194 readdir       1.0%   0.9%     1143     1143      0     1.24    18.41      0.25   0.9%
195 fsstat        1.0%   1.0%     1227     1227      0     0.14     0.04      0.01   0.1%
196 access       11.0%  11.2%    13507    13507      0     0.14     0.03      0.00   1.2%
197 commit        0.0%   0.0%        0     6824      0     0.00     0.00      0.00  27.8%
198 readdirplus   2.0%   2.1%     2496     2496      0     1.26    14.36      0.15   2.0%
199 -------------------------------------------------------------------------------------
200
201         ---------------------------------------------
202         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
203         ---------------------------------------------
204 SFS NFS THROUGHPUT:     402 Ops/Sec   AVG. RESPONSE TIME:     1.3 Msec/Op
205 TCP PROTOCOL (IPv4)
206 NFS MIXFILE: [ SFS default ]
207 AGGREGATE REQUESTED LOAD: 400 Ops/Sec 
208 TOTAL LOGICAL NFS OPERATIONS:  120468         TEST TIME: 300 Sec 
209 TOTAL PHYSICAL NFS OPERATIONS: 134393   
210 PHYSICAL NFS IO THROUGHPUT: 447 Ops/sec
211 NUMBER OF SFS CLIENTS: 1
212 TOTAL FILE SET SIZE CREATED: 10373.2 MB
213 TOTAL FILE SET SIZE ACCESSED: 3113.4 - 3376.2 MB  (100.00% to 108.44% of Base)
214
215 ------------------------------------------------------------------------
216
217 Mon Feb 14 10:36:36 PST 2011 
218 ************************************************************************
219 Mon Feb 14 10:36:36 PST 2011 
220 ************************************************************************
221 Mon Feb 14 10:36:36 PST 2011 Test Run 3 of 20
222
223 Mon Feb 14 10:36:36 PST 2011 Mon Feb 14 10:36:36 PST 2011 c09-44.sysnet.ucsd.edu start:
224 Mon Feb 14 10:36:36 PST 2011         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 
225
226 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
227 Executing SFS Benchmark on 1 Client(s).
228 Mon Feb 14 10:36:51 2011 Waiting on DONE-MOUNT message from 1 client(s).
229 Mon Feb 14 10:36:52 2011 Received.
230 Mon Feb 14 10:36:52 2011 Sending DO-INIT message to 1 client(s).
231 Mon Feb 14 10:36:52 2011 Completed.
232 Mon Feb 14 10:36:52 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
233 Mon Feb 14 10:37:12 2011 Received.
234 Mon Feb 14 10:37:12 2011 Sending DO-WARMUP message to 1 client(s).
235 Mon Feb 14 10:37:12 2011 Completed.
236 Mon Feb 14 10:37:12 2011 Waiting on READY message from 1 client(s).
237 Mon Feb 14 10:42:13 2011 Received.
238 Mon Feb 14 10:42:13 2011 Sending START message to 1 client(s).
239 Mon Feb 14 10:42:13 2011 Completed.
240 Mon Feb 14 10:47:13 2011 Sending STOP message to 1 client(s).
241 Mon Feb 14 10:47:13 2011 Completed.
242 Mon Feb 14 10:47:13 2011 Waiting on DONE-TEST message from 1 client(s).
243 Mon Feb 14 10:47:24 2011 Received.
244 Mon Feb 14 10:47:24 2011 Sending MOVE-DATA message to 1 client(s).
245 Mon Feb 14 10:47:24 2011 Completed.
246 Mon Feb 14 10:47:24 2011 Waiting on SEND-DATA message from 1 client(s).
247 Mon Feb 14 10:47:25 2011 Received.
248 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
249 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 600 -C ../result/sfssum.20110214-native -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu 
250
251 Aggregate Test Parameters: 
252     Number of processes = 4
253     Requested Load (NFS operations/second) = 600
254     Maximum number of outstanding biod writes = 2
255     Maximum number of outstanding biod reads = 2
256     Warm-up time (seconds) = 300
257     Run time (seconds) = 300
258     File Set =  20004 Files created for I/O operations
259                  6000 Files accessed for I/O operations
260                   404 Files for non-I/O operations
261                    24 Symlinks
262                   664 Directories
263                       Additional non-I/O files created as necessary
264
265 SFS Aggregate Results for 1 Client(s), Mon Feb 14 10:47:25 2011
266 NFS Protocol Version 3
267
268 -------------------------------------------------------------------------------------
269 NFS         Target Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
270 Op          NFS    NFS     Logical Physical  Op     Response Response of Mean,  of   
271 Type        Mix    Mix     Success Success   Error  Time     Time     95% Conf  Total
272             Pcnt   Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
273 -------------------------------------------------------------------------------------
274 getattr      26.0%  26.1%    47728    47728      0     0.14     0.04      0.00   2.6%
275 setattr       4.0%   4.1%     7453     7453      0     7.81    71.83      0.19  22.4%
276 lookup       24.0%  23.9%    43696    43696      0     0.15     0.04      0.00   2.5%
277 readlink      1.0%   1.0%     1791     1791      0     0.15     0.04      0.01   0.1%
278 read         18.0%  17.9%    32794    40313      0     0.94     8.51      0.03  11.8%
279 write        10.0%  10.0%    18279    22275      0     1.68    22.80      0.07  11.8%
280 create        1.0%   1.1%     1940     1940      0     9.84    81.43      0.40   7.4%
281 remove        1.0%   0.9%     1711     1711      0    11.89   100.34      0.47   7.8%
282 readdir       1.0%   1.0%     1833     1833      0     0.86    10.35      0.15   0.6%
283 fsstat        1.0%   1.0%     1789     1789      0     0.14     0.04      0.01   0.1%
284 access       11.0%  11.0%    20108    20108      0     0.14     0.04      0.00   1.1%
285 commit        0.0%   0.0%        0    10719      0     0.00     0.00      0.00  30.3%
286 readdirplus   2.0%   2.0%     3685     3685      0     0.90     2.02      0.05   1.3%
287 -------------------------------------------------------------------------------------
288
289         ---------------------------------------------
290         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
291         ---------------------------------------------
292 SFS NFS THROUGHPUT:     609 Ops/Sec   AVG. RESPONSE TIME:     1.4 Msec/Op
293 TCP PROTOCOL (IPv4)
294 NFS MIXFILE: [ SFS default ]
295 AGGREGATE REQUESTED LOAD: 600 Ops/Sec 
296 TOTAL LOGICAL NFS OPERATIONS:  182807         TEST TIME: 300 Sec 
297 TOTAL PHYSICAL NFS OPERATIONS: 205041   
298 PHYSICAL NFS IO THROUGHPUT: 683 Ops/sec
299 NUMBER OF SFS CLIENTS: 1
300 TOTAL FILE SET SIZE CREATED: 10373.2 MB
301 TOTAL FILE SET SIZE ACCESSED: 3113.4 - 3432.3 MB  (100.00% to 110.24% of Base)
302
303 ------------------------------------------------------------------------
304
305 Mon Feb 14 10:47:26 PST 2011 
306 ************************************************************************
307 Mon Feb 14 10:47:26 PST 2011 
308 ************************************************************************
309 Mon Feb 14 10:47:26 PST 2011 Test Run 4 of 20
310
311 Mon Feb 14 10:47:26 PST 2011 Mon Feb 14 10:47:26 PST 2011 c09-44.sysnet.ucsd.edu start:
312 Mon Feb 14 10:47:26 PST 2011         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 
313
314 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
315 Executing SFS Benchmark on 1 Client(s).
316 Mon Feb 14 10:47:41 2011 Waiting on DONE-MOUNT message from 1 client(s).
317 Mon Feb 14 10:47:42 2011 Received.
318 Mon Feb 14 10:47:42 2011 Sending DO-INIT message to 1 client(s).
319 Mon Feb 14 10:47:42 2011 Completed.
320 Mon Feb 14 10:47:42 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
321 Mon Feb 14 10:48:11 2011 Received.
322 Mon Feb 14 10:48:11 2011 Sending DO-WARMUP message to 1 client(s).
323 Mon Feb 14 10:48:11 2011 Completed.
324 Mon Feb 14 10:48:11 2011 Waiting on READY message from 1 client(s).
325 Mon Feb 14 10:53:12 2011 Received.
326 Mon Feb 14 10:53:12 2011 Sending START message to 1 client(s).
327 Mon Feb 14 10:53:12 2011 Completed.
328 Mon Feb 14 10:58:12 2011 Sending STOP message to 1 client(s).
329 Mon Feb 14 10:58:12 2011 Completed.
330 Mon Feb 14 10:58:12 2011 Waiting on DONE-TEST message from 1 client(s).
331 Mon Feb 14 10:58:23 2011 Received.
332 Mon Feb 14 10:58:23 2011 Sending MOVE-DATA message to 1 client(s).
333 Mon Feb 14 10:58:23 2011 Completed.
334 Mon Feb 14 10:58:23 2011 Waiting on SEND-DATA message from 1 client(s).
335 Mon Feb 14 10:58:24 2011 Received.
336 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
337 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 800 -C ../result/sfssum.20110214-native -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu 
338
339 Aggregate Test Parameters: 
340     Number of processes = 4
341     Requested Load (NFS operations/second) = 800
342     Maximum number of outstanding biod writes = 2
343     Maximum number of outstanding biod reads = 2
344     Warm-up time (seconds) = 300
345     Run time (seconds) = 300
346     File Set =  20004 Files created for I/O operations
347                  6000 Files accessed for I/O operations
348                   404 Files for non-I/O operations
349                    24 Symlinks
350                   664 Directories
351                       Additional non-I/O files created as necessary
352
353 SFS Aggregate Results for 1 Client(s), Mon Feb 14 10:58:24 2011
354 NFS Protocol Version 3
355
356 -------------------------------------------------------------------------------------
357 NFS         Target Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
358 Op          NFS    NFS     Logical Physical  Op     Response Response of Mean,  of   
359 Type        Mix    Mix     Success Success   Error  Time     Time     95% Conf  Total
360             Pcnt   Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
361 -------------------------------------------------------------------------------------
362 getattr      26.0%  26.1%    63772    63772      0     0.15     0.05      0.00   2.3%
363 setattr       4.0%   4.0%     9849     9849      0     9.66    62.08      0.16  23.1%
364 lookup       24.0%  24.2%    59002    59002      0     0.15     0.05      0.00   2.2%
365 readlink      1.0%   1.0%     2399     2399      0     0.15     0.05      0.01   0.1%
366 read         18.0%  18.0%    44035    53986      0     0.88     9.11      0.03   9.4%
367 write        10.0%  10.0%    24333    29637      0     1.34    17.93      0.05   7.9%
368 create        1.0%   1.0%     2530     2530      0    15.66    96.73      0.38   9.6%
369 remove        1.0%   0.7%     1588     1588      0    13.97    90.21      0.47   5.4%
370 readdir       1.0%   1.0%     2446     2446      0     0.69     9.28      0.12   0.4%
371 fsstat        1.0%   1.0%     2493     2493      0     0.15     0.05      0.01   0.1%
372 access       11.0%  11.0%    26856    26856      0     0.15     0.05      0.00   1.0%
373 commit        0.0%   0.0%        0    14463      0     0.00     0.00      0.00  37.6%
374 readdirplus   2.0%   2.0%     4962     4962      0     0.85     0.78      0.02   1.0%
375 -------------------------------------------------------------------------------------
376
377         ---------------------------------------------
378         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
379         ---------------------------------------------
380 SFS NFS THROUGHPUT:     817 Ops/Sec   AVG. RESPONSE TIME:     1.7 Msec/Op
381 TCP PROTOCOL (IPv4)
382 NFS MIXFILE: [ SFS default ]
383 AGGREGATE REQUESTED LOAD: 800 Ops/Sec 
384 TOTAL LOGICAL NFS OPERATIONS:  244265         TEST TIME: 299 Sec 
385 TOTAL PHYSICAL NFS OPERATIONS: 273983   
386 PHYSICAL NFS IO THROUGHPUT: 916 Ops/sec
387 NUMBER OF SFS CLIENTS: 1
388 TOTAL FILE SET SIZE CREATED: 10373.2 MB
389 TOTAL FILE SET SIZE ACCESSED: 3113.4 - 3430.8 MB  (100.00% to 110.19% of Base)
390
391 ------------------------------------------------------------------------
392
393 Mon Feb 14 10:58:25 PST 2011 
394 ************************************************************************
395 Mon Feb 14 10:58:25 PST 2011 
396 ************************************************************************
397 Mon Feb 14 10:58:25 PST 2011 Test Run 5 of 20
398
399 Mon Feb 14 10:58:25 PST 2011 Mon Feb 14 10:58:25 PST 2011 c09-44.sysnet.ucsd.edu start:
400 Mon Feb 14 10:58:25 PST 2011         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 
401
402 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
403 Executing SFS Benchmark on 1 Client(s).
404 Mon Feb 14 10:58:40 2011 Waiting on DONE-MOUNT message from 1 client(s).
405 Mon Feb 14 10:58:41 2011 Received.
406 Mon Feb 14 10:58:41 2011 Sending DO-INIT message to 1 client(s).
407 Mon Feb 14 10:58:41 2011 Completed.
408 Mon Feb 14 10:58:41 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
409 Mon Feb 14 10:59:09 2011 Received.
410 Mon Feb 14 10:59:09 2011 Sending DO-WARMUP message to 1 client(s).
411 Mon Feb 14 10:59:09 2011 Completed.
412 Mon Feb 14 10:59:09 2011 Waiting on READY message from 1 client(s).
413 Mon Feb 14 11:04:10 2011 Received.
414 Mon Feb 14 11:04:10 2011 Sending START message to 1 client(s).
415 Mon Feb 14 11:04:10 2011 Completed.
416 Mon Feb 14 11:09:10 2011 Sending STOP message to 1 client(s).
417 Mon Feb 14 11:09:10 2011 Completed.
418 Mon Feb 14 11:09:10 2011 Waiting on DONE-TEST message from 1 client(s).
419 Mon Feb 14 11:09:21 2011 Received.
420 Mon Feb 14 11:09:21 2011 Sending MOVE-DATA message to 1 client(s).
421 Mon Feb 14 11:09:21 2011 Completed.
422 Mon Feb 14 11:09:21 2011 Waiting on SEND-DATA message from 1 client(s).
423 Mon Feb 14 11:09:22 2011 Received.
424 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
425 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 1000 -C ../result/sfssum.20110214-native -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu 
426
427 Aggregate Test Parameters: 
428     Number of processes = 4
429     Requested Load (NFS operations/second) = 1000
430     Maximum number of outstanding biod writes = 2
431     Maximum number of outstanding biod reads = 2
432     Warm-up time (seconds) = 300
433     Run time (seconds) = 300
434     File Set =  20004 Files created for I/O operations
435                  6000 Files accessed for I/O operations
436                   404 Files for non-I/O operations
437                    24 Symlinks
438                   664 Directories
439                       Additional non-I/O files created as necessary
440
441 SFS Aggregate Results for 1 Client(s), Mon Feb 14 11:09:22 2011
442 NFS Protocol Version 3
443
444 -------------------------------------------------------------------------------------
445 NFS         Target Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
446 Op          NFS    NFS     Logical Physical  Op     Response Response of Mean,  of   
447 Type        Mix    Mix     Success Success   Error  Time     Time     95% Conf  Total
448             Pcnt   Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
449 -------------------------------------------------------------------------------------
450 getattr      26.0%  26.0%    76399    76399      0     0.17     0.09      0.00   1.1%
451 setattr       4.0%   4.1%    11919    11919      0    29.86    75.93      0.16  30.3%
452 lookup       24.0%  24.1%    71036    71036      0     0.18     0.09      0.00   1.1%
453 readlink      1.0%   1.0%     3013     3013      0     0.17     0.09      0.01   0.0%
454 read         18.0%  18.2%    53393    65731      0     0.85     6.44      0.02   3.9%
455 write        10.0%  10.1%    29592    35728      0     1.50    16.08      0.05   3.8%
456 create        1.0%   1.0%     2889     2889      0    42.41   110.71      0.38  10.4%
457 remove        1.0%   0.5%     1583     1583      0    29.63    78.96      0.44   4.0%
458 readdir       1.0%   1.0%     3026     3026      0     0.67     9.89      0.11   0.2%
459 fsstat        1.0%   1.0%     2903     2903      0     0.17     0.09      0.01   0.0%
460 access       11.0%  11.0%    32448    32448      0     0.17     0.09      0.00   0.5%
461 commit        0.0%   0.0%        0    17624      0     0.00     0.00      0.00  44.1%
462 readdirplus   2.0%   2.0%     5953     5953      0     1.13    10.52      0.08   0.6%
463 -------------------------------------------------------------------------------------
464
465         ---------------------------------------------
466         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
467         ---------------------------------------------
468 SFS NFS THROUGHPUT:     984 Ops/Sec   AVG. RESPONSE TIME:     4.0 Msec/Op
469 TCP PROTOCOL (IPv4)
470 NFS MIXFILE: [ SFS default ]
471 AGGREGATE REQUESTED LOAD: 1000 Ops/Sec 
472 TOTAL LOGICAL NFS OPERATIONS:  294154         TEST TIME: 299 Sec 
473 TOTAL PHYSICAL NFS OPERATIONS: 330252   
474 PHYSICAL NFS IO THROUGHPUT: 1104 Ops/sec
475 NUMBER OF SFS CLIENTS: 1
476 TOTAL FILE SET SIZE CREATED: 10373.2 MB
477 TOTAL FILE SET SIZE ACCESSED: 3113.4 - 3424.7 MB  (100.00% to 110.00% of Base)
478
479 ------------------------------------------------------------------------
480
481 Mon Feb 14 11:09:23 PST 2011 
482 ************************************************************************
483 Mon Feb 14 11:09:23 PST 2011 
484 ************************************************************************
485 Mon Feb 14 11:09:23 PST 2011 Test Run 6 of 20
486
487 Mon Feb 14 11:09:23 PST 2011 Mon Feb 14 11:09:23 PST 2011 c09-44.sysnet.ucsd.edu start:
488 Mon Feb 14 11:09:23 PST 2011         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 
489
490 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
491 Executing SFS Benchmark on 1 Client(s).
492 Mon Feb 14 11:09:38 2011 Waiting on DONE-MOUNT message from 1 client(s).
493 Mon Feb 14 11:09:39 2011 Received.
494 Mon Feb 14 11:09:39 2011 Sending DO-INIT message to 1 client(s).
495 Mon Feb 14 11:09:39 2011 Completed.
496 Mon Feb 14 11:09:39 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
497 Mon Feb 14 11:10:04 2011 Received.
498 Mon Feb 14 11:10:04 2011 Sending DO-WARMUP message to 1 client(s).
499 Mon Feb 14 11:10:04 2011 Completed.
500 Mon Feb 14 11:10:04 2011 Waiting on READY message from 1 client(s).
501 Mon Feb 14 11:15:05 2011 Received.
502 Mon Feb 14 11:15:05 2011 Sending START message to 1 client(s).
503 Mon Feb 14 11:15:05 2011 Completed.
504 Mon Feb 14 11:20:05 2011 Sending STOP message to 1 client(s).
505 Mon Feb 14 11:20:05 2011 Completed.
506 Mon Feb 14 11:20:05 2011 Waiting on DONE-TEST message from 1 client(s).
507 Mon Feb 14 11:20:16 2011 Received.
508 Mon Feb 14 11:20:16 2011 Sending MOVE-DATA message to 1 client(s).
509 Mon Feb 14 11:20:16 2011 Completed.
510 Mon Feb 14 11:20:16 2011 Waiting on SEND-DATA message from 1 client(s).
511 Mon Feb 14 11:20:17 2011 Received.
512 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
513 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 1200 -C ../result/sfssum.20110214-native -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu 
514
515 Aggregate Test Parameters: 
516     Number of processes = 4
517     Requested Load (NFS operations/second) = 1200
518     Maximum number of outstanding biod writes = 2
519     Maximum number of outstanding biod reads = 2
520     Warm-up time (seconds) = 300
521     Run time (seconds) = 300
522     File Set =  20004 Files created for I/O operations
523                  6000 Files accessed for I/O operations
524                   404 Files for non-I/O operations
525                    24 Symlinks
526                   664 Directories
527                       Additional non-I/O files created as necessary
528
529 SFS Aggregate Results for 1 Client(s), Mon Feb 14 11:20:17 2011
530 NFS Protocol Version 3
531
532 -------------------------------------------------------------------------------------
533 NFS         Target Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt 
534 Op          NFS    NFS     Logical Physical  Op     Response Response of Mean,  of   
535 Type        Mix    Mix     Success Success   Error  Time     Time     95% Conf  Total
536             Pcnt   Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time 
537 -------------------------------------------------------------------------------------
538 getattr      26.0%  26.1%    76900    76900      0     0.17     0.09      0.00   1.1%
539 setattr       4.0%   4.0%    11860    11860      0    29.87    67.91      0.15  29.3%
540 lookup       24.0%  24.1%    70899    70899      0     0.18     0.09      0.00   1.1%
541 readlink      1.0%   1.0%     2994     2994      0     0.18     0.09      0.01   0.0%
542 read         18.0%  18.2%    53603    65461      0     0.89     9.65      0.03   3.9%
543 write        10.0%  10.0%    29418    35531      0     1.64    17.48      0.05   4.0%
544 create        1.0%   1.0%     3030     3030      0    46.86   131.53      0.41  11.7%
545 remove        1.0%   0.5%     1609     1609      0    31.77    81.00      0.44   4.2%
546 readdir       1.0%   1.0%     2987     2987      0     0.57     3.98      0.07   0.1%
547 fsstat        1.0%   1.0%     2923     2923      0     0.17     0.08      0.01   0.0%
548 access       11.0%  11.0%    32268    32268      0     0.17     0.09      0.00   0.5%
549 commit        0.0%   0.0%        0    17477      0     0.00     0.00      0.00  43.5%
550 readdirplus   2.0%   2.0%     6021     6021      0     0.94     1.60      0.03   0.5%
551 -------------------------------------------------------------------------------------
552
553         ---------------------------------------------
554         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
555         ---------------------------------------------
556 SFS NFS THROUGHPUT:     985 Ops/Sec   AVG. RESPONSE TIME:     4.1 Msec/Op
557 TCP PROTOCOL (IPv4)
558 NFS MIXFILE: [ SFS default ]
559 AGGREGATE REQUESTED LOAD: 1200 Ops/Sec 
560 TOTAL LOGICAL NFS OPERATIONS:  294512         TEST TIME: 299 Sec 
561 TOTAL PHYSICAL NFS OPERATIONS: 329960   
562 PHYSICAL NFS IO THROUGHPUT: 1103 Ops/sec
563 NUMBER OF SFS CLIENTS: 1
564 TOTAL FILE SET SIZE CREATED: 10373.2 MB
565 TOTAL FILE SET SIZE ACCESSED: 3113.4 - 3424.7 MB  (100.00% to 110.00% of Base)
566
567 ------------------------------------------------------------------------
568
569 Mon Feb 14 11:20:18 PST 2011 
570 ************************************************************************
571 Mon Feb 14 11:20:18 PST 2011 
572 ************************************************************************
573 Mon Feb 14 11:20:18 PST 2011 Test Run 7 of 20
574
575 Mon Feb 14 11:20:18 PST 2011 Mon Feb 14 11:20:18 PST 2011 c09-44.sysnet.ucsd.edu start:
576 Mon Feb 14 11:20:18 PST 2011         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 
577
578 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
579 Executing SFS Benchmark on 1 Client(s).
580 Mon Feb 14 11:20:33 2011 Waiting on DONE-MOUNT message from 1 client(s).
581 Mon Feb 14 11:20:34 2011 Received.
582 Mon Feb 14 11:20:34 2011 Sending DO-INIT message to 1 client(s).
583 Mon Feb 14 11:20:34 2011 Completed.
584 Mon Feb 14 11:20:34 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
585 Mon Feb 14 11:20:56 2011 Received.
586 Mon Feb 14 11:20:56 2011 Sending DO-WARMUP message to 1 client(s).
587 Mon Feb 14 11:20:56 2011 Completed.
588 Mon Feb 14 11:20:56 2011 Waiting on READY message from 1 client(s).
589
590 ../binaries/linux-x86/sfs_prime: Caught Signal 2 SIGINT
591
592 Sending interupt signal to clients ... c09-44.sysnet.ucsd.edu: RPC: Unable to receive; errno = Connection reset by peer
593 Error calling signal_sfs_clients. Exit(9)