1 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 100 -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 16 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export
2 NFS V3 Protocol Version
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
8 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
9 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
11 SFS NFS V3 Benchmark Client Logfile, Mon Apr 11 13:16:31 2011
12 Client hostname = c09-44
13 Prime Client hostname = c09-44.sysnet.ucsd.edu
15 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
17 Mon Apr 11 13:16:31 2011 Mounting 16 remote test directories.
18 Child[002]: NFS negotiated block size 32768
19 Child[011]: NFS negotiated block size 32768
20 Child[014]: NFS negotiated block size 32768
21 Child[000]: NFS negotiated block size 32768
22 Child[001]: NFS negotiated block size 32768
23 Child[003]: NFS negotiated block size 32768
24 Child[004]: NFS negotiated block size 32768
25 Child[005]: NFS negotiated block size 32768
26 Child[006]: NFS negotiated block size 32768
27 Child[007]: NFS negotiated block size 32768
28 Child[008]: NFS negotiated block size 32768
29 Child[009]: NFS negotiated block size 32768
30 Child[010]: NFS negotiated block size 32768
31 Child[012]: NFS negotiated block size 32768
32 Child[013]: NFS negotiated block size 32768
33 Child[015]: NFS negotiated block size 32768
34 Mon Apr 11 13:16:50 2011 Completed.
35 Mon Apr 11 13:16:50 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
36 Mon Apr 11 13:16:50 2011 Completed.
37 Mon Apr 11 13:16:50 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
38 Mon Apr 11 13:16:50 2011 Received.
40 Mon Apr 11 13:16:50 2011 Initializing test directories.
41 Mon Apr 11 13:16:50 2011 Child 15 will create 46 directories.
42 Mon Apr 11 13:16:50 2011 Child 3 will create 46 directories.
43 Mon Apr 11 13:16:50 2011 Child 2 will create 46 directories.
44 Mon Apr 11 13:16:50 2011 Child 11 will create 46 directories.
45 Mon Apr 11 13:16:50 2011 Child 12 will create 46 directories.
46 Mon Apr 11 13:16:50 2011 Child 13 will create 46 directories.
47 Mon Apr 11 13:16:50 2011 Child 5 will create 46 directories.
48 Mon Apr 11 13:16:50 2011 Child 0 will create 46 directories.
49 Mon Apr 11 13:16:50 2011 Child 14 will create 46 directories.
50 Mon Apr 11 13:16:50 2011 Child 10 will create 46 directories.
51 Mon Apr 11 13:16:50 2011 Child 1 will create 46 directories.
52 Mon Apr 11 13:16:50 2011 Child 8 will create 46 directories.
53 Mon Apr 11 13:16:50 2011 Child 4 will create 46 directories.
54 Mon Apr 11 13:16:50 2011 Child 7 will create 46 directories.
55 Mon Apr 11 13:16:50 2011 Child 6 will create 46 directories.
56 Mon Apr 11 13:16:50 2011 Child 9 will create 46 directories.
57 Mon Apr 11 13:16:50 2011 Child 13 finished creating 46 directories.
58 Mon Apr 11 13:16:50 2011 Child 13 will create 1386 files.
59 Mon Apr 11 13:16:50 2011 Child 8 finished creating 46 directories.
60 Mon Apr 11 13:16:50 2011 Child 8 will create 1386 files.
61 Mon Apr 11 13:16:50 2011 Child 12 finished creating 46 directories.
62 Mon Apr 11 13:16:50 2011 Child 12 will create 1386 files.
63 Mon Apr 11 13:16:50 2011 Child 11 finished creating 46 directories.
64 Mon Apr 11 13:16:50 2011 Child 11 will create 1386 files.
65 Mon Apr 11 13:16:50 2011 Child 9 finished creating 46 directories.
66 Mon Apr 11 13:16:50 2011 Child 9 will create 1386 files.
67 Mon Apr 11 13:16:50 2011 Child 6 finished creating 46 directories.
68 Mon Apr 11 13:16:50 2011 Child 6 will create 1386 files.
69 Mon Apr 11 13:16:50 2011 Child 5 finished creating 46 directories.
70 Mon Apr 11 13:16:50 2011 Child 5 will create 1386 files.
71 Mon Apr 11 13:16:50 2011 Child 4 finished creating 46 directories.
72 Mon Apr 11 13:16:50 2011 Child 4 will create 1386 files.
73 Mon Apr 11 13:16:50 2011 Child 1 finished creating 46 directories.
74 Mon Apr 11 13:16:50 2011 Child 1 will create 1386 files.
75 Mon Apr 11 13:16:50 2011 Child 3 finished creating 46 directories.
76 Mon Apr 11 13:16:50 2011 Child 3 will create 1386 files.
77 Mon Apr 11 13:16:51 2011 Child 0 finished creating 46 directories.
78 Mon Apr 11 13:16:51 2011 Child 0 will create 1386 files.
79 Mon Apr 11 13:16:51 2011 Child 10 finished creating 46 directories.
80 Mon Apr 11 13:16:51 2011 Child 10 will create 1386 files.
81 Mon Apr 11 13:16:51 2011 Child 2 finished creating 46 directories.
82 Mon Apr 11 13:16:51 2011 Child 2 will create 1386 files.
83 Mon Apr 11 13:16:51 2011 Child 7 finished creating 46 directories.
84 Mon Apr 11 13:16:51 2011 Child 7 will create 1386 files.
85 Mon Apr 11 13:16:51 2011 Child 15 finished creating 46 directories.
86 Mon Apr 11 13:16:51 2011 Child 15 will create 1386 files.
87 Mon Apr 11 13:16:51 2011 Child 14 finished creating 46 directories.
88 Mon Apr 11 13:16:51 2011 Child 14 will create 1386 files.
89 Mon Apr 11 13:21:52 2011 Child 3 verified 815 files (815 creates).
90 Mon Apr 11 13:21:52 2011 Child 4 verified 941 files (941 creates).
91 Mon Apr 11 13:21:52 2011 Child 6 verified 562 files (562 creates).
92 Mon Apr 11 13:21:52 2011 Child 14 verified 875 files (875 creates).
93 Mon Apr 11 13:21:52 2011 Child 7 verified 856 files (856 creates).
94 Mon Apr 11 13:22:28 2011 Child 2 verified 745 files (745 creates).
95 Mon Apr 11 13:22:28 2011 Child 5 verified 742 files (742 creates).
96 Mon Apr 11 13:22:28 2011 Child 1 verified 420 files (420 creates).
97 Mon Apr 11 13:22:29 2011 Child 8 verified 872 files (872 creates).
98 Mon Apr 11 13:22:29 2011 Child 10 verified 856 files (856 creates).
99 Mon Apr 11 13:22:46 2011 Child 12 verified 597 files (597 creates).
100 Mon Apr 11 13:22:46 2011 Child 15 verified 420 files (420 creates).
101 Mon Apr 11 13:22:46 2011 Child 11 verified 597 files (597 creates).
102 Mon Apr 11 13:22:46 2011 Child 0 verified 872 files (872 creates).
103 Mon Apr 11 13:22:47 2011 Child 9 verified 856 files (856 creates).
104 Mon Apr 11 13:22:47 2011 Child 13 verified 856 files (856 creates).
105 Mon Apr 11 13:23:13 2011 Child 4 verified 1386 files, created 1373
106 Mon Apr 11 13:23:13 2011 Child 4 will create 2 symlinks.
107 Mon Apr 11 13:23:13 2011 Child 4 finished creating 2 symlinks.
108 Mon Apr 11 13:23:13 2011 Child 14 verified 1386 files, created 1373
109 Mon Apr 11 13:23:13 2011 Child 14 will create 2 symlinks.
110 Mon Apr 11 13:23:14 2011 Child 14 finished creating 2 symlinks.
111 Mon Apr 11 13:23:22 2011 Child 7 verified 1386 files, created 1373
112 Mon Apr 11 13:23:22 2011 Child 7 will create 2 symlinks.
113 Mon Apr 11 13:23:22 2011 Child 7 finished creating 2 symlinks.
114 Mon Apr 11 13:23:35 2011 Child 3 verified 1386 files, created 1373
115 Mon Apr 11 13:23:35 2011 Child 3 will create 2 symlinks.
116 Mon Apr 11 13:23:35 2011 Child 3 finished creating 2 symlinks.
117 Mon Apr 11 13:23:47 2011 Child 8 verified 1386 files, created 1373
118 Mon Apr 11 13:23:47 2011 Child 8 will create 2 symlinks.
119 Mon Apr 11 13:23:47 2011 Child 8 finished creating 2 symlinks.
120 Mon Apr 11 13:23:51 2011 Child 0 verified 1386 files, created 1373
121 Mon Apr 11 13:23:51 2011 Child 0 will create 2 symlinks.
122 Mon Apr 11 13:23:51 2011 Child 0 finished creating 2 symlinks.
123 Mon Apr 11 13:23:51 2011 Child 6 verified 1386 files, created 1373
124 Mon Apr 11 13:23:51 2011 Child 6 will create 2 symlinks.
125 Mon Apr 11 13:23:51 2011 Child 6 finished creating 2 symlinks.
126 Mon Apr 11 13:23:52 2011 Child 10 verified 1386 files, created 1373
127 Mon Apr 11 13:23:52 2011 Child 10 will create 2 symlinks.
128 Mon Apr 11 13:23:52 2011 Child 10 finished creating 2 symlinks.
129 Mon Apr 11 13:23:55 2011 Child 9 verified 1386 files, created 1373
130 Mon Apr 11 13:23:55 2011 Child 9 will create 2 symlinks.
131 Mon Apr 11 13:23:55 2011 Child 9 finished creating 2 symlinks.
132 Mon Apr 11 13:23:55 2011 Child 13 verified 1386 files, created 1373
133 Mon Apr 11 13:23:55 2011 Child 13 will create 2 symlinks.
134 Mon Apr 11 13:23:55 2011 Child 13 finished creating 2 symlinks.
135 Mon Apr 11 13:23:57 2011 Child 5 verified 1386 files, created 1373
136 Mon Apr 11 13:23:57 2011 Child 5 will create 2 symlinks.
137 Mon Apr 11 13:23:57 2011 Child 5 finished creating 2 symlinks.
138 Mon Apr 11 13:23:57 2011 Child 2 verified 1386 files, created 1373
139 Mon Apr 11 13:23:57 2011 Child 2 will create 2 symlinks.
140 Mon Apr 11 13:23:57 2011 Child 2 finished creating 2 symlinks.
141 Mon Apr 11 13:24:03 2011 Child 11 verified 1386 files, created 1373
142 Mon Apr 11 13:24:03 2011 Child 11 will create 2 symlinks.
143 Mon Apr 11 13:24:03 2011 Child 11 finished creating 2 symlinks.
144 Mon Apr 11 13:24:03 2011 Child 12 verified 1386 files, created 1373
145 Mon Apr 11 13:24:03 2011 Child 12 will create 2 symlinks.
146 Mon Apr 11 13:24:03 2011 Child 12 finished creating 2 symlinks.
147 Mon Apr 11 13:24:10 2011 Child 1 verified 1386 files, created 1373
148 Mon Apr 11 13:24:10 2011 Child 1 will create 2 symlinks.
149 Mon Apr 11 13:24:10 2011 Child 15 verified 1386 files, created 1373
150 Mon Apr 11 13:24:10 2011 Child 15 will create 2 symlinks.
151 Mon Apr 11 13:24:10 2011 Child 1 finished creating 2 symlinks.
152 Mon Apr 11 13:24:10 2011 Child 15 finished creating 2 symlinks.
153 Mon Apr 11 13:24:11 2011 Completed.
154 Mon Apr 11 13:24:11 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
155 Mon Apr 11 13:24:11 2011 Completed.
156 Mon Apr 11 13:24:11 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
157 Mon Apr 11 13:24:11 2011 Received.
158 Mon Apr 11 13:24:11 2011 Performing 300 seconds pretest warmup.
159 Mon Apr 11 13:29:11 2011 Completed.
160 Mon Apr 11 13:29:11 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
161 Mon Apr 11 13:29:11 2011 Completed.
162 Mon Apr 11 13:29:11 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
163 Mon Apr 11 13:29:12 2011 Received.
164 Mon Apr 11 13:29:12 2011 Starting 300 seconds test run.
165 Child 4 - 50 aborted ops
166 Child 4 - 100 aborted ops
167 SFS Single Client (c09-44) Results, Mon Apr 11 13:34:22 2011
168 --------------------------------------------------------------------------------------
169 NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt
170 Op Logical Logical Logical Physical Op Response Response of Mean, of
171 Type Mix Mix Success Success Error Time Time 95% Conf Total
172 Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time
173 --------------------------------------------------------------------------------------
174 getattr 26.0% 25.8% 7749 7749 0 0.19 0.03 0.00 5.5%
175 setattr 4.0% 4.0% 1191 1191 0 0.94 0.98 0.06 4.2%
176 lookup 24.0% 23.7% 7104 7104 0 0.19 0.03 0.00 5.2%
177 readlink 1.0% 1.0% 302 302 0 0.19 0.01 0.01 0.2%
178 read 18.0% 18.1% 5440 6644 0 1.21 2.58 0.04 24.7%
179 write 10.0% 10.2% 3053 3706 0 3.58 10.97 0.12 41.3%
180 create 1.0% 1.0% 303 303 0 1.89 0.91 0.11 2.2%
181 remove 1.0% 1.0% 297 297 0 1.15 0.56 0.09 1.3%
182 readdir 1.0% 1.0% 287 287 0 0.36 0.08 0.03 0.4%
183 fsstat 1.0% 1.0% 293 293 0 0.19 0.03 0.02 0.2%
184 access 11.0% 11.1% 3338 3338 0 0.19 0.03 0.01 2.4%
185 commit 0.0% 0.0% 0 1343 0 0.00 0.00 0.00 11.2%
186 readdirplus 2.0% 2.1% 627 627 0 0.55 0.04 0.02 1.3%
187 --------------------------------------------------------------------------------------
189 --------------------------------------------------
190 | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY |
191 --------------------------+-----------------------
192 SFS NFS V3 THROUGHPUT: 99.94 Ops/Sec AVG. RESPONSE TIME: 0.88 Msec/Op
195 NFS V3 MIXFILE: [ SFS Default ]
196 CLIENT REQUESTED LOAD: 100 Ops/Sec
197 TOTAL LOGICAL NFS V3 OPERATIONS: 29984 TEST TIME: 300 Sec
198 TOTAL PHYSICAL NFS V3 OPERATIONS: 33184
199 PHYSICAL NFS V3 THROUGHPUT: 110.61 Ops/Sec
200 FILE SET SIZE CREATED: 11537568.0 KB
201 FILE SET SIZE ACCESSED: 3466368.0 - 3536581.0 KB (100.00% to 102.03% of Base)
203 ------------------------------------------------------------------------
205 Mon Apr 11 13:34:22 2011 Completed.
207 Client Test Parameters:
208 Number of processes = 16
209 Requested Load (NFS V3 operations/second) = 100
210 Maximum number of outstanding biod writes = 8
211 Maximum number of outstanding biod reads = 8
212 Warm-up time (seconds) = 300
213 Run time (seconds) = 300
214 File Set = 21728 Files created for I/O operations
215 6512 Files accessed for I/O operations
216 448 Files for non-I/O operations
219 Additional non-I/O files created as necessary
222 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
223 Mon Apr 11 13:34:22 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
224 Mon Apr 11 13:34:22 2011 Completed.
225 Mon Apr 11 13:34:22 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
227 ************************************************************************
228 Mon Apr 11 13:34:23 2011 Received.
229 Mon Apr 11 13:34:23 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
230 Mon Apr 11 13:34:23 2011 Completed.
231 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 200 -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 16 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export
232 NFS V3 Protocol Version
233 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
234 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
236 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
237 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
239 ************************************************************************
241 SFS NFS V3 Benchmark Client Logfile, Mon Apr 11 13:34:25 2011
242 Client hostname = c09-44
243 Prime Client hostname = c09-44.sysnet.ucsd.edu
245 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
247 Mon Apr 11 13:34:25 2011 Mounting 16 remote test directories.
248 Child[000]: NFS negotiated block size 32768
249 Child[001]: NFS negotiated block size 32768
250 Child[002]: NFS negotiated block size 32768
251 Child[003]: NFS negotiated block size 32768
252 Child[004]: NFS negotiated block size 32768
253 Child[005]: NFS negotiated block size 32768
254 Child[006]: NFS negotiated block size 32768
255 Child[007]: NFS negotiated block size 32768
256 Child[008]: NFS negotiated block size 32768
257 Child[009]: NFS negotiated block size 32768
258 Child[010]: NFS negotiated block size 32768
259 Child[011]: NFS negotiated block size 32768
260 Child[012]: NFS negotiated block size 32768
261 Child[013]: NFS negotiated block size 32768
262 Child[014]: NFS negotiated block size 32768
263 Child[015]: NFS negotiated block size 32768
264 Mon Apr 11 13:34:39 2011 Completed.
265 Mon Apr 11 13:34:39 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
266 Mon Apr 11 13:34:39 2011 Completed.
267 Mon Apr 11 13:34:39 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
268 Mon Apr 11 13:34:41 2011 Received.
270 Mon Apr 11 13:34:41 2011 Initializing test directories.
271 Mon Apr 11 13:34:41 2011 Child 14 will create 95 directories.
272 Mon Apr 11 13:34:41 2011 Child 11 will create 95 directories.
273 Mon Apr 11 13:34:41 2011 Child 6 will create 95 directories.
274 Mon Apr 11 13:34:41 2011 Child 15 will create 95 directories.
275 Mon Apr 11 13:34:41 2011 Child 12 will create 95 directories.
276 Mon Apr 11 13:34:41 2011 Child 9 will create 95 directories.
277 Mon Apr 11 13:34:41 2011 Child 5 will create 95 directories.
278 Mon Apr 11 13:34:41 2011 Child 2 will create 95 directories.
279 Mon Apr 11 13:34:41 2011 Child 4 will create 95 directories.
280 Mon Apr 11 13:34:41 2011 Child 1 will create 95 directories.
281 Mon Apr 11 13:34:41 2011 Child 8 will create 95 directories.
282 Mon Apr 11 13:34:41 2011 Child 10 will create 95 directories.
283 Mon Apr 11 13:34:41 2011 Child 3 will create 95 directories.
284 Mon Apr 11 13:34:41 2011 Child 13 will create 95 directories.
285 Mon Apr 11 13:34:41 2011 Child 0 will create 95 directories.
286 Mon Apr 11 13:34:41 2011 Child 7 will create 95 directories.
287 Mon Apr 11 13:34:42 2011 Child 15 finished creating 95 directories.
288 Mon Apr 11 13:34:42 2011 Child 15 will create 2897 files.
289 Mon Apr 11 13:34:42 2011 Child 1 finished creating 95 directories.
290 Mon Apr 11 13:34:42 2011 Child 1 will create 2897 files.
291 Mon Apr 11 13:34:42 2011 Child 0 finished creating 95 directories.
292 Mon Apr 11 13:34:42 2011 Child 0 will create 2897 files.
293 Mon Apr 11 13:34:42 2011 Child 3 finished creating 95 directories.
294 Mon Apr 11 13:34:42 2011 Child 3 will create 2897 files.
295 Mon Apr 11 13:34:42 2011 Child 12 finished creating 95 directories.
296 Mon Apr 11 13:34:42 2011 Child 12 will create 2897 files.
297 Mon Apr 11 13:34:42 2011 Child 5 finished creating 95 directories.
298 Mon Apr 11 13:34:42 2011 Child 5 will create 2897 files.
299 Mon Apr 11 13:34:43 2011 Child 11 finished creating 95 directories.
300 Mon Apr 11 13:34:43 2011 Child 11 will create 2897 files.
301 Mon Apr 11 13:34:43 2011 Child 13 finished creating 95 directories.
302 Mon Apr 11 13:34:43 2011 Child 13 will create 2897 files.
303 Mon Apr 11 13:34:45 2011 Child 7 finished creating 95 directories.
304 Mon Apr 11 13:34:45 2011 Child 7 will create 2897 files.
305 Mon Apr 11 13:34:46 2011 Child 2 finished creating 95 directories.
306 Mon Apr 11 13:34:46 2011 Child 2 will create 2897 files.
307 Mon Apr 11 13:34:46 2011 Child 14 finished creating 95 directories.
308 Mon Apr 11 13:34:46 2011 Child 14 will create 2897 files.
309 Mon Apr 11 13:34:46 2011 Child 9 finished creating 95 directories.
310 Mon Apr 11 13:34:46 2011 Child 9 will create 2897 files.
311 Mon Apr 11 13:34:46 2011 Child 4 finished creating 95 directories.
312 Mon Apr 11 13:34:46 2011 Child 4 will create 2897 files.
313 Mon Apr 11 13:34:46 2011 Child 10 finished creating 95 directories.
314 Mon Apr 11 13:34:46 2011 Child 10 will create 2897 files.
315 Mon Apr 11 13:34:46 2011 Child 8 finished creating 95 directories.
316 Mon Apr 11 13:34:46 2011 Child 8 will create 2897 files.
317 Mon Apr 11 13:34:46 2011 Child 6 finished creating 95 directories.
318 Mon Apr 11 13:34:46 2011 Child 6 will create 2897 files.
319 Mon Apr 11 13:39:48 2011 Child 8 verified 1687 files (329 creates).
320 Mon Apr 11 13:39:48 2011 Child 1 verified 1866 files (508 creates).
321 Mon Apr 11 13:39:48 2011 Child 13 verified 1687 files (329 creates).
322 Mon Apr 11 13:39:57 2011 Child 7 verified 1687 files (329 creates).
323 Mon Apr 11 13:40:02 2011 Child 4 verified 1687 files (329 creates).
324 Mon Apr 11 13:40:02 2011 Child 3 verified 1823 files (465 creates).
325 Mon Apr 11 13:40:02 2011 Child 11 verified 1774 files (416 creates).
326 Mon Apr 11 13:40:02 2011 Child 15 verified 1823 files (465 creates).
327 Mon Apr 11 13:40:02 2011 Child 9 verified 1687 files (329 creates).
328 Mon Apr 11 13:40:02 2011 Child 14 verified 1774 files (416 creates).
329 Mon Apr 11 13:40:02 2011 Child 6 verified 1687 files (329 creates).
330 Mon Apr 11 13:40:02 2011 Child 0 verified 1823 files (465 creates).
331 Mon Apr 11 13:40:02 2011 Child 10 verified 1687 files (329 creates).
332 Mon Apr 11 13:40:02 2011 Child 2 verified 1687 files (329 creates).
333 Mon Apr 11 13:40:02 2011 Child 12 verified 1823 files (465 creates).
334 Mon Apr 11 13:40:02 2011 Child 5 verified 1823 files (465 creates).
335 Mon Apr 11 13:45:02 2011 Child 4 verified 1953 files (595 creates).
336 Mon Apr 11 13:45:02 2011 Child 2 verified 1964 files (606 creates).
337 Mon Apr 11 13:45:02 2011 Child 15 verified 2191 files (833 creates).
338 Mon Apr 11 13:45:03 2011 Child 12 verified 2225 files (867 creates).
339 Mon Apr 11 13:45:12 2011 Child 0 verified 2291 files (933 creates).
340 Mon Apr 11 13:45:13 2011 Child 13 verified 1907 files (549 creates).
341 Mon Apr 11 13:45:13 2011 Child 9 verified 1907 files (549 creates).
342 Mon Apr 11 13:45:13 2011 Child 5 verified 2310 files (952 creates).
343 Mon Apr 11 13:45:13 2011 Child 8 verified 1907 files (549 creates).
344 Mon Apr 11 13:45:31 2011 Child 7 verified 1907 files (549 creates).
345 Mon Apr 11 13:45:31 2011 Child 14 verified 2141 files (783 creates).
346 Mon Apr 11 13:45:31 2011 Child 10 verified 1907 files (549 creates).
347 Mon Apr 11 13:45:31 2011 Child 3 verified 2203 files (845 creates).
348 Mon Apr 11 13:45:31 2011 Child 6 verified 1907 files (549 creates).
349 Mon Apr 11 13:45:31 2011 Child 11 verified 2141 files (783 creates).
350 Mon Apr 11 13:45:31 2011 Child 1 verified 2364 files (1006 creates).
351 Mon Apr 11 13:50:04 2011 Child 4 verified 2404 files (1046 creates).
352 Mon Apr 11 13:50:04 2011 Child 15 verified 2540 files (1182 creates).
353 Mon Apr 11 13:50:23 2011 Child 8 verified 2370 files (1012 creates).
354 Mon Apr 11 13:50:23 2011 Child 2 verified 2370 files (1012 creates).
355 Mon Apr 11 13:50:23 2011 Child 0 verified 2725 files (1367 creates).
356 Mon Apr 11 13:50:33 2011 Child 12 verified 2560 files (1202 creates).
357 Mon Apr 11 13:50:42 2011 Child 9 verified 2404 files (1046 creates).
358 Mon Apr 11 13:50:57 2011 Child 6 verified 2378 files (1020 creates).
359 Mon Apr 11 13:51:08 2011 Child 13 verified 2378 files (1020 creates).
360 Mon Apr 11 13:51:08 2011 Child 14 verified 2501 files (1143 creates).
361 Mon Apr 11 13:51:08 2011 Child 11 verified 2448 files (1090 creates).
362 Mon Apr 11 13:51:27 2011 Child 10 verified 2364 files (1006 creates).
363 Mon Apr 11 13:51:29 2011 Child 3 verified 2542 files (1184 creates).
364 Mon Apr 11 13:51:29 2011 Child 7 verified 2364 files (1006 creates).
365 Mon Apr 11 13:51:29 2011 Child 1 verified 2741 files (1383 creates).
366 Mon Apr 11 13:51:32 2011 Child 5 verified 2897 files, created 1511
367 Mon Apr 11 13:51:32 2011 Child 5 will create 2 symlinks.
368 Mon Apr 11 13:51:32 2011 Child 5 finished creating 2 symlinks.
369 Mon Apr 11 13:52:38 2011 Child 1 verified 2897 files, created 1511
370 Mon Apr 11 13:52:38 2011 Child 1 will create 2 symlinks.
371 Mon Apr 11 13:52:38 2011 Child 1 finished creating 2 symlinks.
372 Mon Apr 11 13:53:09 2011 Child 0 verified 2897 files, created 1511
373 Mon Apr 11 13:53:09 2011 Child 0 will create 2 symlinks.
374 Mon Apr 11 13:53:09 2011 Child 0 finished creating 2 symlinks.
375 Mon Apr 11 13:53:34 2011 Child 12 verified 2897 files, created 1511
376 Mon Apr 11 13:53:34 2011 Child 12 will create 2 symlinks.
377 Mon Apr 11 13:53:34 2011 Child 12 finished creating 2 symlinks.
378 Mon Apr 11 13:54:14 2011 Child 3 verified 2897 files, created 1511
379 Mon Apr 11 13:54:14 2011 Child 3 will create 2 symlinks.
380 Mon Apr 11 13:54:15 2011 Child 15 verified 2897 files, created 1511
381 Mon Apr 11 13:54:15 2011 Child 15 will create 2 symlinks.
382 Mon Apr 11 13:54:15 2011 Child 14 verified 2897 files, created 1511
383 Mon Apr 11 13:54:15 2011 Child 14 will create 2 symlinks.
384 Mon Apr 11 13:54:15 2011 Child 15 finished creating 2 symlinks.
385 Mon Apr 11 13:54:15 2011 Child 14 finished creating 2 symlinks.
386 Mon Apr 11 13:54:19 2011 Child 3 finished creating 2 symlinks.
387 Mon Apr 11 13:54:23 2011 Child 4 verified 2897 files, created 1511
388 Mon Apr 11 13:54:23 2011 Child 4 will create 2 symlinks.
389 Mon Apr 11 13:54:23 2011 Child 4 finished creating 2 symlinks.
390 Mon Apr 11 13:54:34 2011 Child 11 verified 2897 files, created 1511
391 Mon Apr 11 13:54:34 2011 Child 11 will create 2 symlinks.
392 Mon Apr 11 13:54:35 2011 Child 11 finished creating 2 symlinks.
393 Mon Apr 11 13:54:37 2011 Child 9 verified 2897 files, created 1511
394 Mon Apr 11 13:54:37 2011 Child 9 will create 2 symlinks.
395 Mon Apr 11 13:54:38 2011 Child 6 verified 2897 files, created 1511
396 Mon Apr 11 13:54:38 2011 Child 6 will create 2 symlinks.
397 Mon Apr 11 13:54:40 2011 Child 13 verified 2897 files, created 1511
398 Mon Apr 11 13:54:40 2011 Child 13 will create 2 symlinks.
399 Mon Apr 11 13:54:41 2011 Child 13 finished creating 2 symlinks.
400 Mon Apr 11 13:54:41 2011 Child 6 finished creating 2 symlinks.
401 Mon Apr 11 13:54:41 2011 Child 9 finished creating 2 symlinks.
402 Mon Apr 11 13:54:42 2011 Child 8 verified 2897 files, created 1511
403 Mon Apr 11 13:54:42 2011 Child 8 will create 2 symlinks.
404 Mon Apr 11 13:54:42 2011 Child 8 finished creating 2 symlinks.
405 Mon Apr 11 13:54:44 2011 Child 10 verified 2897 files, created 1511
406 Mon Apr 11 13:54:44 2011 Child 10 will create 2 symlinks.
407 Mon Apr 11 13:54:44 2011 Child 10 finished creating 2 symlinks.
408 Mon Apr 11 13:54:46 2011 Child 2 verified 2897 files, created 1511
409 Mon Apr 11 13:54:46 2011 Child 2 will create 2 symlinks.
410 Mon Apr 11 13:54:46 2011 Child 2 finished creating 2 symlinks.
411 Mon Apr 11 13:54:48 2011 Child 7 verified 2897 files, created 1511
412 Mon Apr 11 13:54:48 2011 Child 7 will create 2 symlinks.
413 Mon Apr 11 13:54:48 2011 Child 7 finished creating 2 symlinks.
414 Mon Apr 11 13:54:48 2011 Completed.
415 Mon Apr 11 13:54:48 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
416 Mon Apr 11 13:54:48 2011 Completed.
417 Mon Apr 11 13:54:48 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
418 Mon Apr 11 13:54:49 2011 Received.
419 Mon Apr 11 13:54:49 2011 Performing 300 seconds pretest warmup.
420 Mon Apr 11 13:59:49 2011 Completed.
421 Mon Apr 11 13:59:49 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
422 Mon Apr 11 13:59:49 2011 Completed.
423 Mon Apr 11 13:59:49 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
424 Mon Apr 11 13:59:50 2011 Received.
425 Mon Apr 11 13:59:50 2011 Starting 300 seconds test run.
426 SFS Single Client (c09-44) Results, Mon Apr 11 14:05:00 2011
427 --------------------------------------------------------------------------------------
428 NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt
429 Op Logical Logical Logical Physical Op Response Response of Mean, of
430 Type Mix Mix Success Success Error Time Time 95% Conf Total
431 Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time
432 --------------------------------------------------------------------------------------
433 getattr 26.0% 26.1% 15636 15636 0 0.19 0.05 0.00 4.4%
434 setattr 4.0% 4.1% 2443 2443 0 1.54 10.17 0.13 5.5%
435 lookup 24.0% 23.9% 14314 14314 0 0.20 0.06 0.00 4.2%
436 readlink 1.0% 1.0% 623 623 0 0.19 0.07 0.02 0.2%
437 read 18.0% 18.1% 10842 13425 0 2.01 4.42 0.04 31.9%
438 write 10.0% 9.9% 5963 7271 0 3.42 12.67 0.09 29.8%
439 create 1.0% 1.0% 599 599 0 5.02 38.61 0.50 4.4%
440 remove 1.0% 1.0% 622 622 0 3.22 23.31 0.38 2.9%
441 readdir 1.0% 1.0% 604 604 0 0.40 0.12 0.03 0.4%
442 fsstat 1.0% 1.0% 616 616 0 0.19 0.05 0.02 0.2%
443 access 11.0% 10.9% 6547 6547 0 0.19 0.04 0.01 1.8%
444 commit 0.0% 0.0% 0 2598 0 0.00 0.00 0.00 13.4%
445 readdirplus 2.0% 2.0% 1206 1206 0 0.65 0.07 0.01 1.1%
446 --------------------------------------------------------------------------------------
448 --------------------------------------------------
449 | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY |
450 --------------------------+-----------------------
451 SFS NFS V3 THROUGHPUT: 200.05 Ops/Sec AVG. RESPONSE TIME: 1.14 Msec/Op
454 NFS V3 MIXFILE: [ SFS Default ]
455 CLIENT REQUESTED LOAD: 200 Ops/Sec
456 TOTAL LOGICAL NFS V3 OPERATIONS: 60015 TEST TIME: 300 Sec
457 TOTAL PHYSICAL NFS V3 OPERATIONS: 66504
458 PHYSICAL NFS V3 THROUGHPUT: 221.68 Ops/Sec
459 FILE SET SIZE CREATED: 24128640.0 KB
460 FILE SET SIZE ACCESSED: 7247088.0 - 7391739.0 KB (100.00% to 102.00% of Base)
462 ------------------------------------------------------------------------
464 Mon Apr 11 14:05:00 2011 Completed.
466 Client Test Parameters:
467 Number of processes = 16
468 Requested Load (NFS V3 operations/second) = 200
469 Maximum number of outstanding biod writes = 8
470 Maximum number of outstanding biod reads = 8
471 Warm-up time (seconds) = 300
472 Run time (seconds) = 300
473 File Set = 45440 Files created for I/O operations
474 13632 Files accessed for I/O operations
475 912 Files for non-I/O operations
478 Additional non-I/O files created as necessary
481 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
482 Mon Apr 11 14:05:00 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
483 Mon Apr 11 14:05:00 2011 Completed.
484 Mon Apr 11 14:05:00 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
486 ************************************************************************
487 Mon Apr 11 14:05:01 2011 Received.
488 Mon Apr 11 14:05:01 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
489 Mon Apr 11 14:05:01 2011 Completed.
490 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 300 -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 16 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export
491 NFS V3 Protocol Version
493 ************************************************************************
494 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
495 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
497 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
498 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
500 SFS NFS V3 Benchmark Client Logfile, Mon Apr 11 14:05:03 2011
501 Client hostname = c09-44
502 Prime Client hostname = c09-44.sysnet.ucsd.edu
504 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
506 Mon Apr 11 14:05:03 2011 Mounting 16 remote test directories.
507 Child[000]: NFS negotiated block size 32768
508 Child[001]: NFS negotiated block size 32768
509 Child[002]: NFS negotiated block size 32768
510 Child[003]: NFS negotiated block size 32768
511 Child[004]: NFS negotiated block size 32768
512 Child[005]: NFS negotiated block size 32768
513 Child[006]: NFS negotiated block size 32768
514 Child[007]: NFS negotiated block size 32768
515 Child[008]: NFS negotiated block size 32768
516 Child[009]: NFS negotiated block size 32768
517 Child[010]: NFS negotiated block size 32768
518 Child[011]: NFS negotiated block size 32768
519 Child[012]: NFS negotiated block size 32768
520 Child[013]: NFS negotiated block size 32768
521 Child[014]: NFS negotiated block size 32768
522 Child[015]: NFS negotiated block size 32768
523 Mon Apr 11 14:05:17 2011 Completed.
524 Mon Apr 11 14:05:17 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
525 Mon Apr 11 14:05:17 2011 Completed.
526 Mon Apr 11 14:05:17 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
527 Mon Apr 11 14:05:19 2011 Received.
529 Mon Apr 11 14:05:19 2011 Initializing test directories.
530 Mon Apr 11 14:05:19 2011 Child 6 will create 145 directories.
531 Mon Apr 11 14:05:19 2011 Child 8 will create 145 directories.
532 Mon Apr 11 14:05:19 2011 Child 2 will create 145 directories.
533 Mon Apr 11 14:05:19 2011 Child 9 will create 145 directories.
534 Mon Apr 11 14:05:19 2011 Child 10 will create 145 directories.
535 Mon Apr 11 14:05:19 2011 Child 7 will create 145 directories.
536 Mon Apr 11 14:05:19 2011 Child 1 will create 145 directories.
537 Mon Apr 11 14:05:19 2011 Child 13 will create 145 directories.
538 Mon Apr 11 14:05:19 2011 Child 12 will create 145 directories.
539 Mon Apr 11 14:05:19 2011 Child 0 will create 145 directories.
540 Mon Apr 11 14:05:19 2011 Child 5 will create 145 directories.
541 Mon Apr 11 14:05:19 2011 Child 14 will create 145 directories.
542 Mon Apr 11 14:05:19 2011 Child 11 will create 145 directories.
543 Mon Apr 11 14:05:19 2011 Child 3 will create 145 directories.
544 Mon Apr 11 14:05:19 2011 Child 4 will create 145 directories.
545 Mon Apr 11 14:05:19 2011 Child 15 will create 145 directories.
546 Mon Apr 11 14:05:19 2011 Child 4 finished creating 145 directories.
547 Mon Apr 11 14:05:19 2011 Child 4 will create 4408 files.
548 Mon Apr 11 14:05:20 2011 Child 5 finished creating 145 directories.
549 Mon Apr 11 14:05:20 2011 Child 5 will create 4408 files.
550 Mon Apr 11 14:05:20 2011 Child 1 finished creating 145 directories.
551 Mon Apr 11 14:05:20 2011 Child 1 will create 4408 files.
552 Mon Apr 11 14:05:21 2011 Child 3 finished creating 145 directories.
553 Mon Apr 11 14:05:21 2011 Child 3 will create 4408 files.
554 Mon Apr 11 14:05:21 2011 Child 10 finished creating 145 directories.
555 Mon Apr 11 14:05:21 2011 Child 10 will create 4408 files.
556 Mon Apr 11 14:05:22 2011 Child 13 finished creating 145 directories.
557 Mon Apr 11 14:05:22 2011 Child 13 will create 4408 files.
558 Mon Apr 11 14:05:22 2011 Child 15 finished creating 145 directories.
559 Mon Apr 11 14:05:22 2011 Child 15 will create 4408 files.
560 Mon Apr 11 14:05:23 2011 Child 6 finished creating 145 directories.
561 Mon Apr 11 14:05:23 2011 Child 6 will create 4408 files.
562 Mon Apr 11 14:05:25 2011 Child 9 finished creating 145 directories.
563 Mon Apr 11 14:05:25 2011 Child 9 will create 4408 files.
564 Mon Apr 11 14:05:25 2011 Child 7 finished creating 145 directories.
565 Mon Apr 11 14:05:25 2011 Child 7 will create 4408 files.
566 Mon Apr 11 14:05:30 2011 Child 12 finished creating 145 directories.
567 Mon Apr 11 14:05:30 2011 Child 12 will create 4408 files.
568 Mon Apr 11 14:05:30 2011 Child 14 finished creating 145 directories.
569 Mon Apr 11 14:05:30 2011 Child 14 will create 4408 files.
570 Mon Apr 11 14:05:30 2011 Child 8 finished creating 145 directories.
571 Mon Apr 11 14:05:30 2011 Child 8 will create 4408 files.
572 Mon Apr 11 14:05:30 2011 Child 0 finished creating 145 directories.
573 Mon Apr 11 14:05:30 2011 Child 0 will create 4408 files.
574 Mon Apr 11 14:05:30 2011 Child 2 finished creating 145 directories.
575 Mon Apr 11 14:05:30 2011 Child 2 will create 4408 files.
576 Mon Apr 11 14:05:30 2011 Child 11 finished creating 145 directories.
577 Mon Apr 11 14:05:30 2011 Child 11 will create 4408 files.
578 Mon Apr 11 14:10:22 2011 Child 5 verified 3456 files (616 creates).
579 Mon Apr 11 14:10:43 2011 Child 15 verified 3312 files (472 creates).
580 Mon Apr 11 14:10:43 2011 Child 6 verified 3297 files (457 creates).
581 Mon Apr 11 14:10:43 2011 Child 13 verified 3312 files (472 creates).
582 Mon Apr 11 14:10:54 2011 Child 14 verified 3192 files (352 creates).
583 Mon Apr 11 14:10:54 2011 Child 3 verified 3456 files (616 creates).
584 Mon Apr 11 14:11:03 2011 Child 0 verified 3161 files (321 creates).
585 Mon Apr 11 14:11:04 2011 Child 9 verified 3192 files (352 creates).
586 Mon Apr 11 14:11:13 2011 Child 8 verified 3052 files (212 creates).
587 Mon Apr 11 14:11:14 2011 Child 4 verified 3456 files (616 creates).
588 Mon Apr 11 14:11:27 2011 Child 10 verified 3456 files (616 creates).
589 Mon Apr 11 14:11:29 2011 Child 2 verified 3146 files (306 creates).
590 Mon Apr 11 14:11:29 2011 Child 11 verified 3146 files (306 creates).
591 Mon Apr 11 14:11:29 2011 Child 12 verified 3146 files (306 creates).
592 Mon Apr 11 14:11:29 2011 Child 1 verified 3505 files (665 creates).
593 Mon Apr 11 14:11:29 2011 Child 7 verified 3075 files (235 creates).
594 Mon Apr 11 14:15:31 2011 Child 5 verified 3851 files (1011 creates).
595 Mon Apr 11 14:15:54 2011 Child 13 verified 3544 files (704 creates).
596 Mon Apr 11 14:16:03 2011 Child 15 verified 3592 files (752 creates).
597 Mon Apr 11 14:16:13 2011 Child 14 verified 3734 files (894 creates).
598 Mon Apr 11 14:16:16 2011 Child 6 verified 3594 files (754 creates).
599 Mon Apr 11 14:16:16 2011 Child 3 verified 3873 files (1033 creates).
600 Mon Apr 11 14:16:17 2011 Child 4 verified 3886 files (1046 creates).
601 Mon Apr 11 14:16:47 2011 Child 10 verified 3949 files (1109 creates).
602 Mon Apr 11 14:16:47 2011 Child 2 verified 3680 files (840 creates).
603 Mon Apr 11 14:16:47 2011 Child 11 verified 3544 files (704 creates).
604 Mon Apr 11 14:16:47 2011 Child 0 verified 3743 files (903 creates).
605 Mon Apr 11 14:16:47 2011 Child 9 verified 3544 files (704 creates).
606 Mon Apr 11 14:16:47 2011 Child 7 verified 3544 files (704 creates).
607 Mon Apr 11 14:16:47 2011 Child 1 verified 3879 files (1039 creates).
608 Mon Apr 11 14:16:47 2011 Child 8 verified 3370 files (530 creates).
609 Mon Apr 11 14:16:47 2011 Child 12 verified 3743 files (903 creates).
610 Mon Apr 11 14:19:28 2011 Child 4 verified 4408 files, created 1525
611 Mon Apr 11 14:19:28 2011 Child 4 will create 2 symlinks.
612 Mon Apr 11 14:19:28 2011 Child 4 finished creating 2 symlinks.
613 Mon Apr 11 14:19:29 2011 Child 10 verified 4408 files, created 1525
614 Mon Apr 11 14:19:29 2011 Child 10 will create 2 symlinks.
615 Mon Apr 11 14:19:29 2011 Child 10 finished creating 2 symlinks.
616 Mon Apr 11 14:19:32 2011 Child 1 verified 4408 files, created 1525
617 Mon Apr 11 14:19:32 2011 Child 1 will create 2 symlinks.
618 Mon Apr 11 14:19:33 2011 Child 1 finished creating 2 symlinks.
619 Mon Apr 11 14:19:34 2011 Child 3 verified 4408 files, created 1525
620 Mon Apr 11 14:19:34 2011 Child 3 will create 2 symlinks.
621 Mon Apr 11 14:19:34 2011 Child 3 finished creating 2 symlinks.
622 Mon Apr 11 14:19:37 2011 Child 5 verified 4408 files, created 1525
623 Mon Apr 11 14:19:37 2011 Child 5 will create 2 symlinks.
624 Mon Apr 11 14:19:37 2011 Child 5 finished creating 2 symlinks.
625 Mon Apr 11 14:20:26 2011 Child 0 verified 4408 files, created 1525
626 Mon Apr 11 14:20:26 2011 Child 0 will create 2 symlinks.
627 Mon Apr 11 14:20:26 2011 Child 0 finished creating 2 symlinks.
628 Mon Apr 11 14:20:27 2011 Child 14 verified 4408 files, created 1525
629 Mon Apr 11 14:20:27 2011 Child 14 will create 2 symlinks.
630 Mon Apr 11 14:20:27 2011 Child 14 finished creating 2 symlinks.
631 Mon Apr 11 14:20:30 2011 Child 15 verified 4408 files, created 1525
632 Mon Apr 11 14:20:30 2011 Child 15 will create 2 symlinks.
633 Mon Apr 11 14:20:31 2011 Child 15 finished creating 2 symlinks.
634 Mon Apr 11 14:20:32 2011 Child 6 verified 4408 files, created 1525
635 Mon Apr 11 14:20:32 2011 Child 6 will create 2 symlinks.
636 Mon Apr 11 14:20:32 2011 Child 6 finished creating 2 symlinks.
637 Mon Apr 11 14:20:44 2011 Child 12 verified 4408 files, created 1525
638 Mon Apr 11 14:20:44 2011 Child 12 will create 2 symlinks.
639 Mon Apr 11 14:20:44 2011 Child 12 finished creating 2 symlinks.
640 Mon Apr 11 14:20:47 2011 Child 2 verified 4408 files, created 1525
641 Mon Apr 11 14:20:47 2011 Child 2 will create 2 symlinks.
642 Mon Apr 11 14:20:47 2011 Child 2 finished creating 2 symlinks.
643 Mon Apr 11 14:20:48 2011 Child 13 verified 4408 files, created 1525
644 Mon Apr 11 14:20:48 2011 Child 13 will create 2 symlinks.
645 Mon Apr 11 14:20:48 2011 Child 13 finished creating 2 symlinks.
646 Mon Apr 11 14:20:54 2011 Child 7 verified 4408 files, created 1525
647 Mon Apr 11 14:20:54 2011 Child 7 will create 2 symlinks.
648 Mon Apr 11 14:20:54 2011 Child 8 verified 4408 files, created 1525
649 Mon Apr 11 14:20:54 2011 Child 8 will create 2 symlinks.
650 Mon Apr 11 14:20:54 2011 Child 9 verified 4408 files, created 1525
651 Mon Apr 11 14:20:54 2011 Child 9 will create 2 symlinks.
652 Mon Apr 11 14:20:54 2011 Child 7 finished creating 2 symlinks.
653 Mon Apr 11 14:20:54 2011 Child 11 verified 4408 files, created 1525
654 Mon Apr 11 14:20:54 2011 Child 11 will create 2 symlinks.
655 Mon Apr 11 14:20:54 2011 Child 8 finished creating 2 symlinks.
656 Mon Apr 11 14:20:54 2011 Child 9 finished creating 2 symlinks.
657 Mon Apr 11 14:20:54 2011 Child 11 finished creating 2 symlinks.
658 Mon Apr 11 14:20:54 2011 Completed.
659 Mon Apr 11 14:20:54 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
660 Mon Apr 11 14:20:54 2011 Completed.
661 Mon Apr 11 14:20:54 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
662 Mon Apr 11 14:20:54 2011 Received.
663 Mon Apr 11 14:20:54 2011 Performing 300 seconds pretest warmup.
664 Mon Apr 11 14:25:54 2011 Completed.
665 Mon Apr 11 14:25:54 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
666 Mon Apr 11 14:25:54 2011 Completed.
667 Mon Apr 11 14:25:54 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
668 Mon Apr 11 14:25:55 2011 Received.
669 Mon Apr 11 14:25:55 2011 Starting 300 seconds test run.
670 SFS Single Client (c09-44) Results, Mon Apr 11 14:31:05 2011
671 --------------------------------------------------------------------------------------
672 NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt
673 Op Logical Logical Logical Physical Op Response Response of Mean, of
674 Type Mix Mix Success Success Error Time Time 95% Conf Total
675 Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time
676 --------------------------------------------------------------------------------------
677 getattr 26.0% 26.0% 23377 23377 0 0.19 0.05 0.00 3.3%
678 setattr 4.0% 4.0% 3598 3598 0 2.03 10.76 0.11 5.4%
679 lookup 24.0% 24.0% 21650 21650 0 0.20 0.05 0.00 3.2%
680 readlink 1.0% 1.0% 914 914 0 0.19 0.05 0.01 0.1%
681 read 18.0% 17.9% 16126 19763 0 3.34 22.89 0.07 39.7%
682 write 10.0% 10.1% 9132 11173 0 4.42 17.99 0.09 29.7%
683 create 1.0% 1.0% 939 939 0 4.59 11.51 0.22 3.2%
684 remove 1.0% 1.0% 872 872 0 3.72 19.37 0.29 2.4%
685 readdir 1.0% 0.9% 855 855 0 0.40 0.10 0.02 0.3%
686 fsstat 1.0% 1.0% 922 922 0 0.19 0.06 0.02 0.1%
687 access 11.0% 11.0% 9872 9872 0 0.19 0.07 0.01 1.4%
688 commit 0.0% 0.0% 0 4017 0 0.00 0.00 0.00 10.4%
689 readdirplus 2.0% 2.0% 1777 1777 0 0.69 0.07 0.01 0.9%
690 --------------------------------------------------------------------------------------
692 --------------------------------------------------
693 | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY |
694 --------------------------+-----------------------
695 SFS NFS V3 THROUGHPUT: 300.11 Ops/Sec AVG. RESPONSE TIME: 1.50 Msec/Op
698 NFS V3 MIXFILE: [ SFS Default ]
699 CLIENT REQUESTED LOAD: 300 Ops/Sec
700 TOTAL LOGICAL NFS V3 OPERATIONS: 90034 TEST TIME: 300 Sec
701 TOTAL PHYSICAL NFS V3 OPERATIONS: 99729
702 PHYSICAL NFS V3 THROUGHPUT: 332.43 Ops/Sec
703 FILE SET SIZE CREATED: 36711216.0 KB
704 FILE SET SIZE ACCESSED: 11019312.0 - 11237196.0 KB (100.00% to 101.98% of Base)
706 ------------------------------------------------------------------------
708 Mon Apr 11 14:31:05 2011 Completed.
710 Client Test Parameters:
711 Number of processes = 16
712 Requested Load (NFS V3 operations/second) = 300
713 Maximum number of outstanding biod writes = 8
714 Maximum number of outstanding biod reads = 8
715 Warm-up time (seconds) = 300
716 Run time (seconds) = 300
717 File Set = 69136 Files created for I/O operations
718 20736 Files accessed for I/O operations
719 1392 Files for non-I/O operations
722 Additional non-I/O files created as necessary
725 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
726 Mon Apr 11 14:31:05 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
727 Mon Apr 11 14:31:05 2011 Completed.
728 Mon Apr 11 14:31:05 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
730 ************************************************************************
731 Mon Apr 11 14:31:06 2011 Received.
732 Mon Apr 11 14:31:06 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
733 Mon Apr 11 14:31:06 2011 Completed.
734 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 400 -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 16 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export
735 NFS V3 Protocol Version
737 ************************************************************************
738 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
739 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
741 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
742 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
744 SFS NFS V3 Benchmark Client Logfile, Mon Apr 11 14:31:08 2011
745 Client hostname = c09-44
746 Prime Client hostname = c09-44.sysnet.ucsd.edu
748 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
750 Mon Apr 11 14:31:08 2011 Mounting 16 remote test directories.
751 Child[000]: NFS negotiated block size 32768
752 Child[001]: NFS negotiated block size 32768
753 Child[002]: NFS negotiated block size 32768
754 Child[003]: NFS negotiated block size 32768
755 Child[004]: NFS negotiated block size 32768
756 Child[005]: NFS negotiated block size 32768
757 Child[006]: NFS negotiated block size 32768
758 Child[007]: NFS negotiated block size 32768
759 Child[008]: NFS negotiated block size 32768
760 Child[009]: NFS negotiated block size 32768
761 Child[010]: NFS negotiated block size 32768
762 Child[011]: NFS negotiated block size 32768
763 Child[012]: NFS negotiated block size 32768
764 Child[013]: NFS negotiated block size 32768
765 Child[014]: NFS negotiated block size 32768
766 Child[015]: NFS negotiated block size 32768
767 Mon Apr 11 14:31:22 2011 Completed.
768 Mon Apr 11 14:31:22 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
769 Mon Apr 11 14:31:22 2011 Completed.
770 Mon Apr 11 14:31:22 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
771 Mon Apr 11 14:31:24 2011 Received.
773 Mon Apr 11 14:31:24 2011 Initializing test directories.
774 Mon Apr 11 14:31:24 2011 Child 12 will create 190 directories.
775 Mon Apr 11 14:31:24 2011 Child 9 will create 190 directories.
776 Mon Apr 11 14:31:24 2011 Child 0 will create 190 directories.
777 Mon Apr 11 14:31:24 2011 Child 14 will create 190 directories.
778 Mon Apr 11 14:31:24 2011 Child 11 will create 190 directories.
779 Mon Apr 11 14:31:24 2011 Child 2 will create 190 directories.
780 Mon Apr 11 14:31:24 2011 Child 15 will create 190 directories.
781 Mon Apr 11 14:31:24 2011 Child 1 will create 190 directories.
782 Mon Apr 11 14:31:24 2011 Child 4 will create 190 directories.
783 Mon Apr 11 14:31:24 2011 Child 13 will create 190 directories.
784 Mon Apr 11 14:31:24 2011 Child 3 will create 190 directories.
785 Mon Apr 11 14:31:24 2011 Child 5 will create 190 directories.
786 Mon Apr 11 14:31:24 2011 Child 8 will create 190 directories.
787 Mon Apr 11 14:31:24 2011 Child 6 will create 190 directories.
788 Mon Apr 11 14:31:24 2011 Child 10 will create 190 directories.
789 Mon Apr 11 14:31:24 2011 Child 7 will create 190 directories.
790 Mon Apr 11 14:31:25 2011 Child 2 finished creating 190 directories.
791 Mon Apr 11 14:31:25 2011 Child 2 will create 5793 files.
792 Mon Apr 11 14:31:26 2011 Child 15 finished creating 190 directories.
793 Mon Apr 11 14:31:26 2011 Child 15 will create 5793 files.
794 Mon Apr 11 14:31:26 2011 Child 6 finished creating 190 directories.
795 Mon Apr 11 14:31:26 2011 Child 6 will create 5793 files.
796 Mon Apr 11 14:31:28 2011 Child 10 finished creating 190 directories.
797 Mon Apr 11 14:31:28 2011 Child 10 will create 5793 files.
798 Mon Apr 11 14:31:29 2011 Child 7 finished creating 190 directories.
799 Mon Apr 11 14:31:29 2011 Child 7 will create 5793 files.
800 Mon Apr 11 14:31:30 2011 Child 0 finished creating 190 directories.
801 Mon Apr 11 14:31:30 2011 Child 0 will create 5793 files.
802 Mon Apr 11 14:31:30 2011 Child 8 finished creating 190 directories.
803 Mon Apr 11 14:31:30 2011 Child 8 will create 5793 files.
804 Mon Apr 11 14:31:30 2011 Child 13 finished creating 190 directories.
805 Mon Apr 11 14:31:30 2011 Child 13 will create 5793 files.
806 Mon Apr 11 14:31:36 2011 Child 14 finished creating 190 directories.
807 Mon Apr 11 14:31:36 2011 Child 14 will create 5793 files.
808 Mon Apr 11 14:31:36 2011 Child 12 finished creating 190 directories.
809 Mon Apr 11 14:31:36 2011 Child 12 will create 5793 files.
810 Mon Apr 11 14:31:36 2011 Child 4 finished creating 190 directories.
811 Mon Apr 11 14:31:36 2011 Child 4 will create 5793 files.
812 Mon Apr 11 14:31:37 2011 Child 5 finished creating 190 directories.
813 Mon Apr 11 14:31:37 2011 Child 5 will create 5793 files.
814 Mon Apr 11 14:31:38 2011 Child 9 finished creating 190 directories.
815 Mon Apr 11 14:31:38 2011 Child 9 will create 5793 files.
816 Mon Apr 11 14:31:38 2011 Child 11 finished creating 190 directories.
817 Mon Apr 11 14:31:38 2011 Child 11 will create 5793 files.
818 Mon Apr 11 14:31:39 2011 Child 3 finished creating 190 directories.
819 Mon Apr 11 14:31:39 2011 Child 3 will create 5793 files.
820 Mon Apr 11 14:31:40 2011 Child 1 finished creating 190 directories.
821 Mon Apr 11 14:31:40 2011 Child 1 will create 5793 files.
822 Mon Apr 11 14:36:45 2011 Child 7 verified 4887 files (566 creates).
823 Mon Apr 11 14:36:46 2011 Child 14 verified 4654 files (333 creates).
824 Mon Apr 11 14:36:46 2011 Child 2 verified 5070 files (749 creates).
825 Mon Apr 11 14:36:46 2011 Child 12 verified 4608 files (287 creates).
826 Mon Apr 11 14:36:46 2011 Child 8 verified 4806 files (485 creates).
827 Mon Apr 11 14:36:46 2011 Child 0 verified 4886 files (565 creates).
828 Mon Apr 11 14:36:46 2011 Child 15 verified 4991 files (670 creates).
829 Mon Apr 11 14:36:46 2011 Child 13 verified 4854 files (533 creates).
830 Mon Apr 11 14:36:46 2011 Child 5 verified 4608 files (287 creates).
831 Mon Apr 11 14:36:46 2011 Child 10 verified 4896 files (575 creates).
832 Mon Apr 11 14:36:46 2011 Child 6 verified 4991 files (670 creates).
833 Mon Apr 11 14:37:22 2011 Child 3 verified 4571 files (250 creates).
834 Mon Apr 11 14:37:22 2011 Child 11 verified 4608 files (287 creates).
835 Mon Apr 11 14:37:22 2011 Child 4 verified 4571 files (250 creates).
836 Mon Apr 11 14:37:22 2011 Child 9 verified 4571 files (250 creates).
837 Mon Apr 11 14:37:22 2011 Child 1 verified 4608 files (287 creates).
838 Mon Apr 11 14:39:30 2011 Child 2 verified 5793 files, created 1416
839 Mon Apr 11 14:39:30 2011 Child 2 will create 2 symlinks.
840 Mon Apr 11 14:39:32 2011 Child 2 finished creating 2 symlinks.
841 Mon Apr 11 14:41:32 2011 Child 15 verified 5793 files, created 1416
842 Mon Apr 11 14:41:32 2011 Child 15 will create 2 symlinks.
843 Mon Apr 11 14:41:33 2011 Child 7 verified 5793 files, created 1416
844 Mon Apr 11 14:41:33 2011 Child 7 will create 2 symlinks.
845 Mon Apr 11 14:41:33 2011 Child 7 finished creating 2 symlinks.
846 Mon Apr 11 14:41:33 2011 Child 6 verified 5793 files, created 1416
847 Mon Apr 11 14:41:33 2011 Child 6 will create 2 symlinks.
848 Mon Apr 11 14:41:34 2011 Child 6 finished creating 2 symlinks.
849 Mon Apr 11 14:41:34 2011 Child 15 finished creating 2 symlinks.
850 Mon Apr 11 14:41:44 2011 Child 14 verified 5276 files (955 creates).
851 Mon Apr 11 14:41:45 2011 Child 12 verified 5224 files (903 creates).
852 Mon Apr 11 14:41:46 2011 Child 8 verified 5559 files (1238 creates).
853 Mon Apr 11 14:41:47 2011 Child 13 verified 5585 files (1264 creates).
854 Mon Apr 11 14:41:47 2011 Child 5 verified 4909 files (588 creates).
855 Mon Apr 11 14:41:48 2011 Child 0 verified 5793 files, created 1416
856 Mon Apr 11 14:41:48 2011 Child 0 will create 2 symlinks.
857 Mon Apr 11 14:41:48 2011 Child 0 finished creating 2 symlinks.
858 Mon Apr 11 14:42:00 2011 Child 10 verified 5793 files, created 1416
859 Mon Apr 11 14:42:00 2011 Child 10 will create 2 symlinks.
860 Mon Apr 11 14:42:00 2011 Child 10 finished creating 2 symlinks.
861 Mon Apr 11 14:42:09 2011 Child 13 verified 5793 files, created 1416
862 Mon Apr 11 14:42:09 2011 Child 13 will create 2 symlinks.
863 Mon Apr 11 14:42:09 2011 Child 13 finished creating 2 symlinks.
864 Mon Apr 11 14:42:12 2011 Child 8 verified 5793 files, created 1416
865 Mon Apr 11 14:42:12 2011 Child 8 will create 2 symlinks.
866 Mon Apr 11 14:42:13 2011 Child 8 finished creating 2 symlinks.
867 Mon Apr 11 14:42:19 2011 Child 14 verified 5793 files, created 1416
868 Mon Apr 11 14:42:19 2011 Child 14 will create 2 symlinks.
869 Mon Apr 11 14:42:19 2011 Child 14 finished creating 2 symlinks.
870 Mon Apr 11 14:42:20 2011 Child 3 verified 5360 files (1039 creates).
871 Mon Apr 11 14:42:26 2011 Child 9 verified 5275 files (954 creates).
872 Mon Apr 11 14:42:26 2011 Child 11 verified 5362 files (1041 creates).
873 Mon Apr 11 14:42:26 2011 Child 1 verified 5362 files (1041 creates).
874 Mon Apr 11 14:42:26 2011 Child 4 verified 5642 files (1321 creates).
875 Mon Apr 11 14:42:28 2011 Child 4 verified 5793 files, created 1416
876 Mon Apr 11 14:42:28 2011 Child 4 will create 2 symlinks.
877 Mon Apr 11 14:42:28 2011 Child 4 finished creating 2 symlinks.
878 Mon Apr 11 14:42:28 2011 Child 12 verified 5793 files, created 1416
879 Mon Apr 11 14:42:28 2011 Child 12 will create 2 symlinks.
880 Mon Apr 11 14:42:28 2011 Child 12 finished creating 2 symlinks.
881 Mon Apr 11 14:42:40 2011 Child 3 verified 5793 files, created 1416
882 Mon Apr 11 14:42:40 2011 Child 3 will create 2 symlinks.
883 Mon Apr 11 14:42:40 2011 Child 1 verified 5793 files, created 1416
884 Mon Apr 11 14:42:40 2011 Child 1 will create 2 symlinks.
885 Mon Apr 11 14:42:40 2011 Child 1 finished creating 2 symlinks.
886 Mon Apr 11 14:42:40 2011 Child 3 finished creating 2 symlinks.
887 Mon Apr 11 14:42:40 2011 Child 11 verified 5793 files, created 1416
888 Mon Apr 11 14:42:40 2011 Child 11 will create 2 symlinks.
889 Mon Apr 11 14:42:40 2011 Child 11 finished creating 2 symlinks.
890 Mon Apr 11 14:42:42 2011 Child 9 verified 5793 files, created 1416
891 Mon Apr 11 14:42:42 2011 Child 9 will create 2 symlinks.
892 Mon Apr 11 14:42:42 2011 Child 9 finished creating 2 symlinks.
893 Mon Apr 11 14:42:42 2011 Child 5 verified 5793 files, created 1416
894 Mon Apr 11 14:42:42 2011 Child 5 will create 2 symlinks.
895 Mon Apr 11 14:42:43 2011 Child 5 finished creating 2 symlinks.
896 Mon Apr 11 14:42:43 2011 Completed.
897 Mon Apr 11 14:42:43 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
898 Mon Apr 11 14:42:43 2011 Completed.
899 Mon Apr 11 14:42:43 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
900 Mon Apr 11 14:42:43 2011 Received.
901 Mon Apr 11 14:42:43 2011 Performing 300 seconds pretest warmup.
902 Mon Apr 11 14:47:43 2011 Completed.
903 Mon Apr 11 14:47:43 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
904 Mon Apr 11 14:47:43 2011 Completed.
905 Mon Apr 11 14:47:43 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
906 Mon Apr 11 14:47:44 2011 Received.
907 Mon Apr 11 14:47:44 2011 Starting 300 seconds test run.
908 SFS Single Client (c09-44) Results, Mon Apr 11 14:52:54 2011
909 --------------------------------------------------------------------------------------
910 NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt
911 Op Logical Logical Logical Physical Op Response Response of Mean, of
912 Type Mix Mix Success Success Error Time Time 95% Conf Total
913 Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time
914 --------------------------------------------------------------------------------------
915 getattr 26.0% 25.9% 31143 31143 0 0.21 1.28 0.01 2.4%
916 setattr 4.0% 4.0% 4780 4780 0 2.54 6.36 0.07 4.6%
917 lookup 24.0% 23.9% 28644 28644 0 0.22 1.40 0.01 2.3%
918 readlink 1.0% 1.0% 1226 1226 0 0.20 0.08 0.02 0.1%
919 read 18.0% 18.2% 21816 26838 0 4.65 32.88 0.08 38.3%
920 write 10.0% 10.1% 12117 14882 0 8.18 24.56 0.09 37.5%
921 create 1.0% 1.0% 1174 1174 0 5.40 7.05 0.15 2.4%
922 remove 1.0% 1.0% 1211 1211 0 4.10 6.29 0.14 1.9%
923 readdir 1.0% 1.0% 1179 1179 0 0.40 0.06 0.01 0.2%
924 fsstat 1.0% 1.0% 1255 1255 0 0.19 0.04 0.01 0.1%
925 access 11.0% 10.9% 13148 13148 0 0.22 1.90 0.02 1.1%
926 commit 0.0% 0.0% 0 5331 0 0.00 0.00 0.00 8.5%
927 readdirplus 2.0% 2.0% 2392 2392 0 0.70 0.08 0.01 0.6%
928 --------------------------------------------------------------------------------------
930 --------------------------------------------------
931 | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY |
932 --------------------------+-----------------------
933 SFS NFS V3 THROUGHPUT: 400.28 Ops/Sec AVG. RESPONSE TIME: 2.20 Msec/Op
936 NFS V3 MIXFILE: [ SFS Default ]
937 CLIENT REQUESTED LOAD: 400 Ops/Sec
938 TOTAL LOGICAL NFS V3 OPERATIONS: 120085 TEST TIME: 300 Sec
939 TOTAL PHYSICAL NFS V3 OPERATIONS: 133203
940 PHYSICAL NFS V3 THROUGHPUT: 444.01 Ops/Sec
941 FILE SET SIZE CREATED: 48248784.0 KB
942 FILE SET SIZE ACCESSED: 14477184.0 - 14764625.0 KB (100.00% to 101.99% of Base)
944 ------------------------------------------------------------------------
946 Mon Apr 11 14:52:54 2011 Completed.
948 Client Test Parameters:
949 Number of processes = 16
950 Requested Load (NFS V3 operations/second) = 400
951 Maximum number of outstanding biod writes = 8
952 Maximum number of outstanding biod reads = 8
953 Warm-up time (seconds) = 300
954 Run time (seconds) = 300
955 File Set = 90864 Files created for I/O operations
956 27248 Files accessed for I/O operations
957 1824 Files for non-I/O operations
960 Additional non-I/O files created as necessary
963 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
964 Mon Apr 11 14:52:54 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
965 Mon Apr 11 14:52:54 2011 Completed.
966 Mon Apr 11 14:52:54 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
968 ************************************************************************
969 Mon Apr 11 14:52:55 2011 Received.
970 Mon Apr 11 14:52:55 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
971 Mon Apr 11 14:52:55 2011 Completed.
972 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 500 -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 16 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export
973 NFS V3 Protocol Version
975 ************************************************************************
976 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
977 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
979 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
980 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
982 SFS NFS V3 Benchmark Client Logfile, Mon Apr 11 14:52:57 2011
983 Client hostname = c09-44
984 Prime Client hostname = c09-44.sysnet.ucsd.edu
986 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
988 Mon Apr 11 14:52:57 2011 Mounting 16 remote test directories.
989 Child[000]: NFS negotiated block size 32768
990 Child[001]: NFS negotiated block size 32768
991 Child[002]: NFS negotiated block size 32768
992 Child[003]: NFS negotiated block size 32768
993 Child[004]: NFS negotiated block size 32768
994 Child[005]: NFS negotiated block size 32768
995 Child[006]: NFS negotiated block size 32768
996 Child[007]: NFS negotiated block size 32768
997 Child[008]: NFS negotiated block size 32768
998 Child[009]: NFS negotiated block size 32768
999 Child[010]: NFS negotiated block size 32768
1000 Child[011]: NFS negotiated block size 32768
1001 Child[012]: NFS negotiated block size 32768
1002 Child[013]: NFS negotiated block size 32768
1003 Child[014]: NFS negotiated block size 32768
1004 Child[015]: NFS negotiated block size 32768
1005 Mon Apr 11 14:53:11 2011 Completed.
1006 Mon Apr 11 14:53:11 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1007 Mon Apr 11 14:53:11 2011 Completed.
1008 Mon Apr 11 14:53:11 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1009 Mon Apr 11 14:53:13 2011 Received.
1011 Mon Apr 11 14:53:13 2011 Initializing test directories.
1012 Mon Apr 11 14:53:13 2011 Child 11 will create 239 directories.
1013 Mon Apr 11 14:53:13 2011 Child 15 will create 239 directories.
1014 Mon Apr 11 14:53:13 2011 Child 0 will create 239 directories.
1015 Mon Apr 11 14:53:13 2011 Child 12 will create 239 directories.
1016 Mon Apr 11 14:53:13 2011 Child 14 will create 239 directories.
1017 Mon Apr 11 14:53:13 2011 Child 3 will create 239 directories.
1018 Mon Apr 11 14:53:13 2011 Child 2 will create 239 directories.
1019 Mon Apr 11 14:53:13 2011 Child 13 will create 239 directories.
1020 Mon Apr 11 14:53:13 2011 Child 4 will create 239 directories.
1021 Mon Apr 11 14:53:13 2011 Child 1 will create 239 directories.
1022 Mon Apr 11 14:53:13 2011 Child 10 will create 239 directories.
1023 Mon Apr 11 14:53:13 2011 Child 6 will create 239 directories.
1024 Mon Apr 11 14:53:13 2011 Child 5 will create 239 directories.
1025 Mon Apr 11 14:53:13 2011 Child 9 will create 239 directories.
1026 Mon Apr 11 14:53:13 2011 Child 7 will create 239 directories.
1027 Mon Apr 11 14:53:13 2011 Child 8 will create 239 directories.
1028 Mon Apr 11 14:53:15 2011 Child 2 finished creating 239 directories.
1029 Mon Apr 11 14:53:15 2011 Child 2 will create 7304 files.
1030 Mon Apr 11 14:53:15 2011 Child 3 finished creating 239 directories.
1031 Mon Apr 11 14:53:15 2011 Child 3 will create 7304 files.
1032 Mon Apr 11 14:53:15 2011 Child 6 finished creating 239 directories.
1033 Mon Apr 11 14:53:15 2011 Child 6 will create 7304 files.
1034 Mon Apr 11 14:53:19 2011 Child 10 finished creating 239 directories.
1035 Mon Apr 11 14:53:19 2011 Child 10 will create 7304 files.
1036 Mon Apr 11 14:53:19 2011 Child 12 finished creating 239 directories.
1037 Mon Apr 11 14:53:19 2011 Child 12 will create 7304 files.
1038 Mon Apr 11 14:53:22 2011 Child 15 finished creating 239 directories.
1039 Mon Apr 11 14:53:22 2011 Child 15 will create 7304 files.
1040 Mon Apr 11 14:53:22 2011 Child 9 finished creating 239 directories.
1041 Mon Apr 11 14:53:22 2011 Child 9 will create 7304 files.
1042 Mon Apr 11 14:53:25 2011 Child 0 finished creating 239 directories.
1043 Mon Apr 11 14:53:25 2011 Child 0 will create 7304 files.
1044 Mon Apr 11 14:53:25 2011 Child 11 finished creating 239 directories.
1045 Mon Apr 11 14:53:25 2011 Child 11 will create 7304 files.
1046 Mon Apr 11 14:53:25 2011 Child 4 finished creating 239 directories.
1047 Mon Apr 11 14:53:25 2011 Child 4 will create 7304 files.
1048 Mon Apr 11 14:53:26 2011 Child 1 finished creating 239 directories.
1049 Mon Apr 11 14:53:26 2011 Child 1 will create 7304 files.
1050 Mon Apr 11 14:53:29 2011 Child 7 finished creating 239 directories.
1051 Mon Apr 11 14:53:29 2011 Child 7 will create 7304 files.
1052 Mon Apr 11 14:53:29 2011 Child 13 finished creating 239 directories.
1053 Mon Apr 11 14:53:29 2011 Child 13 will create 7304 files.
1054 Mon Apr 11 14:53:30 2011 Child 5 finished creating 239 directories.
1055 Mon Apr 11 14:53:30 2011 Child 5 will create 7304 files.
1056 Mon Apr 11 14:53:32 2011 Child 14 finished creating 239 directories.
1057 Mon Apr 11 14:53:32 2011 Child 14 will create 7304 files.
1058 Mon Apr 11 14:53:35 2011 Child 8 finished creating 239 directories.
1059 Mon Apr 11 14:53:35 2011 Child 8 will create 7304 files.
1060 Mon Apr 11 14:58:38 2011 Child 15 verified 6246 files (567 creates).
1061 Mon Apr 11 14:58:38 2011 Child 0 verified 6251 files (572 creates).
1062 Mon Apr 11 14:58:39 2011 Child 6 verified 6510 files (831 creates).
1063 Mon Apr 11 14:58:50 2011 Child 12 verified 6353 files (674 creates).
1064 Mon Apr 11 14:58:50 2011 Child 2 verified 6547 files (868 creates).
1065 Mon Apr 11 14:58:50 2011 Child 14 verified 5981 files (302 creates).
1066 Mon Apr 11 14:58:50 2011 Child 5 verified 6092 files (413 creates).
1067 Mon Apr 11 14:58:50 2011 Child 9 verified 6353 files (674 creates).
1068 Mon Apr 11 14:59:14 2011 Child 10 verified 6353 files (674 creates).
1069 Mon Apr 11 14:59:14 2011 Child 11 verified 6092 files (413 creates).
1070 Mon Apr 11 14:59:14 2011 Child 1 verified 6092 files (413 creates).
1071 Mon Apr 11 14:59:14 2011 Child 13 verified 6092 files (413 creates).
1072 Mon Apr 11 14:59:25 2011 Child 7 verified 6092 files (413 creates).
1073 Mon Apr 11 14:59:25 2011 Child 4 verified 6092 files (413 creates).
1074 Mon Apr 11 14:59:25 2011 Child 8 verified 6092 files (413 creates).
1075 Mon Apr 11 14:59:44 2011 Child 3 verified 6543 files (864 creates).
1076 Mon Apr 11 15:03:39 2011 Child 0 verified 6696 files (1017 creates).
1077 Mon Apr 11 15:03:40 2011 Child 15 verified 6769 files (1090 creates).
1078 Mon Apr 11 15:03:42 2011 Child 6 verified 7110 files (1431 creates).
1079 Mon Apr 11 15:03:48 2011 Child 2 verified 7304 files, created 1554
1080 Mon Apr 11 15:03:48 2011 Child 2 will create 2 symlinks.
1081 Mon Apr 11 15:03:48 2011 Child 2 finished creating 2 symlinks.
1082 Mon Apr 11 15:03:49 2011 Child 6 verified 7304 files, created 1554
1083 Mon Apr 11 15:03:49 2011 Child 6 will create 2 symlinks.
1084 Mon Apr 11 15:03:49 2011 Child 6 finished creating 2 symlinks.
1085 Mon Apr 11 15:03:52 2011 Child 12 verified 6883 files (1204 creates).
1086 Mon Apr 11 15:03:52 2011 Child 9 verified 6884 files (1205 creates).
1087 Mon Apr 11 15:03:52 2011 Child 5 verified 6734 files (1055 creates).
1088 Mon Apr 11 15:03:52 2011 Child 14 verified 6678 files (999 creates).
1089 Mon Apr 11 15:04:18 2011 Child 10 verified 7036 files (1357 creates).
1090 Mon Apr 11 15:04:18 2011 Child 11 verified 6809 files (1130 creates).
1091 Mon Apr 11 15:04:18 2011 Child 13 verified 6901 files (1222 creates).
1092 Mon Apr 11 15:04:18 2011 Child 1 verified 6850 files (1171 creates).
1093 Mon Apr 11 15:04:26 2011 Child 4 verified 6770 files (1091 creates).
1094 Mon Apr 11 15:04:26 2011 Child 7 verified 6880 files (1201 creates).
1095 Mon Apr 11 15:04:26 2011 Child 8 verified 6868 files (1189 creates).
1096 Mon Apr 11 15:04:28 2011 Child 3 verified 7304 files, created 1554
1097 Mon Apr 11 15:04:28 2011 Child 3 will create 2 symlinks.
1098 Mon Apr 11 15:04:28 2011 Child 3 finished creating 2 symlinks.
1099 Mon Apr 11 15:04:38 2011 Child 9 verified 7304 files, created 1554
1100 Mon Apr 11 15:04:38 2011 Child 9 will create 2 symlinks.
1101 Mon Apr 11 15:04:38 2011 Child 9 finished creating 2 symlinks.
1102 Mon Apr 11 15:04:38 2011 Child 12 verified 7304 files, created 1554
1103 Mon Apr 11 15:04:38 2011 Child 12 will create 2 symlinks.
1104 Mon Apr 11 15:04:39 2011 Child 12 finished creating 2 symlinks.
1105 Mon Apr 11 15:04:41 2011 Child 15 verified 7304 files, created 1554
1106 Mon Apr 11 15:04:41 2011 Child 15 will create 2 symlinks.
1107 Mon Apr 11 15:04:41 2011 Child 15 finished creating 2 symlinks.
1108 Mon Apr 11 15:04:43 2011 Child 10 verified 7304 files, created 1554
1109 Mon Apr 11 15:04:43 2011 Child 10 will create 2 symlinks.
1110 Mon Apr 11 15:04:43 2011 Child 10 finished creating 2 symlinks.
1111 Mon Apr 11 15:04:49 2011 Child 0 verified 7304 files, created 1554
1112 Mon Apr 11 15:04:49 2011 Child 0 will create 2 symlinks.
1113 Mon Apr 11 15:04:49 2011 Child 0 finished creating 2 symlinks.
1114 Mon Apr 11 15:04:54 2011 Child 5 verified 7304 files, created 1554
1115 Mon Apr 11 15:04:54 2011 Child 5 will create 2 symlinks.
1116 Mon Apr 11 15:04:54 2011 Child 5 finished creating 2 symlinks.
1117 Mon Apr 11 15:05:02 2011 Child 13 verified 7304 files, created 1554
1118 Mon Apr 11 15:05:02 2011 Child 13 will create 2 symlinks.
1119 Mon Apr 11 15:05:04 2011 Child 13 finished creating 2 symlinks.
1120 Mon Apr 11 15:05:06 2011 Child 14 verified 7304 files, created 1554
1121 Mon Apr 11 15:05:06 2011 Child 14 will create 2 symlinks.
1122 Mon Apr 11 15:05:06 2011 Child 14 finished creating 2 symlinks.
1123 Mon Apr 11 15:05:07 2011 Child 1 verified 7304 files, created 1554
1124 Mon Apr 11 15:05:07 2011 Child 1 will create 2 symlinks.
1125 Mon Apr 11 15:05:07 2011 Child 7 verified 7304 files, created 1554
1126 Mon Apr 11 15:05:07 2011 Child 7 will create 2 symlinks.
1127 Mon Apr 11 15:05:07 2011 Child 1 finished creating 2 symlinks.
1128 Mon Apr 11 15:05:07 2011 Child 7 finished creating 2 symlinks.
1129 Mon Apr 11 15:05:07 2011 Child 8 verified 7304 files, created 1554
1130 Mon Apr 11 15:05:07 2011 Child 8 will create 2 symlinks.
1131 Mon Apr 11 15:05:07 2011 Child 8 finished creating 2 symlinks.
1132 Mon Apr 11 15:05:07 2011 Child 11 verified 7304 files, created 1554
1133 Mon Apr 11 15:05:07 2011 Child 11 will create 2 symlinks.
1134 Mon Apr 11 15:05:07 2011 Child 11 finished creating 2 symlinks.
1135 Mon Apr 11 15:05:07 2011 Child 4 verified 7304 files, created 1554
1136 Mon Apr 11 15:05:07 2011 Child 4 will create 2 symlinks.
1137 Mon Apr 11 15:05:07 2011 Child 4 finished creating 2 symlinks.
1138 Mon Apr 11 15:05:07 2011 Completed.
1139 Mon Apr 11 15:05:07 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1140 Mon Apr 11 15:05:07 2011 Completed.
1141 Mon Apr 11 15:05:07 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1142 Mon Apr 11 15:05:07 2011 Received.
1143 Mon Apr 11 15:05:07 2011 Performing 300 seconds pretest warmup.
1144 Mon Apr 11 15:10:07 2011 Completed.
1145 Mon Apr 11 15:10:07 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1146 Mon Apr 11 15:10:07 2011 Completed.
1147 Mon Apr 11 15:10:07 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1148 Mon Apr 11 15:10:08 2011 Received.
1149 Mon Apr 11 15:10:08 2011 Starting 300 seconds test run.
1150 SFS Single Client (c09-44) Results, Mon Apr 11 15:15:18 2011
1151 --------------------------------------------------------------------------------------
1152 NFS V3 Target Actual NFS Op NFS Op NFS Mean Std Dev Std Error Pcnt
1153 Op Logical Logical Logical Physical Op Response Response of Mean, of
1154 Type Mix Mix Success Success Error Time Time 95% Conf Total
1155 Pcnt Pcnt Count Count Count Msec/Op Msec/Op +-Msec/Op Time
1156 --------------------------------------------------------------------------------------
1157 getattr 26.0% 26.0% 39100 39100 0 0.24 7.87 0.03 1.5%
1158 setattr 4.0% 4.0% 5949 5949 0 11.94 120.51 0.28 11.1%
1159 lookup 24.0% 23.8% 35799 35799 0 0.24 6.20 0.03 1.4%
1160 readlink 1.0% 1.0% 1479 1479 0 0.20 0.12 0.02 0.0%
1161 read 18.0% 18.1% 27284 33651 0 7.85 64.45 0.10 33.5%
1162 write 10.0% 10.1% 15135 18361 0 11.83 54.05 0.12 28.0%
1163 create 1.0% 1.0% 1521 1521 0 14.24 112.01 0.53 3.4%
1164 remove 1.0% 1.0% 1478 1478 0 15.64 135.21 0.59 3.6%
1165 readdir 1.0% 1.0% 1516 1516 0 0.42 0.13 0.02 0.1%
1166 fsstat 1.0% 1.0% 1485 1485 0 0.21 0.28 0.03 0.0%
1167 access 11.0% 11.0% 16529 16529 0 0.20 0.09 0.00 0.5%
1168 commit 0.0% 0.0% 0 6650 0 0.00 0.00 0.00 16.6%
1169 readdirplus 2.0% 2.0% 3056 3056 0 0.73 0.54 0.03 0.3%
1170 --------------------------------------------------------------------------------------
1172 --------------------------------------------------
1173 | SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY |
1174 --------------------------+-----------------------
1175 SFS NFS V3 THROUGHPUT: 502.77 Ops/Sec AVG. RESPONSE TIME: 4.25 Msec/Op
1178 NFS V3 MIXFILE: [ SFS Default ]
1179 CLIENT REQUESTED LOAD: 500 Ops/Sec
1180 TOTAL LOGICAL NFS V3 OPERATIONS: 150331 TEST TIME: 299 Sec
1181 TOTAL PHYSICAL NFS V3 OPERATIONS: 166574
1182 PHYSICAL NFS V3 THROUGHPUT: 557.10 Ops/Sec
1183 FILE SET SIZE CREATED: 60831360.0 KB
1184 FILE SET SIZE ACCESSED: 18257904.0 - 18612316.0 KB (100.00% to 101.94% of Base)
1186 ------------------------------------------------------------------------
1188 Mon Apr 11 15:15:18 2011 Completed.
1190 Client Test Parameters:
1191 Number of processes = 16
1192 Requested Load (NFS V3 operations/second) = 500
1193 Maximum number of outstanding biod writes = 8
1194 Maximum number of outstanding biod reads = 8
1195 Warm-up time (seconds) = 300
1196 Run time (seconds) = 300
1197 File Set = 114560 Files created for I/O operations
1198 34368 Files accessed for I/O operations
1199 2304 Files for non-I/O operations
1202 Additional non-I/O files created as necessary
1205 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1206 Mon Apr 11 15:15:18 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1207 Mon Apr 11 15:15:18 2011 Completed.
1208 Mon Apr 11 15:15:18 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1210 ************************************************************************
1211 Mon Apr 11 15:15:19 2011 Received.
1212 Mon Apr 11 15:15:19 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1213 Mon Apr 11 15:15:19 2011 Completed.
1214 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 600 -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 16 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export vrable2.sysnet.ucsd.edu:/export
1215 NFS V3 Protocol Version
1217 ************************************************************************
1218 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1219 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1221 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1222 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1224 SFS NFS V3 Benchmark Client Logfile, Mon Apr 11 15:15:21 2011
1225 Client hostname = c09-44
1226 Prime Client hostname = c09-44.sysnet.ucsd.edu
1228 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1230 Mon Apr 11 15:15:21 2011 Mounting 16 remote test directories.
1231 Child[000]: NFS negotiated block size 32768
1232 Child[001]: NFS negotiated block size 32768
1233 Child[002]: NFS negotiated block size 32768
1234 Child[003]: NFS negotiated block size 32768
1235 Child[004]: NFS negotiated block size 32768
1236 Child[005]: NFS negotiated block size 32768
1237 Child[006]: NFS negotiated block size 32768
1238 Child[007]: NFS negotiated block size 32768
1239 Child[008]: NFS negotiated block size 32768
1240 Child[009]: NFS negotiated block size 32768
1241 Child[010]: NFS negotiated block size 32768
1242 Child[011]: NFS negotiated block size 32768
1243 Child[012]: NFS negotiated block size 32768
1244 Child[013]: NFS negotiated block size 32768
1245 Child[014]: NFS negotiated block size 32768
1246 Child[015]: NFS negotiated block size 32768
1247 Mon Apr 11 15:15:35 2011 Completed.
1248 Mon Apr 11 15:15:35 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1249 Mon Apr 11 15:15:35 2011 Completed.
1250 Mon Apr 11 15:15:35 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1251 Mon Apr 11 15:15:37 2011 Received.
1253 Mon Apr 11 15:15:37 2011 Initializing test directories.
1254 Mon Apr 11 15:15:37 2011 Child 4 will create 289 directories.
1255 Mon Apr 11 15:15:37 2011 Child 15 will create 289 directories.
1256 Mon Apr 11 15:15:37 2011 Child 12 will create 289 directories.
1257 Mon Apr 11 15:15:37 2011 Child 0 will create 289 directories.
1258 Mon Apr 11 15:15:37 2011 Child 11 will create 289 directories.
1259 Mon Apr 11 15:15:37 2011 Child 6 will create 289 directories.
1260 Mon Apr 11 15:15:37 2011 Child 9 will create 289 directories.
1261 Mon Apr 11 15:15:37 2011 Child 2 will create 289 directories.
1262 Mon Apr 11 15:15:37 2011 Child 1 will create 289 directories.
1263 Mon Apr 11 15:15:37 2011 Child 8 will create 289 directories.
1264 Mon Apr 11 15:15:37 2011 Child 3 will create 289 directories.
1265 Mon Apr 11 15:15:37 2011 Child 14 will create 289 directories.
1266 Mon Apr 11 15:15:37 2011 Child 7 will create 289 directories.
1267 Mon Apr 11 15:15:37 2011 Child 5 will create 289 directories.
1268 Mon Apr 11 15:15:37 2011 Child 10 will create 289 directories.
1269 Mon Apr 11 15:15:37 2011 Child 13 will create 289 directories.
1270 Mon Apr 11 15:15:41 2011 Child 2 finished creating 289 directories.
1271 Mon Apr 11 15:15:41 2011 Child 2 will create 8814 files.
1272 Mon Apr 11 15:15:43 2011 Child 13 finished creating 289 directories.
1273 Mon Apr 11 15:15:43 2011 Child 13 will create 8814 files.
1274 Mon Apr 11 15:15:44 2011 Child 3 finished creating 289 directories.
1275 Mon Apr 11 15:15:44 2011 Child 3 will create 8814 files.
1276 Mon Apr 11 15:15:45 2011 Child 9 finished creating 289 directories.
1277 Mon Apr 11 15:15:45 2011 Child 9 will create 8814 files.
1278 Mon Apr 11 15:15:49 2011 Child 5 finished creating 289 directories.
1279 Mon Apr 11 15:15:49 2011 Child 5 will create 8814 files.
1280 Mon Apr 11 15:15:51 2011 Child 14 finished creating 289 directories.
1281 Mon Apr 11 15:15:51 2011 Child 14 will create 8814 files.
1282 Mon Apr 11 15:15:51 2011 Child 10 finished creating 289 directories.
1283 Mon Apr 11 15:15:51 2011 Child 10 will create 8814 files.
1284 Mon Apr 11 15:15:54 2011 Child 15 finished creating 289 directories.
1285 Mon Apr 11 15:15:54 2011 Child 15 will create 8814 files.
1286 Mon Apr 11 15:15:54 2011 Child 8 finished creating 289 directories.
1287 Mon Apr 11 15:15:54 2011 Child 8 will create 8814 files.
1288 Mon Apr 11 15:15:57 2011 Child 1 finished creating 289 directories.
1289 Mon Apr 11 15:15:57 2011 Child 1 will create 8814 files.
1290 Mon Apr 11 15:15:58 2011 Child 12 finished creating 289 directories.
1291 Mon Apr 11 15:15:58 2011 Child 12 will create 8814 files.
1292 Mon Apr 11 15:15:58 2011 Child 4 finished creating 289 directories.
1293 Mon Apr 11 15:15:58 2011 Child 4 will create 8814 files.
1294 Mon Apr 11 15:15:58 2011 Child 7 finished creating 289 directories.
1295 Mon Apr 11 15:15:58 2011 Child 7 will create 8814 files.
1296 Mon Apr 11 15:16:02 2011 Child 6 finished creating 289 directories.
1297 Mon Apr 11 15:16:02 2011 Child 6 will create 8814 files.
1298 Mon Apr 11 15:16:02 2011 Child 0 finished creating 289 directories.
1299 Mon Apr 11 15:16:02 2011 Child 0 will create 8814 files.
1300 Mon Apr 11 15:16:02 2011 Child 11 finished creating 289 directories.
1301 Mon Apr 11 15:16:02 2011 Child 11 will create 8814 files.
1302 Mon Apr 11 15:21:13 2011 Child 1 verified 7754 files (594 creates).
1303 Mon Apr 11 15:21:13 2011 Child 15 verified 7756 files (596 creates).
1304 Mon Apr 11 15:21:13 2011 Child 5 verified 8147 files (987 creates).
1305 Mon Apr 11 15:21:13 2011 Child 8 verified 7783 files (623 creates).
1306 Mon Apr 11 15:21:18 2011 Child 12 verified 7538 files (378 creates).
1307 Mon Apr 11 15:21:18 2011 Child 0 verified 7728 files (568 creates).
1308 Mon Apr 11 15:21:18 2011 Child 7 verified 7538 files (378 creates).
1309 Mon Apr 11 15:21:18 2011 Child 10 verified 8026 files (866 creates).
1310 Mon Apr 11 15:21:18 2011 Child 4 verified 7563 files (403 creates).
1311 Mon Apr 11 15:21:18 2011 Child 6 verified 7609 files (449 creates).
1312 Mon Apr 11 15:21:18 2011 Child 13 verified 8286 files (1126 creates).
1313 Mon Apr 11 15:21:18 2011 Child 11 verified 7563 files (403 creates).
1314 Mon Apr 11 15:21:18 2011 Child 9 verified 8205 files (1045 creates).
1315 Mon Apr 11 15:21:18 2011 Child 2 verified 8526 files (1366 creates).
1316 Mon Apr 11 15:21:18 2011 Child 3 verified 8205 files (1045 creates).
1317 Mon Apr 11 15:21:18 2011 Child 14 verified 7877 files (717 creates).
1318 Mon Apr 11 15:22:27 2011 Child 2 verified 8814 files, created 1568
1319 Mon Apr 11 15:22:27 2011 Child 2 will create 2 symlinks.
1320 Mon Apr 11 15:22:27 2011 Child 2 finished creating 2 symlinks.
1321 Mon Apr 11 15:23:08 2011 Child 13 verified 8814 files, created 1568
1322 Mon Apr 11 15:23:08 2011 Child 13 will create 2 symlinks.
1323 Mon Apr 11 15:23:08 2011 Child 13 finished creating 2 symlinks.
1324 Mon Apr 11 15:24:01 2011 Child 5 verified 8814 files, created 1568
1325 Mon Apr 11 15:24:01 2011 Child 5 will create 2 symlinks.
1326 Mon Apr 11 15:24:01 2011 Child 5 finished creating 2 symlinks.
1327 Mon Apr 11 15:24:01 2011 Child 9 verified 8814 files, created 1568
1328 Mon Apr 11 15:24:01 2011 Child 9 will create 2 symlinks.
1329 Mon Apr 11 15:24:01 2011 Child 9 finished creating 2 symlinks.
1330 Mon Apr 11 15:24:23 2011 Child 3 verified 8814 files, created 1568
1331 Mon Apr 11 15:24:23 2011 Child 3 will create 2 symlinks.
1332 Mon Apr 11 15:24:23 2011 Child 3 finished creating 2 symlinks.
1333 Mon Apr 11 15:25:31 2011 Child 10 verified 8814 files, created 1568
1334 Mon Apr 11 15:25:31 2011 Child 10 will create 2 symlinks.
1335 Mon Apr 11 15:25:31 2011 Child 10 finished creating 2 symlinks.
1336 Mon Apr 11 15:26:14 2011 Child 15 verified 8544 files (1384 creates).
1337 Mon Apr 11 15:26:14 2011 Child 1 verified 8550 files (1390 creates).
1338 Mon Apr 11 15:26:15 2011 Child 14 verified 8814 files, created 1568
1339 Mon Apr 11 15:26:15 2011 Child 14 will create 2 symlinks.
1340 Mon Apr 11 15:26:17 2011 Child 8 verified 8613 files (1453 creates).
1341 Mon Apr 11 15:26:17 2011 Child 7 verified 8357 files (1197 creates).
1342 Mon Apr 11 15:26:17 2011 Child 0 verified 8574 files (1414 creates).
1343 Mon Apr 11 15:26:17 2011 Child 6 verified 8458 files (1298 creates).
1344 Mon Apr 11 15:26:17 2011 Child 12 verified 8357 files (1197 creates).
1345 Mon Apr 11 15:26:17 2011 Child 4 verified 8575 files (1415 creates).
1346 Mon Apr 11 15:26:18 2011 Child 11 verified 8503 files (1343 creates).
1347 Mon Apr 11 15:26:22 2011 Child 14 finished creating 2 symlinks.
1348 Mon Apr 11 15:26:26 2011 Child 8 verified 8814 files, created 1568
1349 Mon Apr 11 15:26:26 2011 Child 8 will create 2 symlinks.
1350 Mon Apr 11 15:26:26 2011 Child 8 finished creating 2 symlinks.
1351 Mon Apr 11 15:26:34 2011 Child 4 verified 8814 files, created 1568
1352 Mon Apr 11 15:26:34 2011 Child 4 will create 2 symlinks.
1353 Mon Apr 11 15:26:34 2011 Child 1 verified 8814 files, created 1568
1354 Mon Apr 11 15:26:34 2011 Child 1 will create 2 symlinks.
1355 Mon Apr 11 15:26:34 2011 Child 0 verified 8814 files, created 1568
1356 Mon Apr 11 15:26:34 2011 Child 0 will create 2 symlinks.
1357 Mon Apr 11 15:26:34 2011 Child 1 finished creating 2 symlinks.
1358 Mon Apr 11 15:26:34 2011 Child 0 finished creating 2 symlinks.
1359 Mon Apr 11 15:26:34 2011 Child 4 finished creating 2 symlinks.
1360 Mon Apr 11 15:26:34 2011 Child 15 verified 8814 files, created 1568
1361 Mon Apr 11 15:26:34 2011 Child 15 will create 2 symlinks.
1362 Mon Apr 11 15:26:35 2011 Child 15 finished creating 2 symlinks.
1363 Mon Apr 11 15:26:42 2011 Child 6 verified 8814 files, created 1568
1364 Mon Apr 11 15:26:42 2011 Child 6 will create 2 symlinks.
1365 Mon Apr 11 15:26:42 2011 Child 11 verified 8814 files, created 1568
1366 Mon Apr 11 15:26:42 2011 Child 11 will create 2 symlinks.
1367 Mon Apr 11 15:26:42 2011 Child 6 finished creating 2 symlinks.
1368 Mon Apr 11 15:26:42 2011 Child 11 finished creating 2 symlinks.
1369 Mon Apr 11 15:26:42 2011 Child 12 verified 8814 files, created 1568
1370 Mon Apr 11 15:26:42 2011 Child 12 will create 2 symlinks.
1371 Mon Apr 11 15:26:42 2011 Child 12 finished creating 2 symlinks.
1372 Mon Apr 11 15:26:44 2011 Child 7 verified 8814 files, created 1568
1373 Mon Apr 11 15:26:44 2011 Child 7 will create 2 symlinks.
1374 Mon Apr 11 15:26:44 2011 Child 7 finished creating 2 symlinks.
1375 Mon Apr 11 15:26:45 2011 Completed.
1376 Mon Apr 11 15:26:45 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1377 Mon Apr 11 15:26:45 2011 Completed.
1378 Mon Apr 11 15:26:45 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1379 Mon Apr 11 15:26:46 2011 Received.
1380 Mon Apr 11 15:26:46 2011 Performing 300 seconds pretest warmup.
1381 Mon Apr 11 15:31:46 2011 Completed.
1382 Mon Apr 11 15:31:46 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1383 Mon Apr 11 15:31:46 2011 Completed.
1384 Mon Apr 11 15:31:46 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1385 Mon Apr 11 15:31:47 2011 Received.
1386 Mon Apr 11 15:31:47 2011 Starting 300 seconds test run.
1387 Child 15: 0 calls during measurement interval
1388 Child 15: probably unstable, try fewer, or more processes.
1389 Child 15: 0 calls during measurement interval
1390 Child 15: probably unstable, try fewer, or more processes.
1391 Child 15: 0 calls during measurement interval
1392 Child 15: probably unstable, try fewer, or more processes.
1393 Strike 3. You're out. Exit(188)
1394 sfsnfs315: sending Pid 0 Signal 2
1395 sfsnfs3: caught unexpected SIGCHLD.
1396 A child (PID: 9366) has abnormally exited with status of 65
1397 Tell Prime to stop the benchmark.
1398 Terminating all child processes.
1399 sfsnfs3: sending Pid 0 Signal 2
projects / bluesky.git / blob