results/20110311/sfsc001.20110315-native-hi8

   1 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 8 -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
   2 NFS V3 Protocol Version
   3
   4 ************************************************************************
   5 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
   6 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
   7
   8 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
   9 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
  10
  11 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 08:26:06 2011
  12         Client hostname = c09-44
  13         Prime Client hostname = c09-44.sysnet.ucsd.edu
  14
  15 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
  16 NFS V3 Protocol
  17 Tue Mar 15 08:26:06 2011 Mounting 8 remote test directories.
  18 Child[003]: NFS negotiated block size 32768
  19 Child[004]: NFS negotiated block size 32768
  20 Child[006]: NFS negotiated block size 32768
  21 Child[007]: NFS negotiated block size 32768
  22 Child[000]: NFS negotiated block size 32768
  23 Child[001]: NFS negotiated block size 32768
  24 Child[002]: NFS negotiated block size 32768
  25 Child[005]: NFS negotiated block size 32768
  26 Tue Mar 15 08:26:23 2011 Completed.
  27 Tue Mar 15 08:26:23 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
  28 Tue Mar 15 08:26:23 2011 Completed.
  29 Tue Mar 15 08:26:23 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
  30 Tue Mar 15 08:26:23 2011 Received.
  31
  32 Tue Mar 15 08:26:23 2011 Initializing test directories.
  33 Tue Mar 15 08:26:23 2011 Child 5 will create 190 directories.
  34 Tue Mar 15 08:26:23 2011 Child 7 will create 190 directories.
  35 Tue Mar 15 08:26:23 2011 Child 3 will create 190 directories.
  36 Tue Mar 15 08:26:23 2011 Child 1 will create 190 directories.
  37 Tue Mar 15 08:26:23 2011 Child 4 will create 190 directories.
  38 Tue Mar 15 08:26:23 2011 Child 6 will create 190 directories.
  39 Tue Mar 15 08:26:23 2011 Child 2 will create 190 directories.
  40 Tue Mar 15 08:26:23 2011 Child 0 will create 190 directories.
  41 Tue Mar 15 08:26:24 2011 Child 7 finished creating 190 directories.
  42 Tue Mar 15 08:26:24 2011 Child 7 will create 5793 files.
  43 Tue Mar 15 08:26:24 2011 Child 2 finished creating 190 directories.
  44 Tue Mar 15 08:26:24 2011 Child 2 will create 5793 files.
  45 Tue Mar 15 08:26:24 2011 Child 1 finished creating 190 directories.
  46 Tue Mar 15 08:26:24 2011 Child 1 will create 5793 files.
  47 Tue Mar 15 08:26:24 2011 Child 4 finished creating 190 directories.
  48 Tue Mar 15 08:26:24 2011 Child 4 will create 5793 files.
  49 Tue Mar 15 08:26:25 2011 Child 5 finished creating 190 directories.
  50 Tue Mar 15 08:26:25 2011 Child 5 will create 5793 files.
  51 Tue Mar 15 08:26:25 2011 Child 0 finished creating 190 directories.
  52 Tue Mar 15 08:26:25 2011 Child 0 will create 5793 files.
  53 Tue Mar 15 08:26:25 2011 Child 6 finished creating 190 directories.
  54 Tue Mar 15 08:26:25 2011 Child 6 will create 5793 files.
  55 Tue Mar 15 08:26:25 2011 Child 3 finished creating 190 directories.
  56 Tue Mar 15 08:26:25 2011 Child 3 will create 5793 files.
  57 Tue Mar 15 08:31:27 2011 Child 1 verified 2501 files (2501 creates).
  58 Tue Mar 15 08:31:27 2011 Child 7 verified 2487 files (2487 creates).
  59 Tue Mar 15 08:31:27 2011 Child 4 verified 2501 files (2501 creates).
  60 Tue Mar 15 08:31:27 2011 Child 5 verified 2432 files (2432 creates).
  61 Tue Mar 15 08:31:28 2011 Child 2 verified 2468 files (2468 creates).
  62 Tue Mar 15 08:31:28 2011 Child 0 verified 2470 files (2470 creates).
  63 Tue Mar 15 08:31:28 2011 Child 3 verified 2393 files (2393 creates).
  64 Tue Mar 15 08:31:29 2011 Child 6 verified 2471 files (2471 creates).
  65 Tue Mar 15 08:36:27 2011 Child 1 verified 4644 files (4644 creates).
  66 Tue Mar 15 08:36:27 2011 Child 7 verified 4702 files (4702 creates).
  67 Tue Mar 15 08:36:27 2011 Child 4 verified 4630 files (4630 creates).
  68 Tue Mar 15 08:36:29 2011 Child 0 verified 4571 files (4571 creates).
  69 Tue Mar 15 08:36:29 2011 Child 2 verified 4636 files (4636 creates).
  70 Tue Mar 15 08:36:29 2011 Child 6 verified 4642 files (4642 creates).
  71 Tue Mar 15 08:36:29 2011 Child 5 verified 4636 files (4636 creates).
  72 Tue Mar 15 08:36:29 2011 Child 3 verified 4571 files (4571 creates).
  73 Tue Mar 15 08:38:16 2011 Child 7 verified 5793 files, created 5737
  74 Tue Mar 15 08:38:16 2011 Child 7 will create 3 symlinks.
  75 Tue Mar 15 08:38:16 2011 Child 7 finished creating 3 symlinks.
  76 Tue Mar 15 08:38:16 2011 Child 2 verified 5793 files, created 5737
  77 Tue Mar 15 08:38:16 2011 Child 2 will create 3 symlinks.
  78 Tue Mar 15 08:38:16 2011 Child 2 finished creating 3 symlinks.
  79 Tue Mar 15 08:38:17 2011 Child 1 verified 5793 files, created 5737
  80 Tue Mar 15 08:38:17 2011 Child 1 will create 3 symlinks.
  81 Tue Mar 15 08:38:17 2011 Child 1 finished creating 3 symlinks.
  82 Tue Mar 15 08:38:17 2011 Child 5 verified 5793 files, created 5737
  83 Tue Mar 15 08:38:17 2011 Child 5 will create 3 symlinks.
  84 Tue Mar 15 08:38:17 2011 Child 5 finished creating 3 symlinks.
  85 Tue Mar 15 08:38:17 2011 Child 4 verified 5793 files, created 5737
  86 Tue Mar 15 08:38:17 2011 Child 4 will create 3 symlinks.
  87 Tue Mar 15 08:38:17 2011 Child 4 finished creating 3 symlinks.
  88 Tue Mar 15 08:38:17 2011 Child 6 verified 5793 files, created 5737
  89 Tue Mar 15 08:38:17 2011 Child 6 will create 3 symlinks.
  90 Tue Mar 15 08:38:17 2011 Child 6 finished creating 3 symlinks.
  91 Tue Mar 15 08:38:19 2011 Child 0 verified 5793 files, created 5737
  92 Tue Mar 15 08:38:19 2011 Child 0 will create 3 symlinks.
  93 Tue Mar 15 08:38:19 2011 Child 0 finished creating 3 symlinks.
  94 Tue Mar 15 08:38:19 2011 Child 3 verified 5793 files, created 5737
  95 Tue Mar 15 08:38:19 2011 Child 3 will create 3 symlinks.
  96 Tue Mar 15 08:38:19 2011 Child 3 finished creating 3 symlinks.
  97 Tue Mar 15 08:38:19 2011 Completed.
  98 Tue Mar 15 08:38:19 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
  99 Tue Mar 15 08:38:19 2011 Completed.
 100 Tue Mar 15 08:38:19 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
 101 Tue Mar 15 08:38:19 2011 Received.
 102 Tue Mar 15 08:38:19 2011 Performing 300 seconds pretest warmup.
 103 Tue Mar 15 08:43:19 2011 Completed.
 104 Tue Mar 15 08:43:19 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
 105 Tue Mar 15 08:43:19 2011 Completed.
 106 Tue Mar 15 08:43:19 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
 107 Tue Mar 15 08:43:20 2011 Received.
 108 Tue Mar 15 08:43:20 2011 Starting 300 seconds test run.
 109 SFS Single Client (c09-44) Results, Tue Mar 15 08:48:30 2011
 110 --------------------------------------------------------------------------------------
 111 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
 112 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
 113 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
 114            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 115 --------------------------------------------------------------------------------------
 116 getattr     26.0%    26.3%    15858    15858      0      1.83    38.76      0.10  6.2%
 117 setattr      4.0%     4.0%     2382     2382      0     45.37   220.14      0.60 23.1%
 118 lookup      24.0%    24.1%    14555    14555      0      1.97    37.65      0.10  6.1%
 119 readlink     1.0%     1.0%      585      585      0      0.79     8.80      0.24  0.1%
 120 read        18.0%    17.7%    10667    13112      0      7.46    51.01      0.14 17.0%
 121 write       10.0%    10.1%     6085     7354      0      7.67    61.16      0.20 10.0%
 122 create       1.0%     1.0%      615      615      0     62.71   278.79      1.32  8.3%
 123 remove       1.0%     1.0%      605      605      0     44.79   234.70      1.22  5.8%
 124 readdir      1.0%     1.0%      593      593      0      2.48    28.24      0.43  0.3%
 125 fsstat       1.0%     1.0%      606      606      0      0.26     1.67      0.10  0.0%
 126 access      11.0%    10.8%     6489     6489      0      1.79    40.60      0.16  2.5%
 127 commit       0.0%     0.0%        0     2687      0      0.00     0.00      0.00 19.4%
 128 readdirplus  2.0%     2.1%     1256     1256      0      4.25    55.31      0.41  1.1%
 129 --------------------------------------------------------------------------------------
 130
 131       --------------------------------------------------
 132       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
 133       --------------------------+-----------------------
 134 SFS NFS V3 THROUGHPUT:  201.65 Ops/Sec   AVG. RESPONSE TIME:    7.74 Msec/Op
 135 TCP PROTOCOL
 136 FAST CALLS: 0
 137 NFS V3 MIXFILE: [ SFS Default ]
 138 CLIENT REQUESTED LOAD: 200 Ops/Sec
 139 TOTAL LOGICAL NFS V3 OPERATIONS:  60296          TEST TIME: 299 Sec
 140 TOTAL PHYSICAL NFS V3 OPERATIONS: 66697
 141 PHYSICAL NFS V3 THROUGHPUT:  223.06 Ops/Sec
 142 FILE SET SIZE CREATED: 24124392.0 KB
 143 FILE SET SIZE ACCESSED: 7238592.0 - 7383151.0 KB  (100.00% to 102.00% of Base)
 144
 145 ------------------------------------------------------------------------
 146
 147 Tue Mar 15 08:48:30 2011 Completed.
 148
 149 Client Test Parameters:
 150         Number of processes = 8
 151         Requested Load (NFS V3 operations/second) = 200
 152         Maximum number of outstanding biod writes = 8
 153         Maximum number of outstanding biod reads = 8
 154         Warm-up time (seconds) = 300
 155         Run time (seconds) = 300
 156         File Set = 45432 Files created for I/O operations
 157                    13624 Files accessed for I/O operations
 158                     912 Files for non-I/O operations
 159                      24 Symlinks
 160                    1512 Directories
 161                         Additional non-I/O files created as necessary
 162
 163
 164 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
 165 Tue Mar 15 08:48:30 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
 166 Tue Mar 15 08:48:30 2011 Completed.
 167 Tue Mar 15 08:48:30 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
 168
 169 ************************************************************************
 170 Tue Mar 15 08:48:31 2011 Received.
 171 Tue Mar 15 08:48:31 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
 172 Tue Mar 15 08:48:31 2011 Completed.
 173 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 8 -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
 174 NFS V3 Protocol Version
 175 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
 176 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
 177
 178 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
 179 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 180
 181 ************************************************************************
 182
 183 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 08:48:33 2011
 184         Client hostname = c09-44
 185         Prime Client hostname = c09-44.sysnet.ucsd.edu
 186
 187 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 188 NFS V3 Protocol
 189 Tue Mar 15 08:48:33 2011 Mounting 8 remote test directories.
 190 Child[000]: NFS negotiated block size 32768
 191 Child[001]: NFS negotiated block size 32768
 192 Child[002]: NFS negotiated block size 32768
 193 Child[003]: NFS negotiated block size 32768
 194 Child[004]: NFS negotiated block size 32768
 195 Child[005]: NFS negotiated block size 32768
 196 Child[006]: NFS negotiated block size 32768
 197 Child[007]: NFS negotiated block size 32768
 198 Tue Mar 15 08:48:45 2011 Completed.
 199 Tue Mar 15 08:48:45 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
 200 Tue Mar 15 08:48:45 2011 Completed.
 201 Tue Mar 15 08:48:45 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
 202 Tue Mar 15 08:48:49 2011 Received.
 203
 204 Tue Mar 15 08:48:49 2011 Initializing test directories.
 205 Tue Mar 15 08:48:49 2011 Child 5 will create 379 directories.
 206 Tue Mar 15 08:48:49 2011 Child 7 will create 379 directories.
 207 Tue Mar 15 08:48:49 2011 Child 2 will create 379 directories.
 208 Tue Mar 15 08:48:49 2011 Child 4 will create 379 directories.
 209 Tue Mar 15 08:48:49 2011 Child 0 will create 379 directories.
 210 Tue Mar 15 08:48:49 2011 Child 3 will create 379 directories.
 211 Tue Mar 15 08:48:49 2011 Child 1 will create 379 directories.
 212 Tue Mar 15 08:48:49 2011 Child 6 will create 379 directories.
 213 Tue Mar 15 08:48:52 2011 Child 1 finished creating 379 directories.
 214 Tue Mar 15 08:48:52 2011 Child 1 will create 11585 files.
 215 Tue Mar 15 08:48:54 2011 Child 4 finished creating 379 directories.
 216 Tue Mar 15 08:48:54 2011 Child 4 will create 11585 files.
 217 Tue Mar 15 08:48:57 2011 Child 7 finished creating 379 directories.
 218 Tue Mar 15 08:48:57 2011 Child 7 will create 11585 files.
 219 Tue Mar 15 08:48:57 2011 Child 0 finished creating 379 directories.
 220 Tue Mar 15 08:48:57 2011 Child 0 will create 11585 files.
 221 Tue Mar 15 08:49:05 2011 Child 2 finished creating 379 directories.
 222 Tue Mar 15 08:49:05 2011 Child 2 will create 11585 files.
 223 Tue Mar 15 08:49:07 2011 Child 5 finished creating 379 directories.
 224 Tue Mar 15 08:49:07 2011 Child 5 will create 11585 files.
 225 Tue Mar 15 08:49:36 2011 Child 3 finished creating 379 directories.
 226 Tue Mar 15 08:49:36 2011 Child 3 will create 11585 files.
 227 Tue Mar 15 08:49:37 2011 Child 6 finished creating 379 directories.
 228 Tue Mar 15 08:49:37 2011 Child 6 will create 11585 files.
 229 Tue Mar 15 08:53:53 2011 Child 1 verified 7947 files (2268 creates).
 230 Tue Mar 15 08:53:55 2011 Child 4 verified 7779 files (2100 creates).
 231 Tue Mar 15 08:53:58 2011 Child 7 verified 7745 files (2066 creates).
 232 Tue Mar 15 08:53:58 2011 Child 0 verified 7728 files (2049 creates).
 233 Tue Mar 15 08:54:06 2011 Child 2 verified 7597 files (1918 creates).
 234 Tue Mar 15 08:54:08 2011 Child 5 verified 7600 files (1921 creates).
 235 Tue Mar 15 08:54:37 2011 Child 3 verified 7748 files (2069 creates).
 236 Tue Mar 15 08:54:39 2011 Child 6 verified 7700 files (2021 creates).
 237 Tue Mar 15 08:58:54 2011 Child 1 verified 10294 files (4615 creates).
 238 Tue Mar 15 08:58:56 2011 Child 4 verified 10116 files (4437 creates).
 239 Tue Mar 15 08:59:01 2011 Child 7 verified 10126 files (4447 creates).
 240 Tue Mar 15 08:59:01 2011 Child 0 verified 10111 files (4432 creates).
 241 Tue Mar 15 08:59:08 2011 Child 2 verified 9939 files (4260 creates).
 242 Tue Mar 15 08:59:09 2011 Child 5 verified 9930 files (4251 creates).
 243 Tue Mar 15 08:59:38 2011 Child 3 verified 9991 files (4312 creates).
 244 Tue Mar 15 08:59:40 2011 Child 6 verified 10000 files (4321 creates).
 245 Tue Mar 15 09:01:20 2011 Child 1 verified 11585 files, created 5793
 246 Tue Mar 15 09:01:20 2011 Child 1 will create 3 symlinks.
 247 Tue Mar 15 09:01:21 2011 Child 1 finished creating 3 symlinks.
 248 Tue Mar 15 09:01:37 2011 Child 4 verified 11585 files, created 5793
 249 Tue Mar 15 09:01:37 2011 Child 4 will create 3 symlinks.
 250 Tue Mar 15 09:01:37 2011 Child 4 finished creating 3 symlinks.
 251 Tue Mar 15 09:01:40 2011 Child 0 verified 11585 files, created 5793
 252 Tue Mar 15 09:01:40 2011 Child 0 will create 3 symlinks.
 253 Tue Mar 15 09:01:40 2011 Child 0 finished creating 3 symlinks.
 254 Tue Mar 15 09:01:40 2011 Child 7 verified 11585 files, created 5793
 255 Tue Mar 15 09:01:40 2011 Child 7 will create 3 symlinks.
 256 Tue Mar 15 09:01:41 2011 Child 7 finished creating 3 symlinks.
 257 Tue Mar 15 09:01:53 2011 Child 2 verified 11585 files, created 5793
 258 Tue Mar 15 09:01:53 2011 Child 2 will create 3 symlinks.
 259 Tue Mar 15 09:01:53 2011 Child 2 finished creating 3 symlinks.
 260 Tue Mar 15 09:01:53 2011 Child 5 verified 11585 files, created 5793
 261 Tue Mar 15 09:01:53 2011 Child 5 will create 3 symlinks.
 262 Tue Mar 15 09:01:53 2011 Child 5 finished creating 3 symlinks.
 263 Tue Mar 15 09:01:56 2011 Child 3 verified 11585 files, created 5793
 264 Tue Mar 15 09:01:56 2011 Child 3 will create 3 symlinks.
 265 Tue Mar 15 09:01:56 2011 Child 3 finished creating 3 symlinks.
 266 Tue Mar 15 09:01:56 2011 Child 6 verified 11585 files, created 5793
 267 Tue Mar 15 09:01:56 2011 Child 6 will create 3 symlinks.
 268 Tue Mar 15 09:01:56 2011 Child 6 finished creating 3 symlinks.
 269 Tue Mar 15 09:01:56 2011 Completed.
 270 Tue Mar 15 09:01:56 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
 271 Tue Mar 15 09:01:56 2011 Completed.
 272 Tue Mar 15 09:01:56 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
 273 Tue Mar 15 09:01:56 2011 Received.
 274 Tue Mar 15 09:01:56 2011 Performing 300 seconds pretest warmup.
 275 Tue Mar 15 09:06:56 2011 Completed.
 276 Tue Mar 15 09:06:56 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
 277 Tue Mar 15 09:06:56 2011 Completed.
 278 Tue Mar 15 09:06:56 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
 279 Tue Mar 15 09:06:57 2011 Received.
 280 Tue Mar 15 09:06:57 2011 Starting 300 seconds test run.
 281 SFS Single Client (c09-44) Results, Tue Mar 15 09:12:09 2011
 282 --------------------------------------------------------------------------------------
 283 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
 284 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
 285 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
 286            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 287 --------------------------------------------------------------------------------------
 288 getattr     26.0%    26.1%    26389    26389      0      2.98    30.78      0.07  3.1%
 289 setattr      4.0%     3.9%     3940     3940      0    187.72   309.97      0.55 28.8%
 290 lookup      24.0%    23.6%    23845    23845      0      3.08    34.89      0.07  2.9%
 291 readlink     1.0%     1.0%     1003     1003      0      2.45    14.57      0.24  0.1%
 292 read        18.0%    18.2%    18348    22574      0     24.55    59.59      0.11 17.6%
 293 write       10.0%    10.1%    10174    12281      0     20.28    63.82      0.16  8.0%
 294 create       1.0%     1.0%     1005     1005      0    342.37   451.29      1.31 13.4%
 295 remove       1.0%     1.0%      990      990      0    190.67   323.24      1.12  7.4%
 296 readdir      1.0%     1.0%      992      992      0      5.54    40.61      0.40  0.2%
 297 fsstat       1.0%     1.0%      976      976      0      2.42    12.27      0.22  0.1%
 298 access      11.0%    11.2%    11285    11285      0      3.14    33.16      0.11  1.4%
 299 commit       0.0%     0.0%        0     4095      0      0.00     0.00      0.00 16.5%
 300 readdirplus  2.0%     2.0%     1991     1991      0      6.50    39.63      0.28  0.5%
 301 --------------------------------------------------------------------------------------
 302
 303       --------------------------------------------------
 304       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
 305       --------------------------+-----------------------
 306 SFS NFS V3 THROUGHPUT:  335.34 Ops/Sec   AVG. RESPONSE TIME:   25.39 Msec/Op
 307 TCP PROTOCOL
 308 FAST CALLS: 0
 309 NFS V3 MIXFILE: [ SFS Default ]
 310 CLIENT REQUESTED LOAD: 400 Ops/Sec
 311 TOTAL LOGICAL NFS V3 OPERATIONS:  100938         TEST TIME: 301 Sec
 312 TOTAL PHYSICAL NFS V3 OPERATIONS: 111366
 313 PHYSICAL NFS V3 THROUGHPUT:  369.98 Ops/Sec
 314 FILE SET SIZE CREATED: 48244536.0 KB
 315 FILE SET SIZE ACCESSED: 14477184.0 - 14679550.0 KB  (100.00% to 101.40% of Base)
 316
 317 ------------------------------------------------------------------------
 318
 319 Tue Mar 15 09:12:09 2011 Completed.
 320
 321 Client Test Parameters:
 322         Number of processes = 8
 323         Requested Load (NFS V3 operations/second) = 400
 324         Maximum number of outstanding biod writes = 8
 325         Maximum number of outstanding biod reads = 8
 326         Warm-up time (seconds) = 300
 327         Run time (seconds) = 300
 328         File Set = 90856 Files created for I/O operations
 329                    27256 Files accessed for I/O operations
 330                    1824 Files for non-I/O operations
 331                      24 Symlinks
 332                    3024 Directories
 333                         Additional non-I/O files created as necessary
 334
 335
 336 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
 337 Tue Mar 15 09:12:09 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
 338 Tue Mar 15 09:12:09 2011 Completed.
 339 Tue Mar 15 09:12:09 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
 340
 341 ************************************************************************
 342 Tue Mar 15 09:12:09 2011 Received.
 343 Tue Mar 15 09:12:09 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
 344 Tue Mar 15 09:12:09 2011 Completed.
 345 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 8 -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
 346 NFS V3 Protocol Version
 347
 348 ************************************************************************
 349 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
 350 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
 351
 352 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
 353 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 354
 355 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 09:12:11 2011
 356         Client hostname = c09-44
 357         Prime Client hostname = c09-44.sysnet.ucsd.edu
 358
 359 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 360 NFS V3 Protocol
 361 Tue Mar 15 09:12:11 2011 Mounting 8 remote test directories.
 362 Child[000]: NFS negotiated block size 32768
 363 Child[001]: NFS negotiated block size 32768
 364 Child[002]: NFS negotiated block size 32768
 365 Child[003]: NFS negotiated block size 32768
 366 Child[004]: NFS negotiated block size 32768
 367 Child[005]: NFS negotiated block size 32768
 368 Child[006]: NFS negotiated block size 32768
 369 Child[007]: NFS negotiated block size 32768
 370 Tue Mar 15 09:12:23 2011 Completed.
 371 Tue Mar 15 09:12:23 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
 372 Tue Mar 15 09:12:23 2011 Completed.
 373 Tue Mar 15 09:12:23 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
 374 Tue Mar 15 09:12:27 2011 Received.
 375
 376 Tue Mar 15 09:12:27 2011 Initializing test directories.
 377 Tue Mar 15 09:12:27 2011 Child 6 will create 577 directories.
 378 Tue Mar 15 09:12:27 2011 Child 1 will create 577 directories.
 379 Tue Mar 15 09:12:27 2011 Child 7 will create 577 directories.
 380 Tue Mar 15 09:12:27 2011 Child 4 will create 577 directories.
 381 Tue Mar 15 09:12:27 2011 Child 0 will create 577 directories.
 382 Tue Mar 15 09:12:27 2011 Child 2 will create 577 directories.
 383 Tue Mar 15 09:12:27 2011 Child 5 will create 577 directories.
 384 Tue Mar 15 09:12:27 2011 Child 3 will create 577 directories.
 385 Tue Mar 15 09:12:34 2011 Child 2 finished creating 577 directories.
 386 Tue Mar 15 09:12:34 2011 Child 2 will create 17628 files.
 387 Tue Mar 15 09:12:35 2011 Child 0 finished creating 577 directories.
 388 Tue Mar 15 09:12:35 2011 Child 0 will create 17628 files.
 389 Tue Mar 15 09:12:40 2011 Child 5 finished creating 577 directories.
 390 Tue Mar 15 09:12:40 2011 Child 5 will create 17628 files.
 391 Tue Mar 15 09:12:43 2011 Child 3 finished creating 577 directories.
 392 Tue Mar 15 09:12:43 2011 Child 3 will create 17628 files.
 393 Tue Mar 15 09:12:45 2011 Child 4 finished creating 577 directories.
 394 Tue Mar 15 09:12:45 2011 Child 4 will create 17628 files.
 395 Tue Mar 15 09:12:50 2011 Child 1 finished creating 577 directories.
 396 Tue Mar 15 09:12:50 2011 Child 1 will create 17628 files.
 397 Tue Mar 15 09:12:59 2011 Child 7 finished creating 577 directories.
 398 Tue Mar 15 09:12:59 2011 Child 7 will create 17628 files.
 399 Tue Mar 15 09:13:30 2011 Child 6 finished creating 577 directories.
 400 Tue Mar 15 09:13:30 2011 Child 6 will create 17628 files.
 401 Tue Mar 15 09:17:35 2011 Child 2 verified 13441 files (2084 creates).
 402 Tue Mar 15 09:17:39 2011 Child 0 verified 13362 files (2005 creates).
 403 Tue Mar 15 09:17:41 2011 Child 5 verified 13230 files (1873 creates).
 404 Tue Mar 15 09:17:44 2011 Child 3 verified 13109 files (1752 creates).
 405 Tue Mar 15 09:17:47 2011 Child 4 verified 13055 files (1698 creates).
 406 Tue Mar 15 09:17:51 2011 Child 1 verified 13082 files (1725 creates).
 407 Tue Mar 15 09:18:00 2011 Child 7 verified 13098 files (1741 creates).
 408 Tue Mar 15 09:18:32 2011 Child 6 verified 13044 files (1687 creates).
 409 Tue Mar 15 09:22:36 2011 Child 2 verified 15500 files (4143 creates).
 410 Tue Mar 15 09:22:40 2011 Child 0 verified 15442 files (4085 creates).
 411 Tue Mar 15 09:22:42 2011 Child 5 verified 15271 files (3914 creates).
 412 Tue Mar 15 09:22:46 2011 Child 3 verified 15181 files (3824 creates).
 413 Tue Mar 15 09:22:48 2011 Child 4 verified 15088 files (3731 creates).
 414 Tue Mar 15 09:22:52 2011 Child 1 verified 15110 files (3753 creates).
 415 Tue Mar 15 09:23:01 2011 Child 7 verified 15096 files (3739 creates).
 416 Tue Mar 15 09:23:34 2011 Child 6 verified 15088 files (3731 creates).
 417 Tue Mar 15 09:26:41 2011 Child 2 verified 17628 files, created 6099
 418 Tue Mar 15 09:26:41 2011 Child 2 will create 3 symlinks.
 419 Tue Mar 15 09:26:41 2011 Child 2 finished creating 3 symlinks.
 420 Tue Mar 15 09:26:49 2011 Child 0 verified 17628 files, created 6099
 421 Tue Mar 15 09:26:49 2011 Child 0 will create 3 symlinks.
 422 Tue Mar 15 09:26:49 2011 Child 0 finished creating 3 symlinks.
 423 Tue Mar 15 09:27:06 2011 Child 5 verified 17628 files, created 6099
 424 Tue Mar 15 09:27:06 2011 Child 5 will create 3 symlinks.
 425 Tue Mar 15 09:27:06 2011 Child 5 finished creating 3 symlinks.
 426 Tue Mar 15 09:27:14 2011 Child 3 verified 17628 files, created 6099
 427 Tue Mar 15 09:27:14 2011 Child 3 will create 3 symlinks.
 428 Tue Mar 15 09:27:14 2011 Child 3 finished creating 3 symlinks.
 429 Tue Mar 15 09:27:17 2011 Child 1 verified 17628 files, created 6099
 430 Tue Mar 15 09:27:17 2011 Child 1 will create 3 symlinks.
 431 Tue Mar 15 09:27:17 2011 Child 1 finished creating 3 symlinks.
 432 Tue Mar 15 09:27:17 2011 Child 4 verified 17628 files, created 6099
 433 Tue Mar 15 09:27:17 2011 Child 4 will create 3 symlinks.
 434 Tue Mar 15 09:27:17 2011 Child 4 finished creating 3 symlinks.
 435 Tue Mar 15 09:27:18 2011 Child 7 verified 17628 files, created 6099
 436 Tue Mar 15 09:27:18 2011 Child 7 will create 3 symlinks.
 437 Tue Mar 15 09:27:18 2011 Child 7 finished creating 3 symlinks.
 438 Tue Mar 15 09:27:22 2011 Child 6 verified 17628 files, created 6099
 439 Tue Mar 15 09:27:22 2011 Child 6 will create 3 symlinks.
 440 Tue Mar 15 09:27:22 2011 Child 6 finished creating 3 symlinks.
 441 Tue Mar 15 09:27:22 2011 Completed.
 442 Tue Mar 15 09:27:22 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
 443 Tue Mar 15 09:27:22 2011 Completed.
 444 Tue Mar 15 09:27:22 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
 445 Tue Mar 15 09:27:22 2011 Received.
 446 Tue Mar 15 09:27:22 2011 Performing 300 seconds pretest warmup.
 447 Tue Mar 15 09:32:22 2011 Completed.
 448 Tue Mar 15 09:32:22 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
 449 Tue Mar 15 09:32:22 2011 Completed.
 450 Tue Mar 15 09:32:22 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
 451 Tue Mar 15 09:32:23 2011 Received.
 452 Tue Mar 15 09:32:23 2011 Starting 300 seconds test run.
 453 SFS Single Client (c09-44) Results, Tue Mar 15 09:37:35 2011
 454 --------------------------------------------------------------------------------------
 455 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
 456 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
 457 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
 458            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 459 --------------------------------------------------------------------------------------
 460 getattr     26.0%    25.8%    20366    20366      0      3.55    30.75      0.08  2.8%
 461 setattr      4.0%     4.0%     3124     3124      0    224.96   346.11      0.65 27.4%
 462 lookup      24.0%    24.2%    19110    19110      0      3.61    33.45      0.08  2.7%
 463 readlink     1.0%     1.0%      817      817      0      2.63    10.16      0.22  0.1%
 464 read        18.0%    17.9%    14126    17310      0     36.46    64.54      0.13 20.1%
 465 write       10.0%    10.1%     7972     9657      0     31.17    88.91      0.21  9.7%
 466 create       1.0%     1.0%      823      823      0    433.01   485.93      1.51 13.9%
 467 remove       1.0%     1.0%      806      806      0    225.82   344.26      1.28  7.1%
 468 readdir      1.0%     1.0%      823      823      0      7.70    41.83      0.44  0.2%
 469 fsstat       1.0%     1.0%      789      789      0      2.86     8.96      0.21  0.1%
 470 access      11.0%    11.0%     8683     8683      0      3.44    27.25      0.11  1.2%
 471 commit       0.0%     0.0%        0     2925      0      0.00     0.00      0.00 14.0%
 472 readdirplus  2.0%     2.0%     1611     1611      0     10.53    72.02      0.41  0.7%
 473 --------------------------------------------------------------------------------------
 474
 475       --------------------------------------------------
 476       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
 477       --------------------------+-----------------------
 478 SFS NFS V3 THROUGHPUT:  263.50 Ops/Sec   AVG. RESPONSE TIME:   32.42 Msec/Op
 479 TCP PROTOCOL
 480 FAST CALLS: 0
 481 NFS V3 MIXFILE: [ SFS Default ]
 482 CLIENT REQUESTED LOAD: 600 Ops/Sec
 483 TOTAL LOGICAL NFS V3 OPERATIONS:  79050          TEST TIME: 300 Sec
 484 TOTAL PHYSICAL NFS V3 OPERATIONS: 86844
 485 PHYSICAL NFS V3 THROUGHPUT:  289.48 Ops/Sec
 486 FILE SET SIZE CREATED: 73413936.0 KB
 487 FILE SET SIZE ACCESSED: 22025880.0 - 22186792.0 KB  (100.00% to 100.73% of Base)
 488
 489 ------------------------------------------------------------------------
 490
 491 Tue Mar 15 09:37:35 2011 Completed.
 492
 493 Client Test Parameters:
 494         Number of processes = 8
 495         Requested Load (NFS V3 operations/second) = 600
 496         Maximum number of outstanding biod writes = 8
 497         Maximum number of outstanding biod reads = 8
 498         Warm-up time (seconds) = 300
 499         Run time (seconds) = 300
 500         File Set = 138256 Files created for I/O operations
 501                    41472 Files accessed for I/O operations
 502                    2768 Files for non-I/O operations
 503                      24 Symlinks
 504                    4608 Directories
 505                         Additional non-I/O files created as necessary
 506
 507
 508 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
 509 Tue Mar 15 09:37:35 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
 510 Tue Mar 15 09:37:35 2011 Completed.
 511 Tue Mar 15 09:37:35 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
 512
 513 ************************************************************************
 514 Tue Mar 15 09:37:35 2011 Received.
 515 Tue Mar 15 09:37:35 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
 516 Tue Mar 15 09:37:35 2011 Completed.
 517 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 800  -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 8 -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
 518 NFS V3 Protocol Version
 519
 520 ************************************************************************
 521 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
 522 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
 523
 524 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
 525 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 526
 527 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 09:37:37 2011
 528         Client hostname = c09-44
 529         Prime Client hostname = c09-44.sysnet.ucsd.edu
 530
 531 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 532 NFS V3 Protocol
 533 Tue Mar 15 09:37:37 2011 Mounting 8 remote test directories.
 534 Child[000]: NFS negotiated block size 32768
 535 Child[001]: NFS negotiated block size 32768
 536 Child[002]: NFS negotiated block size 32768
 537 Child[003]: NFS negotiated block size 32768
 538 Child[004]: NFS negotiated block size 32768
 539 Child[005]: NFS negotiated block size 32768
 540 Child[006]: NFS negotiated block size 32768
 541 Child[007]: NFS negotiated block size 32768
 542 Tue Mar 15 09:37:49 2011 Completed.
 543 Tue Mar 15 09:37:49 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
 544 Tue Mar 15 09:37:49 2011 Completed.
 545 Tue Mar 15 09:37:49 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
 546 Tue Mar 15 09:37:53 2011 Received.
 547
 548 Tue Mar 15 09:37:53 2011 Initializing test directories.
 549 Tue Mar 15 09:37:53 2011 Child 6 will create 766 directories.
 550 Tue Mar 15 09:37:53 2011 Child 7 will create 766 directories.
 551 Tue Mar 15 09:37:53 2011 Child 5 will create 766 directories.
 552 Tue Mar 15 09:37:53 2011 Child 0 will create 766 directories.
 553 Tue Mar 15 09:37:53 2011 Child 4 will create 766 directories.
 554 Tue Mar 15 09:37:53 2011 Child 3 will create 766 directories.
 555 Tue Mar 15 09:37:53 2011 Child 1 will create 766 directories.
 556 Tue Mar 15 09:37:53 2011 Child 2 will create 766 directories.
 557 Tue Mar 15 09:38:03 2011 Child 2 finished creating 766 directories.
 558 Tue Mar 15 09:38:03 2011 Child 2 will create 23420 files.
 559 Tue Mar 15 09:38:08 2011 Child 0 finished creating 766 directories.
 560 Tue Mar 15 09:38:08 2011 Child 0 will create 23420 files.
 561 Tue Mar 15 09:38:16 2011 Child 1 finished creating 766 directories.
 562 Tue Mar 15 09:38:16 2011 Child 1 will create 23420 files.
 563 Tue Mar 15 09:38:33 2011 Child 3 finished creating 766 directories.
 564 Tue Mar 15 09:38:33 2011 Child 3 will create 23420 files.
 565 Tue Mar 15 09:38:46 2011 Child 5 finished creating 766 directories.
 566 Tue Mar 15 09:38:46 2011 Child 5 will create 23420 files.
 567 Tue Mar 15 09:38:50 2011 Child 7 finished creating 766 directories.
 568 Tue Mar 15 09:38:50 2011 Child 7 will create 23420 files.
 569 Tue Mar 15 09:38:53 2011 Child 4 finished creating 766 directories.
 570 Tue Mar 15 09:38:53 2011 Child 4 will create 23420 files.
 571 Tue Mar 15 09:39:04 2011 Child 6 finished creating 766 directories.
 572 Tue Mar 15 09:39:04 2011 Child 6 will create 23420 files.
 573 Tue Mar 15 09:43:04 2011 Child 2 verified 19887 files (2605 creates).
 574 Tue Mar 15 09:43:09 2011 Child 0 verified 19539 files (2257 creates).
 575 Tue Mar 15 09:43:18 2011 Child 1 verified 19277 files (1995 creates).
 576 Tue Mar 15 09:43:34 2011 Child 3 verified 19221 files (1939 creates).
 577 Tue Mar 15 09:43:48 2011 Child 5 verified 19233 files (1951 creates).
 578 Tue Mar 15 09:43:51 2011 Child 7 verified 19154 files (1872 creates).
 579 Tue Mar 15 09:43:54 2011 Child 4 verified 19137 files (1855 creates).
 580 Tue Mar 15 09:44:05 2011 Child 6 verified 19140 files (1858 creates).
 581 Tue Mar 15 09:48:06 2011 Child 2 verified 22326 files (5044 creates).
 582 Tue Mar 15 09:48:11 2011 Child 0 verified 21999 files (4717 creates).
 583 Tue Mar 15 09:48:18 2011 Child 1 verified 21782 files (4500 creates).
 584 Tue Mar 15 09:48:35 2011 Child 3 verified 21686 files (4404 creates).
 585 Tue Mar 15 09:48:49 2011 Child 5 verified 21748 files (4466 creates).
 586 Tue Mar 15 09:48:52 2011 Child 7 verified 21649 files (4367 creates).
 587 Tue Mar 15 09:48:56 2011 Child 4 verified 21681 files (4399 creates).
 588 Tue Mar 15 09:49:08 2011 Child 6 verified 21605 files (4323 creates).
 589 Tue Mar 15 09:49:48 2011 Child 2 verified 23420 files, created 5909
 590 Tue Mar 15 09:49:48 2011 Child 2 will create 3 symlinks.
 591 Tue Mar 15 09:49:48 2011 Child 2 finished creating 3 symlinks.
 592 Tue Mar 15 09:50:28 2011 Child 0 verified 23420 files, created 5909
 593 Tue Mar 15 09:50:28 2011 Child 0 will create 3 symlinks.
 594 Tue Mar 15 09:50:28 2011 Child 0 finished creating 3 symlinks.
 595 Tue Mar 15 09:51:01 2011 Child 1 verified 23420 files, created 5909
 596 Tue Mar 15 09:51:01 2011 Child 1 will create 3 symlinks.
 597 Tue Mar 15 09:51:02 2011 Child 1 finished creating 3 symlinks.
 598 Tue Mar 15 09:51:15 2011 Child 3 verified 23420 files, created 5909
 599 Tue Mar 15 09:51:15 2011 Child 3 will create 3 symlinks.
 600 Tue Mar 15 09:51:15 2011 Child 3 finished creating 3 symlinks.
 601 Tue Mar 15 09:51:16 2011 Child 5 verified 23420 files, created 5909
 602 Tue Mar 15 09:51:16 2011 Child 5 will create 3 symlinks.
 603 Tue Mar 15 09:51:16 2011 Child 5 finished creating 3 symlinks.
 604 Tue Mar 15 09:51:18 2011 Child 7 verified 23420 files, created 5909
 605 Tue Mar 15 09:51:18 2011 Child 7 will create 3 symlinks.
 606 Tue Mar 15 09:51:18 2011 Child 7 finished creating 3 symlinks.
 607 Tue Mar 15 09:51:18 2011 Child 4 verified 23420 files, created 5909
 608 Tue Mar 15 09:51:18 2011 Child 4 will create 3 symlinks.
 609 Tue Mar 15 09:51:18 2011 Child 4 finished creating 3 symlinks.
 610 Tue Mar 15 09:51:22 2011 Child 6 verified 23420 files, created 5909
 611 Tue Mar 15 09:51:22 2011 Child 6 will create 3 symlinks.
 612 Tue Mar 15 09:51:22 2011 Child 6 finished creating 3 symlinks.
 613 Tue Mar 15 09:51:22 2011 Completed.
 614 Tue Mar 15 09:51:22 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
 615 Tue Mar 15 09:51:22 2011 Completed.
 616 Tue Mar 15 09:51:22 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
 617 Tue Mar 15 09:51:22 2011 Received.
 618 Tue Mar 15 09:51:22 2011 Performing 300 seconds pretest warmup.
 619 Tue Mar 15 09:56:22 2011 Completed.
 620 Tue Mar 15 09:56:22 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
 621 Tue Mar 15 09:56:22 2011 Completed.
 622 Tue Mar 15 09:56:22 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
 623 Tue Mar 15 09:56:23 2011 Received.
 624 Tue Mar 15 09:56:23 2011 Starting 300 seconds test run.
 625 SFS Single Client (c09-44) Results, Tue Mar 15 10:01:33 2011
 626 --------------------------------------------------------------------------------------
 627 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
 628 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
 629 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
 630            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 631 --------------------------------------------------------------------------------------
 632 getattr     26.0%    25.9%    17953    17953      0      3.93    33.55      0.08  2.7%
 633 setattr      4.0%     4.0%     2808     2808      0    256.29   383.68      0.72 27.9%
 634 lookup      24.0%    24.1%    16714    16714      0      3.80    25.85      0.08  2.5%
 635 readlink     1.0%     1.0%      691      691      0      3.34    10.75      0.24  0.1%
 636 read        18.0%    17.9%    12393    15157      0     47.41    72.19      0.15 22.8%
 637 write       10.0%     9.9%     6893     8300      0     32.08    82.88      0.21  8.6%
 638 create       1.0%     1.0%      707      707      0    496.53   544.06      1.72 13.6%
 639 remove       1.0%     1.0%      677      677      0    251.80   383.16      1.47  6.6%
 640 readdir      1.0%     1.0%      686      686      0      6.73    40.04      0.47  0.2%
 641 fsstat       1.0%     1.1%      741      741      0      8.46    80.90      0.65  0.2%
 642 access      11.0%    11.1%     7718     7718      0      4.21    35.92      0.13  1.3%
 643 commit       0.0%     0.0%        0     2447      0      0.00     0.00      0.00 13.0%
 644 readdirplus  2.0%     2.0%     1372     1372      0      9.79    55.62      0.39  0.5%
 645 --------------------------------------------------------------------------------------
 646
 647       --------------------------------------------------
 648       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
 649       --------------------------+-----------------------
 650 SFS NFS V3 THROUGHPUT:  231.94 Ops/Sec   AVG. RESPONSE TIME:   37.15 Msec/Op
 651 TCP PROTOCOL
 652 FAST CALLS: 0
 653 NFS V3 MIXFILE: [ SFS Default ]
 654 CLIENT REQUESTED LOAD: 800 Ops/Sec
 655 TOTAL LOGICAL NFS V3 OPERATIONS:  69353          TEST TIME: 299 Sec
 656 TOTAL PHYSICAL NFS V3 OPERATIONS: 75971
 657 PHYSICAL NFS V3 THROUGHPUT:  254.08 Ops/Sec
 658 FILE SET SIZE CREATED: 97534080.0 KB
 659 FILE SET SIZE ACCESSED: 29264472.0 - 29407100.0 KB  (100.00% to 100.49% of Base)
 660
 661 ------------------------------------------------------------------------
 662
 663 Tue Mar 15 10:01:33 2011 Completed.
 664
 665 Client Test Parameters:
 666         Number of processes = 8
 667         Requested Load (NFS V3 operations/second) = 800
 668         Maximum number of outstanding biod writes = 8
 669         Maximum number of outstanding biod reads = 8
 670         Warm-up time (seconds) = 300
 671         Run time (seconds) = 300
 672         File Set = 183680 Files created for I/O operations
 673                    55104 Files accessed for I/O operations
 674                    3680 Files for non-I/O operations
 675                      24 Symlinks
 676                    6120 Directories
 677                         Additional non-I/O files created as necessary
 678
 679
 680 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
 681 Tue Mar 15 10:01:33 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
 682 Tue Mar 15 10:01:33 2011 Completed.
 683 Tue Mar 15 10:01:33 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
 684
 685 ************************************************************************
 686 Tue Mar 15 10:01:34 2011 Received.
 687 Tue Mar 15 10:01:34 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
 688 Tue Mar 15 10:01:34 2011 Completed.
 689 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1000  -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 8 -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
 690 NFS V3 Protocol Version
 691
 692 ************************************************************************
 693 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
 694 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
 695
 696 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
 697 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 698
 699 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 10:01:36 2011
 700         Client hostname = c09-44
 701         Prime Client hostname = c09-44.sysnet.ucsd.edu
 702
 703 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 704 NFS V3 Protocol
 705 Tue Mar 15 10:01:36 2011 Mounting 8 remote test directories.
 706 Child[000]: NFS negotiated block size 32768
 707 Child[001]: NFS negotiated block size 32768
 708 Child[002]: NFS negotiated block size 32768
 709 Child[003]: NFS negotiated block size 32768
 710 Child[004]: NFS negotiated block size 32768
 711 Child[005]: NFS negotiated block size 32768
 712 Child[006]: NFS negotiated block size 32768
 713 Child[007]: NFS negotiated block size 32768
 714 Tue Mar 15 10:01:48 2011 Completed.
 715 Tue Mar 15 10:01:48 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
 716 Tue Mar 15 10:01:48 2011 Completed.
 717 Tue Mar 15 10:01:48 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
 718 Tue Mar 15 10:01:52 2011 Received.
 719
 720 Tue Mar 15 10:01:52 2011 Initializing test directories.
 721 Tue Mar 15 10:01:52 2011 Child 6 will create 963 directories.
 722 Tue Mar 15 10:01:52 2011 Child 7 will create 963 directories.
 723 Tue Mar 15 10:01:52 2011 Child 2 will create 963 directories.
 724 Tue Mar 15 10:01:52 2011 Child 4 will create 963 directories.
 725 Tue Mar 15 10:01:52 2011 Child 0 will create 963 directories.
 726 Tue Mar 15 10:01:52 2011 Child 3 will create 963 directories.
 727 Tue Mar 15 10:01:52 2011 Child 5 will create 963 directories.
 728 Tue Mar 15 10:01:52 2011 Child 1 will create 963 directories.
 729 Tue Mar 15 10:02:08 2011 Child 5 finished creating 963 directories.
 730 Tue Mar 15 10:02:08 2011 Child 5 will create 29463 files.
 731 Tue Mar 15 10:02:13 2011 Child 6 finished creating 963 directories.
 732 Tue Mar 15 10:02:13 2011 Child 6 will create 29463 files.
 733 Tue Mar 15 10:02:16 2011 Child 4 finished creating 963 directories.
 734 Tue Mar 15 10:02:16 2011 Child 4 will create 29463 files.
 735 Tue Mar 15 10:02:22 2011 Child 7 finished creating 963 directories.
 736 Tue Mar 15 10:02:22 2011 Child 7 will create 29463 files.
 737 Tue Mar 15 10:02:58 2011 Child 3 finished creating 963 directories.
 738 Tue Mar 15 10:02:58 2011 Child 3 will create 29463 files.
 739 Tue Mar 15 10:03:02 2011 Child 1 finished creating 963 directories.
 740 Tue Mar 15 10:03:02 2011 Child 1 will create 29463 files.
 741 Tue Mar 15 10:03:09 2011 Child 2 finished creating 963 directories.
 742 Tue Mar 15 10:03:09 2011 Child 2 will create 29463 files.
 743 Tue Mar 15 10:03:49 2011 Child 0 finished creating 963 directories.
 744 Tue Mar 15 10:03:49 2011 Child 0 will create 29463 files.
 745 Tue Mar 15 10:07:10 2011 Child 5 verified 25518 files (2558 creates).
 746 Tue Mar 15 10:07:15 2011 Child 6 verified 25253 files (2293 creates).
 747 Tue Mar 15 10:07:17 2011 Child 4 verified 25237 files (2277 creates).
 748 Tue Mar 15 10:07:23 2011 Child 7 verified 25118 files (2158 creates).
 749 Tue Mar 15 10:07:59 2011 Child 3 verified 25095 files (2135 creates).
 750 Tue Mar 15 10:08:03 2011 Child 1 verified 25015 files (2055 creates).
 751 Tue Mar 15 10:08:10 2011 Child 2 verified 25026 files (2066 creates).
 752 Tue Mar 15 10:08:50 2011 Child 0 verified 24972 files (2012 creates).
 753 Tue Mar 15 10:12:11 2011 Child 5 verified 28093 files (5133 creates).
 754 Tue Mar 15 10:12:16 2011 Child 6 verified 27796 files (4836 creates).
 755 Tue Mar 15 10:12:21 2011 Child 4 verified 27775 files (4815 creates).
 756 Tue Mar 15 10:12:24 2011 Child 7 verified 27669 files (4709 creates).
 757 Tue Mar 15 10:13:00 2011 Child 3 verified 27629 files (4669 creates).
 758 Tue Mar 15 10:13:04 2011 Child 1 verified 27559 files (4599 creates).
 759 Tue Mar 15 10:13:13 2011 Child 2 verified 27633 files (4673 creates).
 760 Tue Mar 15 10:13:51 2011 Child 0 verified 27561 files (4601 creates).
 761 Tue Mar 15 10:14:14 2011 Child 5 verified 29463 files, created 6215
 762 Tue Mar 15 10:14:14 2011 Child 5 will create 3 symlinks.
 763 Tue Mar 15 10:14:16 2011 Child 5 finished creating 3 symlinks.
 764 Tue Mar 15 10:14:48 2011 Child 6 verified 29463 files, created 6215
 765 Tue Mar 15 10:14:48 2011 Child 6 will create 3 symlinks.
 766 Tue Mar 15 10:14:48 2011 Child 6 finished creating 3 symlinks.
 767 Tue Mar 15 10:14:49 2011 Child 4 verified 29463 files, created 6215
 768 Tue Mar 15 10:14:49 2011 Child 4 will create 3 symlinks.
 769 Tue Mar 15 10:14:49 2011 Child 4 finished creating 3 symlinks.
 770 Tue Mar 15 10:14:57 2011 Child 7 verified 29463 files, created 6215
 771 Tue Mar 15 10:14:57 2011 Child 7 will create 3 symlinks.
 772 Tue Mar 15 10:14:57 2011 Child 7 finished creating 3 symlinks.
 773 Tue Mar 15 10:15:17 2011 Child 3 verified 29463 files, created 6215
 774 Tue Mar 15 10:15:17 2011 Child 3 will create 3 symlinks.
 775 Tue Mar 15 10:15:17 2011 Child 3 finished creating 3 symlinks.
 776 Tue Mar 15 10:15:18 2011 Child 1 verified 29463 files, created 6215
 777 Tue Mar 15 10:15:18 2011 Child 1 will create 3 symlinks.
 778 Tue Mar 15 10:15:18 2011 Child 1 finished creating 3 symlinks.
 779 Tue Mar 15 10:15:19 2011 Child 2 verified 29463 files, created 6215
 780 Tue Mar 15 10:15:19 2011 Child 2 will create 3 symlinks.
 781 Tue Mar 15 10:15:19 2011 Child 2 finished creating 3 symlinks.
 782 Tue Mar 15 10:15:27 2011 Child 0 verified 29463 files, created 6215
 783 Tue Mar 15 10:15:27 2011 Child 0 will create 3 symlinks.
 784 Tue Mar 15 10:15:27 2011 Child 0 finished creating 3 symlinks.
 785 Tue Mar 15 10:15:27 2011 Completed.
 786 Tue Mar 15 10:15:27 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
 787 Tue Mar 15 10:15:27 2011 Completed.
 788 Tue Mar 15 10:15:27 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
 789 Tue Mar 15 10:15:27 2011 Received.
 790 Tue Mar 15 10:15:27 2011 Performing 300 seconds pretest warmup.
 791 Tue Mar 15 10:20:27 2011 Completed.
 792 Tue Mar 15 10:20:27 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
 793 Tue Mar 15 10:20:27 2011 Completed.
 794 Tue Mar 15 10:20:27 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
 795 Tue Mar 15 10:20:28 2011 Received.
 796 Tue Mar 15 10:20:28 2011 Starting 300 seconds test run.
 797 SFS Single Client (c09-44) Results, Tue Mar 15 10:25:39 2011
 798 --------------------------------------------------------------------------------------
 799 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
 800 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
 801 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
 802            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 803 --------------------------------------------------------------------------------------
 804 getattr     26.0%    26.1%    16217    16217      0      4.27    33.31      0.09  2.7%
 805 setattr      4.0%     4.1%     2553     2553      0    286.57   439.08      0.81 28.4%
 806 lookup      24.0%    23.8%    14806    14806      0      4.97    45.28      0.11  2.9%
 807 readlink     1.0%     1.0%      610      610      0      3.70    12.00      0.27  0.1%
 808 read        18.0%    18.0%    11153    13763      0     54.70    78.57      0.16 23.7%
 809 write       10.0%     9.9%     6157     7341      0     33.23    75.71      0.22  8.0%
 810 create       1.0%     1.0%      645      645      0    535.85   621.40      1.92 13.4%
 811 remove       1.0%     1.0%      629      629      0    277.24   429.54      1.62  6.8%
 812 readdir      1.0%     1.0%      629      629      0      7.20    28.71      0.42  0.2%
 813 fsstat       1.0%     1.0%      635      635      0      4.79    34.94      0.46  0.1%
 814 access      11.0%    11.0%     6844     6844      0      4.55    32.20      0.13  1.2%
 815 commit       0.0%     0.0%        0     2164      0      0.00     0.00      0.00 12.2%
 816 readdirplus  2.0%     2.0%     1219     1219      0      7.60    36.21      0.34  0.4%
 817 --------------------------------------------------------------------------------------
 818
 819       --------------------------------------------------
 820       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
 821       --------------------------+-----------------------
 822 SFS NFS V3 THROUGHPUT:  206.99 Ops/Sec   AVG. RESPONSE TIME:   41.42 Msec/Op
 823 TCP PROTOCOL
 824 FAST CALLS: 0
 825 NFS V3 MIXFILE: [ SFS Default ]
 826 CLIENT REQUESTED LOAD: 1000 Ops/Sec
 827 TOTAL LOGICAL NFS V3 OPERATIONS:  62097          TEST TIME: 300 Sec
 828 TOTAL PHYSICAL NFS V3 OPERATIONS: 68055
 829 PHYSICAL NFS V3 THROUGHPUT:  226.85 Ops/Sec
 830 FILE SET SIZE CREATED: 122703480.0 KB
 831 FILE SET SIZE ACCESSED: 36813168.0 - 36941892.0 KB  (100.00% to 100.35% of Base)
 832
 833 ------------------------------------------------------------------------
 834
 835
 836 ************************************************************************
 837 Tue Mar 15 10:25:39 2011 Completed.
 838
 839 Client Test Parameters:
 840         Number of processes = 8
 841         Requested Load (NFS V3 operations/second) = 1000
 842         Maximum number of outstanding biod writes = 8
 843         Maximum number of outstanding biod reads = 8
 844         Warm-up time (seconds) = 300
 845         Run time (seconds) = 300
 846         File Set = 231080 Files created for I/O operations
 847                    69320 Files accessed for I/O operations
 848                    4624 Files for non-I/O operations
 849                      24 Symlinks
 850                    7696 Directories
 851                         Additional non-I/O files created as necessary
 852
 853
 854 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
 855 Tue Mar 15 10:25:39 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
 856 Tue Mar 15 10:25:39 2011 Completed.
 857 Tue Mar 15 10:25:39 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
 858 Tue Mar 15 10:25:39 2011 Received.
 859 Tue Mar 15 10:25:39 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
 860 Tue Mar 15 10:25:39 2011 Completed.
 861 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1200  -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 8 -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
 862 NFS V3 Protocol Version
 863
 864 ************************************************************************
 865 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
 866 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
 867
 868 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
 869 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 870
 871 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 10:25:41 2011
 872         Client hostname = c09-44
 873         Prime Client hostname = c09-44.sysnet.ucsd.edu
 874
 875 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 876 NFS V3 Protocol
 877 Tue Mar 15 10:25:41 2011 Mounting 8 remote test directories.
 878 Child[000]: NFS negotiated block size 32768
 879 Child[001]: NFS negotiated block size 32768
 880 Child[002]: NFS negotiated block size 32768
 881 Child[003]: NFS negotiated block size 32768
 882 Child[004]: NFS negotiated block size 32768
 883 Child[005]: NFS negotiated block size 32768
 884 Child[006]: NFS negotiated block size 32768
 885 Child[007]: NFS negotiated block size 32768
 886 Tue Mar 15 10:25:53 2011 Completed.
 887 Tue Mar 15 10:25:53 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
 888 Tue Mar 15 10:25:53 2011 Completed.
 889 Tue Mar 15 10:25:53 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
 890 Tue Mar 15 10:25:57 2011 Received.
 891
 892 Tue Mar 15 10:25:57 2011 Initializing test directories.
 893 Tue Mar 15 10:25:57 2011 Child 6 will create 1153 directories.
 894 Tue Mar 15 10:25:57 2011 Child 7 will create 1153 directories.
 895 Tue Mar 15 10:25:57 2011 Child 5 will create 1153 directories.
 896 Tue Mar 15 10:25:57 2011 Child 2 will create 1153 directories.
 897 Tue Mar 15 10:25:57 2011 Child 3 will create 1153 directories.
 898 Tue Mar 15 10:25:57 2011 Child 1 will create 1153 directories.
 899 Tue Mar 15 10:25:57 2011 Child 4 will create 1153 directories.
 900 Tue Mar 15 10:25:57 2011 Child 0 will create 1153 directories.
 901 Tue Mar 15 10:26:21 2011 Child 3 finished creating 1153 directories.
 902 Tue Mar 15 10:26:21 2011 Child 3 will create 35255 files.
 903 Tue Mar 15 10:26:24 2011 Child 7 finished creating 1153 directories.
 904 Tue Mar 15 10:26:24 2011 Child 7 will create 35255 files.
 905 Tue Mar 15 10:26:29 2011 Child 0 finished creating 1153 directories.
 906 Tue Mar 15 10:26:29 2011 Child 0 will create 35255 files.
 907 Tue Mar 15 10:27:09 2011 Child 1 finished creating 1153 directories.
 908 Tue Mar 15 10:27:09 2011 Child 1 will create 35255 files.
 909 Tue Mar 15 10:27:10 2011 Child 2 finished creating 1153 directories.
 910 Tue Mar 15 10:27:10 2011 Child 2 will create 35255 files.
 911 Tue Mar 15 10:27:13 2011 Child 6 finished creating 1153 directories.
 912 Tue Mar 15 10:27:13 2011 Child 6 will create 35255 files.
 913 Tue Mar 15 10:27:57 2011 Child 4 finished creating 1153 directories.
 914 Tue Mar 15 10:27:57 2011 Child 4 will create 35255 files.
 915 Tue Mar 15 10:28:10 2011 Child 5 finished creating 1153 directories.
 916 Tue Mar 15 10:28:10 2011 Child 5 will create 35255 files.
 917 Tue Mar 15 10:31:22 2011 Child 3 verified 31717 files (2832 creates).
 918 Tue Mar 15 10:31:26 2011 Child 7 verified 31560 files (2675 creates).
 919 Tue Mar 15 10:31:31 2011 Child 0 verified 31404 files (2519 creates).
 920 Tue Mar 15 10:32:11 2011 Child 1 verified 31203 files (2318 creates).
 921 Tue Mar 15 10:32:12 2011 Child 2 verified 31179 files (2294 creates).
 922 Tue Mar 15 10:32:14 2011 Child 6 verified 31108 files (2223 creates).
 923 Tue Mar 15 10:33:00 2011 Child 4 verified 30972 files (2087 creates).
 924 Tue Mar 15 10:33:11 2011 Child 5 verified 30949 files (2064 creates).
 925 Tue Mar 15 10:36:24 2011 Child 3 verified 34373 files (5488 creates).
 926 Tue Mar 15 10:36:26 2011 Child 7 verified 34199 files (5314 creates).
 927 Tue Mar 15 10:36:32 2011 Child 0 verified 33999 files (5114 creates).
 928 Tue Mar 15 10:37:10 2011 Child 3 verified 35255 files, created 6025
 929 Tue Mar 15 10:37:10 2011 Child 3 will create 3 symlinks.
 930 Tue Mar 15 10:37:11 2011 Child 3 finished creating 3 symlinks.
 931 Tue Mar 15 10:37:12 2011 Child 1 verified 33880 files (4995 creates).
 932 Tue Mar 15 10:37:13 2011 Child 2 verified 33837 files (4952 creates).
 933 Tue Mar 15 10:37:15 2011 Child 6 verified 33732 files (4847 creates).
 934 Tue Mar 15 10:37:28 2011 Child 7 verified 35255 files, created 6025
 935 Tue Mar 15 10:37:28 2011 Child 7 will create 3 symlinks.
 936 Tue Mar 15 10:37:28 2011 Child 7 finished creating 3 symlinks.
 937 Tue Mar 15 10:37:40 2011 Child 0 verified 35255 files, created 6025
 938 Tue Mar 15 10:37:40 2011 Child 0 will create 3 symlinks.
 939 Tue Mar 15 10:37:40 2011 Child 0 finished creating 3 symlinks.
 940 Tue Mar 15 10:38:01 2011 Child 4 verified 33790 files (4905 creates).
 941 Tue Mar 15 10:38:12 2011 Child 5 verified 33905 files (5020 creates).
 942 Tue Mar 15 10:38:13 2011 Child 1 verified 35255 files, created 6025
 943 Tue Mar 15 10:38:13 2011 Child 1 will create 3 symlinks.
 944 Tue Mar 15 10:38:13 2011 Child 1 finished creating 3 symlinks.
 945 Tue Mar 15 10:38:14 2011 Child 2 verified 35255 files, created 6025
 946 Tue Mar 15 10:38:14 2011 Child 2 will create 3 symlinks.
 947 Tue Mar 15 10:38:14 2011 Child 2 finished creating 3 symlinks.
 948 Tue Mar 15 10:38:17 2011 Child 6 verified 35255 files, created 6025
 949 Tue Mar 15 10:38:17 2011 Child 6 will create 3 symlinks.
 950 Tue Mar 15 10:38:17 2011 Child 6 finished creating 3 symlinks.
 951 Tue Mar 15 10:38:29 2011 Child 4 verified 35255 files, created 6025
 952 Tue Mar 15 10:38:29 2011 Child 4 will create 3 symlinks.
 953 Tue Mar 15 10:38:29 2011 Child 4 finished creating 3 symlinks.
 954 Tue Mar 15 10:38:31 2011 Child 5 verified 35255 files, created 6025
 955 Tue Mar 15 10:38:31 2011 Child 5 will create 3 symlinks.
 956 Tue Mar 15 10:38:31 2011 Child 5 finished creating 3 symlinks.
 957 Tue Mar 15 10:38:32 2011 Completed.
 958 Tue Mar 15 10:38:32 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
 959 Tue Mar 15 10:38:32 2011 Completed.
 960 Tue Mar 15 10:38:32 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
 961 Tue Mar 15 10:38:33 2011 Received.
 962 Tue Mar 15 10:38:33 2011 Performing 300 seconds pretest warmup.
 963 Tue Mar 15 10:43:33 2011 Completed.
 964 Tue Mar 15 10:43:33 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
 965 Tue Mar 15 10:43:33 2011 Completed.
 966 Tue Mar 15 10:43:33 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
 967 Tue Mar 15 10:43:34 2011 Received.
 968 Tue Mar 15 10:43:34 2011 Starting 300 seconds test run.
 969 SFS Single Client (c09-44) Results, Tue Mar 15 10:48:44 2011
 970 --------------------------------------------------------------------------------------
 971 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
 972 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
 973 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
 974            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 975 --------------------------------------------------------------------------------------
 976 getattr     26.0%    26.1%    15660    15660      0      4.31    35.32      0.09  2.6%
 977 setattr      4.0%     4.1%     2438     2438      0    297.01   448.61      0.84 28.1%
 978 lookup      24.0%    24.1%    14492    14492      0      5.31    48.38      0.11  3.0%
 979 readlink     1.0%     1.0%      619      619      0      4.16    11.38      0.27  0.1%
 980 read        18.0%    18.0%    10811    13319      0     59.51    72.04      0.16 25.0%
 981 write       10.0%     9.7%     5811     7012      0     36.97    94.11      0.25  8.3%
 982 create       1.0%     1.0%      604      604      0    537.29   533.13      1.84 12.6%
 983 remove       1.0%     0.9%      549      549      0    293.41   454.80      1.78  6.3%
 984 readdir      1.0%     1.0%      611      611      0      6.94    27.00      0.41  0.2%
 985 fsstat       1.0%     1.1%      641      641      0      3.61    10.00      0.24  0.1%
 986 access      11.0%    11.1%     6661     6661      0      5.23    44.34      0.16  1.4%
 987 commit       0.0%     0.0%        0     2006      0      0.00     0.00      0.00 12.1%
 988 readdirplus  2.0%     1.9%     1161     1161      0      5.96    25.17      0.29  0.3%
 989 --------------------------------------------------------------------------------------
 990
 991       --------------------------------------------------
 992       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
 993       --------------------------+-----------------------
 994 SFS NFS V3 THROUGHPUT:  200.86 Ops/Sec   AVG. RESPONSE TIME:   42.84 Msec/Op
 995 TCP PROTOCOL
 996 FAST CALLS: 0
 997 NFS V3 MIXFILE: [ SFS Default ]
 998 CLIENT REQUESTED LOAD: 1200 Ops/Sec
 999 TOTAL LOGICAL NFS V3 OPERATIONS:  60058          TEST TIME: 299 Sec
1000 TOTAL PHYSICAL NFS V3 OPERATIONS: 65773
1001 PHYSICAL NFS V3 THROUGHPUT:  219.97 Ops/Sec
1002 FILE SET SIZE CREATED: 146823616.0 KB
1003 FILE SET SIZE ACCESSED: 44047512.0 - 44169948.0 KB  (100.00% to 100.28% of Base)
1004
1005 ------------------------------------------------------------------------
1006
1007 Tue Mar 15 10:48:44 2011 Completed.
1008
1009 Client Test Parameters:
1010         Number of processes = 8
1011         Requested Load (NFS V3 operations/second) = 1200
1012         Maximum number of outstanding biod writes = 8
1013         Maximum number of outstanding biod reads = 8
1014         Warm-up time (seconds) = 300
1015         Run time (seconds) = 300
1016         File Set = 276504 Files created for I/O operations
1017                    82944 Files accessed for I/O operations
1018                    5536 Files for non-I/O operations
1019                      24 Symlinks
1020                    9216 Directories
1021                         Additional non-I/O files created as necessary
1022
1023
1024 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1025 Tue Mar 15 10:48:44 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1026 Tue Mar 15 10:48:44 2011 Completed.
1027 Tue Mar 15 10:48:44 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1028
1029 ************************************************************************
1030 Tue Mar 15 10:48:45 2011 Received.
1031 Tue Mar 15 10:48:45 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1032 Tue Mar 15 10:48:45 2011 Completed.
1033 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1400  -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 8 -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
1034 NFS V3 Protocol Version
1035
1036 ************************************************************************
1037 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1038 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1039
1040 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1041 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1042
1043 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 10:48:47 2011
1044         Client hostname = c09-44
1045         Prime Client hostname = c09-44.sysnet.ucsd.edu
1046
1047 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1048 NFS V3 Protocol
1049 Tue Mar 15 10:48:47 2011 Mounting 8 remote test directories.
1050 Child[000]: NFS negotiated block size 32768
1051 Child[001]: NFS negotiated block size 32768
1052 Child[002]: NFS negotiated block size 32768
1053 Child[003]: NFS negotiated block size 32768
1054 Child[004]: NFS negotiated block size 32768
1055 Child[005]: NFS negotiated block size 32768
1056 Child[006]: NFS negotiated block size 32768
1057 Child[007]: NFS negotiated block size 32768
1058 Tue Mar 15 10:48:59 2011 Completed.
1059 Tue Mar 15 10:48:59 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1060 Tue Mar 15 10:48:59 2011 Completed.
1061 Tue Mar 15 10:48:59 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1062 Tue Mar 15 10:49:03 2011 Received.
1063
1064 Tue Mar 15 10:49:03 2011 Initializing test directories.
1065 Tue Mar 15 10:49:03 2011 Child 5 will create 1350 directories.
1066 Tue Mar 15 10:49:03 2011 Child 6 will create 1350 directories.
1067 Tue Mar 15 10:49:03 2011 Child 0 will create 1350 directories.
1068 Tue Mar 15 10:49:03 2011 Child 1 will create 1350 directories.
1069 Tue Mar 15 10:49:03 2011 Child 2 will create 1350 directories.
1070 Tue Mar 15 10:49:03 2011 Child 7 will create 1350 directories.
1071 Tue Mar 15 10:49:03 2011 Child 4 will create 1350 directories.
1072 Tue Mar 15 10:49:03 2011 Child 3 will create 1350 directories.
1073 Tue Mar 15 10:49:26 2011 Child 2 finished creating 1350 directories.
1074 Tue Mar 15 10:49:26 2011 Child 2 will create 41298 files.
1075 Tue Mar 15 10:49:31 2011 Child 6 finished creating 1350 directories.
1076 Tue Mar 15 10:49:31 2011 Child 6 will create 41298 files.
1077 Tue Mar 15 10:50:08 2011 Child 4 finished creating 1350 directories.
1078 Tue Mar 15 10:50:08 2011 Child 4 will create 41298 files.
1079 Tue Mar 15 10:50:12 2011 Child 7 finished creating 1350 directories.
1080 Tue Mar 15 10:50:12 2011 Child 7 will create 41298 files.
1081 Tue Mar 15 10:50:21 2011 Child 3 finished creating 1350 directories.
1082 Tue Mar 15 10:50:21 2011 Child 3 will create 41298 files.
1083 Tue Mar 15 10:50:55 2011 Child 1 finished creating 1350 directories.
1084 Tue Mar 15 10:50:55 2011 Child 1 will create 41298 files.
1085 Tue Mar 15 10:50:58 2011 Child 0 finished creating 1350 directories.
1086 Tue Mar 15 10:50:58 2011 Child 0 will create 41298 files.
1087 Tue Mar 15 10:51:37 2011 Child 5 finished creating 1350 directories.
1088 Tue Mar 15 10:51:37 2011 Child 5 will create 41298 files.
1089 Tue Mar 15 10:54:27 2011 Child 2 verified 37372 files (2809 creates).
1090 Tue Mar 15 10:54:32 2011 Child 6 verified 37028 files (2465 creates).
1091 Tue Mar 15 10:55:09 2011 Child 4 verified 36586 files (2023 creates).
1092 Tue Mar 15 10:55:15 2011 Child 7 verified 36478 files (1915 creates).
1093 Tue Mar 15 10:55:22 2011 Child 3 verified 36329 files (1766 creates).
1094 Tue Mar 15 10:55:57 2011 Child 1 verified 36217 files (1654 creates).
1095 Tue Mar 15 10:56:00 2011 Child 0 verified 36238 files (1675 creates).
1096 Tue Mar 15 10:56:38 2011 Child 5 verified 36165 files (1602 creates).
1097 Tue Mar 15 10:59:28 2011 Child 2 verified 39557 files (4994 creates).
1098 Tue Mar 15 10:59:34 2011 Child 6 verified 39161 files (4598 creates).
1099 Tue Mar 15 11:00:10 2011 Child 4 verified 38777 files (4214 creates).
1100 Tue Mar 15 11:00:16 2011 Child 7 verified 38649 files (4086 creates).
1101 Tue Mar 15 11:00:24 2011 Child 3 verified 38503 files (3940 creates).
1102 Tue Mar 15 11:00:59 2011 Child 1 verified 38431 files (3868 creates).
1103 Tue Mar 15 11:01:01 2011 Child 0 verified 38406 files (3843 creates).
1104 Tue Mar 15 11:01:39 2011 Child 5 verified 38367 files (3804 creates).
1105 Tue Mar 15 11:02:04 2011 Child 2 verified 41298 files, created 6331
1106 Tue Mar 15 11:02:04 2011 Child 2 will create 3 symlinks.
1107 Tue Mar 15 11:02:05 2011 Child 2 finished creating 3 symlinks.
1108 Tue Mar 15 11:02:54 2011 Child 6 verified 41298 files, created 6331
1109 Tue Mar 15 11:02:54 2011 Child 6 will create 3 symlinks.
1110 Tue Mar 15 11:02:54 2011 Child 6 finished creating 3 symlinks.
1111 Tue Mar 15 11:03:42 2011 Child 4 verified 41298 files, created 6331
1112 Tue Mar 15 11:03:42 2011 Child 4 will create 3 symlinks.
1113 Tue Mar 15 11:03:42 2011 Child 4 finished creating 3 symlinks.
1114 Tue Mar 15 11:03:55 2011 Child 7 verified 41298 files, created 6331
1115 Tue Mar 15 11:03:55 2011 Child 7 will create 3 symlinks.
1116 Tue Mar 15 11:03:55 2011 Child 7 finished creating 3 symlinks.
1117 Tue Mar 15 11:04:03 2011 Child 3 verified 41298 files, created 6331
1118 Tue Mar 15 11:04:03 2011 Child 3 will create 3 symlinks.
1119 Tue Mar 15 11:04:03 2011 Child 3 finished creating 3 symlinks.
1120 Tue Mar 15 11:04:12 2011 Child 1 verified 41298 files, created 6331
1121 Tue Mar 15 11:04:12 2011 Child 1 will create 3 symlinks.
1122 Tue Mar 15 11:04:12 2011 Child 1 finished creating 3 symlinks.
1123 Tue Mar 15 11:04:13 2011 Child 0 verified 41298 files, created 6331
1124 Tue Mar 15 11:04:13 2011 Child 0 will create 3 symlinks.
1125 Tue Mar 15 11:04:13 2011 Child 0 finished creating 3 symlinks.
1126 Tue Mar 15 11:04:18 2011 Child 5 verified 41298 files, created 6331
1127 Tue Mar 15 11:04:18 2011 Child 5 will create 3 symlinks.
1128 Tue Mar 15 11:04:18 2011 Child 5 finished creating 3 symlinks.
1129 Tue Mar 15 11:04:19 2011 Completed.
1130 Tue Mar 15 11:04:19 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1131 Tue Mar 15 11:04:19 2011 Completed.
1132 Tue Mar 15 11:04:19 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1133 Tue Mar 15 11:04:20 2011 Received.
1134 Tue Mar 15 11:04:20 2011 Performing 300 seconds pretest warmup.
1135 Tue Mar 15 11:09:20 2011 Completed.
1136 Tue Mar 15 11:09:20 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1137 Tue Mar 15 11:09:20 2011 Completed.
1138 Tue Mar 15 11:09:20 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1139 Tue Mar 15 11:09:21 2011 Received.
1140 Tue Mar 15 11:09:21 2011 Starting 300 seconds test run.
1141 SFS Single Client (c09-44) Results, Tue Mar 15 11:14:31 2011
1142 --------------------------------------------------------------------------------------
1143 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
1144 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
1145 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1146            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
1147 --------------------------------------------------------------------------------------
1148 getattr     26.0%    25.7%    13843    13843      0      5.07    48.73      0.12  2.7%
1149 setattr      4.0%     4.1%     2196     2196      0    326.02   489.23      0.92 27.9%
1150 lookup      24.0%    24.1%    13015    13015      0      4.70    30.72      0.10  2.4%
1151 readlink     1.0%     1.0%      543      543      0      3.05     8.87      0.25  0.1%
1152 read        18.0%    18.1%     9777    12035      0     65.85    77.04      0.17 25.1%
1153 write       10.0%     9.9%     5348     6480      0     40.76    97.89      0.27  8.5%
1154 create       1.0%     1.0%      514      514      0    635.26   639.38      2.19 12.7%
1155 remove       1.0%     1.0%      558      558      0    319.92   456.27      1.77  7.0%
1156 readdir      1.0%     1.0%      525      525      0      9.36    78.72      0.76  0.2%
1157 fsstat       1.0%     1.0%      556      556      0      8.03    94.37      0.81  0.2%
1158 access      11.0%    11.0%     5911     5911      0      6.07    60.53      0.20  1.4%
1159 commit       0.0%     0.0%        0     1844      0      0.00     0.00      0.00 11.6%
1160 readdirplus  2.0%     2.1%     1109     1109      0      8.12    53.03      0.43  0.4%
1161 --------------------------------------------------------------------------------------
1162
1163       --------------------------------------------------
1164       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1165       --------------------------+-----------------------
1166 SFS NFS V3 THROUGHPUT:  180.25 Ops/Sec   AVG. RESPONSE TIME:   47.64 Msec/Op
1167 TCP PROTOCOL
1168 FAST CALLS: 0
1169 NFS V3 MIXFILE: [ SFS Default ]
1170 CLIENT REQUESTED LOAD: 1400 Ops/Sec
1171 TOTAL LOGICAL NFS V3 OPERATIONS:  53895          TEST TIME: 299 Sec
1172 TOTAL PHYSICAL NFS V3 OPERATIONS: 59129
1173 PHYSICAL NFS V3 THROUGHPUT:  197.75 Ops/Sec
1174 FILE SET SIZE CREATED: 171993024.0 KB
1175 FILE SET SIZE ACCESSED: 51600456.0 - 51720640.0 KB  (100.00% to 100.23% of Base)
1176
1177 ------------------------------------------------------------------------
1178
1179 Tue Mar 15 11:14:31 2011 Completed.
1180
1181 Client Test Parameters:
1182         Number of processes = 8
1183         Requested Load (NFS V3 operations/second) = 1400
1184         Maximum number of outstanding biod writes = 8
1185         Maximum number of outstanding biod reads = 8
1186         Warm-up time (seconds) = 300
1187         Run time (seconds) = 300
1188         File Set = 323904 Files created for I/O operations
1189                    97168 Files accessed for I/O operations
1190                    6480 Files for non-I/O operations
1191                      24 Symlinks
1192                    10792 Directories
1193                         Additional non-I/O files created as necessary
1194
1195
1196 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1197 Tue Mar 15 11:14:31 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1198 Tue Mar 15 11:14:31 2011 Completed.
1199 Tue Mar 15 11:14:31 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1200
1201 ************************************************************************
1202 Tue Mar 15 11:14:32 2011 Received.
1203 Tue Mar 15 11:14:32 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1204 Tue Mar 15 11:14:32 2011 Completed.
1205 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1600  -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 8 -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
1206 NFS V3 Protocol Version
1207
1208 ************************************************************************
1209 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1210 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1211
1212 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1213 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1214
1215 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 11:14:34 2011
1216         Client hostname = c09-44
1217         Prime Client hostname = c09-44.sysnet.ucsd.edu
1218
1219 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1220 NFS V3 Protocol
1221 Tue Mar 15 11:14:34 2011 Mounting 8 remote test directories.
1222 Child[000]: NFS negotiated block size 32768
1223 Child[001]: NFS negotiated block size 32768
1224 Child[002]: NFS negotiated block size 32768
1225 Child[003]: NFS negotiated block size 32768
1226 Child[004]: NFS negotiated block size 32768
1227 Child[005]: NFS negotiated block size 32768
1228 Child[006]: NFS negotiated block size 32768
1229 Child[007]: NFS negotiated block size 32768
1230 Tue Mar 15 11:14:46 2011 Completed.
1231 Tue Mar 15 11:14:46 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1232 Tue Mar 15 11:14:46 2011 Completed.
1233 Tue Mar 15 11:14:46 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1234 Tue Mar 15 11:14:50 2011 Received.
1235
1236 Tue Mar 15 11:14:50 2011 Initializing test directories.
1237 Tue Mar 15 11:14:50 2011 Child 6 will create 1539 directories.
1238 Tue Mar 15 11:14:50 2011 Child 0 will create 1539 directories.
1239 Tue Mar 15 11:14:50 2011 Child 1 will create 1539 directories.
1240 Tue Mar 15 11:14:50 2011 Child 7 will create 1539 directories.
1241 Tue Mar 15 11:14:50 2011 Child 4 will create 1539 directories.
1242 Tue Mar 15 11:14:50 2011 Child 2 will create 1539 directories.
1243 Tue Mar 15 11:14:50 2011 Child 3 will create 1539 directories.
1244 Tue Mar 15 11:14:50 2011 Child 5 will create 1539 directories.
1245 Tue Mar 15 11:15:24 2011 Child 5 finished creating 1539 directories.
1246 Tue Mar 15 11:15:24 2011 Child 5 will create 47090 files.
1247 Tue Mar 15 11:15:35 2011 Child 0 finished creating 1539 directories.
1248 Tue Mar 15 11:15:35 2011 Child 0 will create 47090 files.
1249 Tue Mar 15 11:15:37 2011 Child 2 finished creating 1539 directories.
1250 Tue Mar 15 11:15:37 2011 Child 2 will create 47090 files.
1251 Tue Mar 15 11:16:15 2011 Child 7 finished creating 1539 directories.
1252 Tue Mar 15 11:16:15 2011 Child 7 will create 47090 files.
1253 Tue Mar 15 11:16:20 2011 Child 4 finished creating 1539 directories.
1254 Tue Mar 15 11:16:20 2011 Child 4 will create 47090 files.
1255 Tue Mar 15 11:16:37 2011 Child 1 finished creating 1539 directories.
1256 Tue Mar 15 11:16:37 2011 Child 1 will create 47090 files.
1257 Tue Mar 15 11:17:18 2011 Child 6 finished creating 1539 directories.
1258 Tue Mar 15 11:17:18 2011 Child 6 will create 47090 files.
1259 Tue Mar 15 11:17:40 2011 Child 3 finished creating 1539 directories.
1260 Tue Mar 15 11:17:40 2011 Child 3 will create 47090 files.
1261 Tue Mar 15 11:20:25 2011 Child 5 verified 43317 files (2829 creates).
1262 Tue Mar 15 11:20:36 2011 Child 0 verified 42842 files (2354 creates).
1263 Tue Mar 15 11:20:39 2011 Child 2 verified 42810 files (2322 creates).
1264 Tue Mar 15 11:21:17 2011 Child 7 verified 42549 files (2061 creates).
1265 Tue Mar 15 11:21:22 2011 Child 4 verified 42423 files (1935 creates).
1266 Tue Mar 15 11:21:38 2011 Child 1 verified 42237 files (1749 creates).
1267 Tue Mar 15 11:22:19 2011 Child 6 verified 42206 files (1718 creates).
1268 Tue Mar 15 11:22:41 2011 Child 3 verified 42182 files (1694 creates).
1269 Tue Mar 15 11:25:26 2011 Child 5 verified 45847 files (5359 creates).
1270 Tue Mar 15 11:25:38 2011 Child 0 verified 45347 files (4859 creates).
1271 Tue Mar 15 11:25:40 2011 Child 2 verified 45341 files (4853 creates).
1272 Tue Mar 15 11:26:18 2011 Child 7 verified 45084 files (4596 creates).
1273 Tue Mar 15 11:26:24 2011 Child 4 verified 44971 files (4483 creates).
1274 Tue Mar 15 11:26:35 2011 Child 5 verified 47090 files, created 6141
1275 Tue Mar 15 11:26:35 2011 Child 5 will create 3 symlinks.
1276 Tue Mar 15 11:26:35 2011 Child 5 finished creating 3 symlinks.
1277 Tue Mar 15 11:26:40 2011 Child 1 verified 44816 files (4328 creates).
1278 Tue Mar 15 11:27:20 2011 Child 6 verified 44905 files (4417 creates).
1279 Tue Mar 15 11:27:28 2011 Child 2 verified 47090 files, created 6141
1280 Tue Mar 15 11:27:28 2011 Child 2 will create 3 symlinks.
1281 Tue Mar 15 11:27:29 2011 Child 0 verified 47090 files, created 6141
1282 Tue Mar 15 11:27:29 2011 Child 0 will create 3 symlinks.
1283 Tue Mar 15 11:27:29 2011 Child 2 finished creating 3 symlinks.
1284 Tue Mar 15 11:27:29 2011 Child 0 finished creating 3 symlinks.
1285 Tue Mar 15 11:27:42 2011 Child 3 verified 44874 files (4386 creates).
1286 Tue Mar 15 11:28:10 2011 Child 7 verified 47090 files, created 6141
1287 Tue Mar 15 11:28:10 2011 Child 7 will create 3 symlinks.
1288 Tue Mar 15 11:28:10 2011 Child 7 finished creating 3 symlinks.
1289 Tue Mar 15 11:28:13 2011 Child 4 verified 47090 files, created 6141
1290 Tue Mar 15 11:28:13 2011 Child 4 will create 3 symlinks.
1291 Tue Mar 15 11:28:13 2011 Child 4 finished creating 3 symlinks.
1292 Tue Mar 15 11:28:21 2011 Child 1 verified 47090 files, created 6141
1293 Tue Mar 15 11:28:21 2011 Child 1 will create 3 symlinks.
1294 Tue Mar 15 11:28:21 2011 Child 1 finished creating 3 symlinks.
1295 Tue Mar 15 11:28:30 2011 Child 6 verified 47090 files, created 6141
1296 Tue Mar 15 11:28:30 2011 Child 6 will create 3 symlinks.
1297 Tue Mar 15 11:28:30 2011 Child 6 finished creating 3 symlinks.
1298 Tue Mar 15 11:28:34 2011 Child 3 verified 47090 files, created 6141
1299 Tue Mar 15 11:28:34 2011 Child 3 will create 3 symlinks.
1300 Tue Mar 15 11:28:34 2011 Child 3 finished creating 3 symlinks.
1301 Tue Mar 15 11:28:35 2011 Completed.
1302 Tue Mar 15 11:28:35 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1303 Tue Mar 15 11:28:35 2011 Completed.
1304 Tue Mar 15 11:28:35 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1305 Tue Mar 15 11:28:36 2011 Received.
1306 Tue Mar 15 11:28:36 2011 Performing 300 seconds pretest warmup.
1307 Tue Mar 15 11:33:36 2011 Completed.
1308 Tue Mar 15 11:33:36 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1309 Tue Mar 15 11:33:36 2011 Completed.
1310 Tue Mar 15 11:33:36 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1311 Tue Mar 15 11:33:37 2011 Received.
1312 Tue Mar 15 11:33:37 2011 Starting 300 seconds test run.
1313 SFS Single Client (c09-44) Results, Tue Mar 15 11:38:47 2011
1314 --------------------------------------------------------------------------------------
1315 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
1316 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
1317 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1318            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
1319 --------------------------------------------------------------------------------------
1320 getattr     26.0%    26.0%    13836    13836      0      4.68    37.74      0.10  2.5%
1321 setattr      4.0%     4.0%     2148     2148      0    335.83   483.11      0.93 28.3%
1322 lookup      24.0%    24.4%    12964    12964      0      5.86    49.89      0.12  3.0%
1323 readlink     1.0%     0.9%      502      502      0      5.72    30.22      0.48  0.1%
1324 read        18.0%    17.6%     9376    11432      0     67.42    79.73      0.18 24.8%
1325 write       10.0%    10.0%     5331     6461      0     40.40    84.68      0.25  8.5%
1326 create       1.0%     1.0%      510      510      0    648.25   683.34      2.27 13.0%
1327 remove       1.0%     0.9%      479      479      0    326.95   494.79      1.99  6.2%
1328 readdir      1.0%     1.0%      517      517      0      6.40    39.62      0.54  0.1%
1329 fsstat       1.0%     1.0%      520      520      0      4.27    10.24      0.28  0.1%
1330 access      11.0%    11.1%     5896     5896      0      5.23    41.62      0.16  1.2%
1331 commit       0.0%     0.0%        0     1826      0      0.00     0.00      0.00 11.8%
1332 readdirplus  2.0%     2.0%     1070     1070      0      9.24    58.59      0.46  0.4%
1333 --------------------------------------------------------------------------------------
1334
1335       --------------------------------------------------
1336       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1337       --------------------------+-----------------------
1338 SFS NFS V3 THROUGHPUT:  178.35 Ops/Sec   AVG. RESPONSE TIME:   47.89 Msec/Op
1339 TCP PROTOCOL
1340 FAST CALLS: 0
1341 NFS V3 MIXFILE: [ SFS Default ]
1342 CLIENT REQUESTED LOAD: 1600 Ops/Sec
1343 TOTAL LOGICAL NFS V3 OPERATIONS:  53149          TEST TIME: 298 Sec
1344 TOTAL PHYSICAL NFS V3 OPERATIONS: 58161
1345 PHYSICAL NFS V3 THROUGHPUT:  195.17 Ops/Sec
1346 FILE SET SIZE CREATED: 196113168.0 KB
1347 FILE SET SIZE ACCESSED: 58834800.0 - 58958580.0 KB  (100.00% to 100.21% of Base)
1348
1349 ------------------------------------------------------------------------
1350
1351 Tue Mar 15 11:38:47 2011 Completed.
1352
1353 Client Test Parameters:
1354         Number of processes = 8
1355         Requested Load (NFS V3 operations/second) = 1600
1356         Maximum number of outstanding biod writes = 8
1357         Maximum number of outstanding biod reads = 8
1358         Warm-up time (seconds) = 300
1359         Run time (seconds) = 300
1360         File Set = 369328 Files created for I/O operations
1361                    110792 Files accessed for I/O operations
1362                    7392 Files for non-I/O operations
1363                      24 Symlinks
1364                    12304 Directories
1365                         Additional non-I/O files created as necessary
1366
1367
1368 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1369 Tue Mar 15 11:38:47 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1370 Tue Mar 15 11:38:47 2011 Completed.
1371 Tue Mar 15 11:38:47 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1372
1373 ************************************************************************
1374 Tue Mar 15 11:38:48 2011 Received.
1375 Tue Mar 15 11:38:48 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1376 Tue Mar 15 11:38:48 2011 Completed.
1377 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 1800  -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 8 -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
1378 NFS V3 Protocol Version
1379
1380 ************************************************************************
1381 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1382 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1383
1384 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1385 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1386
1387 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 11:38:50 2011
1388         Client hostname = c09-44
1389         Prime Client hostname = c09-44.sysnet.ucsd.edu
1390
1391 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1392 NFS V3 Protocol
1393 Tue Mar 15 11:38:50 2011 Mounting 8 remote test directories.
1394 Child[000]: NFS negotiated block size 32768
1395 Child[001]: NFS negotiated block size 32768
1396 Child[002]: NFS negotiated block size 32768
1397 Child[003]: NFS negotiated block size 32768
1398 Child[004]: NFS negotiated block size 32768
1399 Child[005]: NFS negotiated block size 32768
1400 Child[006]: NFS negotiated block size 32768
1401 Child[007]: NFS negotiated block size 32768
1402 Tue Mar 15 11:39:02 2011 Completed.
1403 Tue Mar 15 11:39:02 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1404 Tue Mar 15 11:39:02 2011 Completed.
1405 Tue Mar 15 11:39:02 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1406 Tue Mar 15 11:39:06 2011 Received.
1407
1408 Tue Mar 15 11:39:06 2011 Initializing test directories.
1409 Tue Mar 15 11:39:06 2011 Child 7 will create 1729 directories.
1410 Tue Mar 15 11:39:06 2011 Child 6 will create 1729 directories.
1411 Tue Mar 15 11:39:06 2011 Child 5 will create 1729 directories.
1412 Tue Mar 15 11:39:06 2011 Child 2 will create 1729 directories.
1413 Tue Mar 15 11:39:06 2011 Child 3 will create 1729 directories.
1414 Tue Mar 15 11:39:06 2011 Child 4 will create 1729 directories.
1415 Tue Mar 15 11:39:06 2011 Child 1 will create 1729 directories.
1416 Tue Mar 15 11:39:06 2011 Child 0 will create 1729 directories.
1417 Tue Mar 15 11:39:06 2011 Child 5 finished creating 1729 directories.
1418 Tue Mar 15 11:39:06 2011 Child 5 will create 52881 files.
1419 Tue Mar 15 11:39:16 2011 Child 2 finished creating 1729 directories.
1420 Tue Mar 15 11:39:16 2011 Child 2 will create 52881 files.
1421 Tue Mar 15 11:40:10 2011 Child 6 finished creating 1729 directories.
1422 Tue Mar 15 11:40:10 2011 Child 6 will create 52881 files.
1423 Tue Mar 15 11:40:56 2011 Child 0 finished creating 1729 directories.
1424 Tue Mar 15 11:40:56 2011 Child 0 will create 52881 files.
1425 Tue Mar 15 11:41:03 2011 Child 4 finished creating 1729 directories.
1426 Tue Mar 15 11:41:03 2011 Child 4 will create 52881 files.
1427 Tue Mar 15 11:41:20 2011 Child 7 finished creating 1729 directories.
1428 Tue Mar 15 11:41:20 2011 Child 7 will create 52881 files.
1429 Tue Mar 15 11:41:50 2011 Child 3 finished creating 1729 directories.
1430 Tue Mar 15 11:41:50 2011 Child 3 will create 52881 files.
1431 Tue Mar 15 11:41:57 2011 Child 1 finished creating 1729 directories.
1432 Tue Mar 15 11:41:57 2011 Child 1 will create 52881 files.
1433 Tue Mar 15 11:44:08 2011 Child 5 verified 50893 files (4727 creates).
1434 Tue Mar 15 11:44:17 2011 Child 2 verified 50217 files (4051 creates).
1435 Tue Mar 15 11:45:11 2011 Child 6 verified 48870 files (2704 creates).
1436 Tue Mar 15 11:45:58 2011 Child 0 verified 48259 files (2093 creates).
1437 Tue Mar 15 11:46:05 2011 Child 4 verified 48183 files (2017 creates).
1438 Tue Mar 15 11:46:21 2011 Child 7 verified 48001 files (1835 creates).
1439 Tue Mar 15 11:46:50 2011 Child 5 verified 52881 files, created 6197
1440 Tue Mar 15 11:46:50 2011 Child 5 will create 3 symlinks.
1441 Tue Mar 15 11:46:50 2011 Child 5 finished creating 3 symlinks.
1442 Tue Mar 15 11:46:51 2011 Child 3 verified 48059 files (1893 creates).
1443 Tue Mar 15 11:46:58 2011 Child 1 verified 48019 files (1853 creates).
1444 Tue Mar 15 11:48:15 2011 Child 2 verified 52881 files, created 6197
1445 Tue Mar 15 11:48:15 2011 Child 2 will create 3 symlinks.
1446 Tue Mar 15 11:48:16 2011 Child 2 finished creating 3 symlinks.
1447 Tue Mar 15 11:50:13 2011 Child 6 verified 51757 files (5591 creates).
1448 Tue Mar 15 11:50:49 2011 Child 6 verified 52881 files, created 6197
1449 Tue Mar 15 11:50:49 2011 Child 6 will create 3 symlinks.
1450 Tue Mar 15 11:50:49 2011 Child 6 finished creating 3 symlinks.
1451 Tue Mar 15 11:50:59 2011 Child 0 verified 51380 files (5214 creates).
1452 Tue Mar 15 11:51:06 2011 Child 4 verified 51369 files (5203 creates).
1453 Tue Mar 15 11:51:22 2011 Child 7 verified 51204 files (5038 creates).
1454 Tue Mar 15 11:51:51 2011 Child 0 verified 52881 files, created 6197
1455 Tue Mar 15 11:51:51 2011 Child 0 will create 3 symlinks.
1456 Tue Mar 15 11:51:52 2011 Child 0 finished creating 3 symlinks.
1457 Tue Mar 15 11:51:52 2011 Child 3 verified 51503 files (5337 creates).
1458 Tue Mar 15 11:51:57 2011 Child 4 verified 52881 files, created 6197
1459 Tue Mar 15 11:51:57 2011 Child 4 will create 3 symlinks.
1460 Tue Mar 15 11:51:57 2011 Child 4 finished creating 3 symlinks.
1461 Tue Mar 15 11:51:59 2011 Child 1 verified 51600 files (5434 creates).
1462 Tue Mar 15 11:52:11 2011 Child 7 verified 52881 files, created 6197
1463 Tue Mar 15 11:52:11 2011 Child 7 will create 3 symlinks.
1464 Tue Mar 15 11:52:11 2011 Child 7 finished creating 3 symlinks.
1465 Tue Mar 15 11:52:14 2011 Child 3 verified 52881 files, created 6197
1466 Tue Mar 15 11:52:14 2011 Child 3 will create 3 symlinks.
1467 Tue Mar 15 11:52:14 2011 Child 3 finished creating 3 symlinks.
1468 Tue Mar 15 11:52:14 2011 Child 1 verified 52881 files, created 6197
1469 Tue Mar 15 11:52:14 2011 Child 1 will create 3 symlinks.
1470 Tue Mar 15 11:52:15 2011 Child 1 finished creating 3 symlinks.
1471 Tue Mar 15 11:52:15 2011 Completed.
1472 Tue Mar 15 11:52:15 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1473 Tue Mar 15 11:52:15 2011 Completed.
1474 Tue Mar 15 11:52:15 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1475 Tue Mar 15 11:52:15 2011 Received.
1476 Tue Mar 15 11:52:15 2011 Performing 300 seconds pretest warmup.
1477 Tue Mar 15 11:57:15 2011 Completed.
1478 Tue Mar 15 11:57:15 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1479 Tue Mar 15 11:57:15 2011 Completed.
1480 Tue Mar 15 11:57:15 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1481 Tue Mar 15 11:57:16 2011 Received.
1482 Tue Mar 15 11:57:16 2011 Starting 300 seconds test run.
1483 SFS Single Client (c09-44) Results, Tue Mar 15 12:02:26 2011
1484 --------------------------------------------------------------------------------------
1485 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
1486 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
1487 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1488            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
1489 --------------------------------------------------------------------------------------
1490 getattr     26.0%    26.3%    14152    14152      0      4.25    23.40      0.08  2.3%
1491 setattr      4.0%     4.0%     2129     2129      0    347.45   509.08      0.96 28.7%
1492 lookup      24.0%    23.7%    12724    12724      0      5.13    37.43      0.11  2.5%
1493 readlink     1.0%     1.0%      560      560      0      4.42    12.27      0.29  0.1%
1494 read        18.0%    18.2%     9756    12094      0     71.93    83.49      0.18 27.2%
1495 write       10.0%     9.9%     5293     6297      0     38.16    71.33      0.23  7.8%
1496 create       1.0%     0.9%      508      508      0    554.04   539.29      2.02 10.9%
1497 remove       1.0%     1.0%      551      551      0    335.54   497.85      1.86  7.2%
1498 readdir      1.0%     1.0%      535      535      0      8.86    58.83      0.65  0.2%
1499 fsstat       1.0%     1.0%      515      515      0      3.88    10.96      0.29  0.1%
1500 access      11.0%    11.0%     5926     5926      0      5.25    35.54      0.15  1.2%
1501 commit       0.0%     0.0%        0     1815      0      0.00     0.00      0.00 11.4%
1502 readdirplus  2.0%     2.0%     1080     1080      0      6.97    29.21      0.32  0.3%
1503 --------------------------------------------------------------------------------------
1504
1505       --------------------------------------------------
1506       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1507       --------------------------+-----------------------
1508 SFS NFS V3 THROUGHPUT:  179.69 Ops/Sec   AVG. RESPONSE TIME:   47.97 Msec/Op
1509 TCP PROTOCOL
1510 FAST CALLS: 0
1511 NFS V3 MIXFILE: [ SFS Default ]
1512 CLIENT REQUESTED LOAD: 1800 Ops/Sec
1513 TOTAL LOGICAL NFS V3 OPERATIONS:  53729          TEST TIME: 299 Sec
1514 TOTAL PHYSICAL NFS V3 OPERATIONS: 58886
1515 PHYSICAL NFS V3 THROUGHPUT:  196.94 Ops/Sec
1516 FILE SET SIZE CREATED: 220233312.0 KB
1517 FILE SET SIZE ACCESSED: 66073392.0 - 66190936.0 KB  (100.00% to 100.18% of Base)
1518
1519 ------------------------------------------------------------------------
1520
1521 Tue Mar 15 12:02:26 2011 Completed.
1522
1523 Client Test Parameters:
1524         Number of processes = 8
1525         Requested Load (NFS V3 operations/second) = 1800
1526         Maximum number of outstanding biod writes = 8
1527         Maximum number of outstanding biod reads = 8
1528         Warm-up time (seconds) = 300
1529         Run time (seconds) = 300
1530         File Set = 414752 Files created for I/O operations
1531                    124424 Files accessed for I/O operations
1532                    8296 Files for non-I/O operations
1533                      24 Symlinks
1534                    13824 Directories
1535                         Additional non-I/O files created as necessary
1536
1537
1538 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1539 Tue Mar 15 12:02:26 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1540 Tue Mar 15 12:02:26 2011 Completed.
1541 Tue Mar 15 12:02:26 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1542
1543 ************************************************************************
1544 Tue Mar 15 12:02:27 2011 Received.
1545 Tue Mar 15 12:02:27 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1546 Tue Mar 15 12:02:27 2011 Completed.
1547 Started on client (c09-44): ../binaries/linux-x86/sfsnfs3 -N 1 -l 2000  -t 300 -a 30 -A 70 -R 8 -W 8 -D 30 -S 20 -Q -p 8 -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
1548 NFS V3 Protocol Version
1549
1550 ************************************************************************
1551 ../binaries/linux-x86/sfsnfs3: NFS User ID only supported on Windows client
1552 ../binaries/linux-x86/sfsnfs3: NFS Group ID only supported on Windows client
1553
1554 c09-44: Good clock resolution [ 1.000000 ] Micro seconds.
1555 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1556
1557 SFS NFS V3 Benchmark Client Logfile, Tue Mar 15 12:02:29 2011
1558         Client hostname = c09-44
1559         Prime Client hostname = c09-44.sysnet.ucsd.edu
1560
1561 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
1562 NFS V3 Protocol
1563 Tue Mar 15 12:02:29 2011 Mounting 8 remote test directories.
1564 Child[000]: NFS negotiated block size 32768
1565 Child[001]: NFS negotiated block size 32768
1566 Child[002]: NFS negotiated block size 32768
1567 Child[003]: NFS negotiated block size 32768
1568 Child[004]: NFS negotiated block size 32768
1569 Child[005]: NFS negotiated block size 32768
1570 Child[006]: NFS negotiated block size 32768
1571 Child[007]: NFS negotiated block size 32768
1572 Tue Mar 15 12:02:41 2011 Completed.
1573 Tue Mar 15 12:02:41 2011 Sending DONE-MOUNT message to Prime Client(c09-44.sysnet.ucsd.edu).
1574 Tue Mar 15 12:02:41 2011 Completed.
1575 Tue Mar 15 12:02:41 2011 Waiting on DO-INIT message from Prime Client(c09-44.sysnet.ucsd.edu).
1576 Tue Mar 15 12:02:45 2011 Received.
1577
1578 Tue Mar 15 12:02:45 2011 Initializing test directories.
1579 Tue Mar 15 12:02:45 2011 Child 7 will create 1926 directories.
1580 Tue Mar 15 12:02:45 2011 Child 5 will create 1926 directories.
1581 Tue Mar 15 12:02:45 2011 Child 4 will create 1926 directories.
1582 Tue Mar 15 12:02:45 2011 Child 1 will create 1926 directories.
1583 Tue Mar 15 12:02:45 2011 Child 6 will create 1926 directories.
1584 Tue Mar 15 12:02:45 2011 Child 3 will create 1926 directories.
1585 Tue Mar 15 12:02:45 2011 Child 0 will create 1926 directories.
1586 Tue Mar 15 12:02:45 2011 Child 2 will create 1926 directories.
1587 Tue Mar 15 12:02:49 2011 Child 1 finished creating 1926 directories.
1588 Tue Mar 15 12:02:49 2011 Child 1 will create 58925 files.
1589 Tue Mar 15 12:03:06 2011 Child 7 finished creating 1926 directories.
1590 Tue Mar 15 12:03:06 2011 Child 7 will create 58925 files.
1591 Tue Mar 15 12:03:36 2011 Child 2 finished creating 1926 directories.
1592 Tue Mar 15 12:03:36 2011 Child 2 will create 58925 files.
1593 Tue Mar 15 12:03:48 2011 Child 4 finished creating 1926 directories.
1594 Tue Mar 15 12:03:48 2011 Child 4 will create 58925 files.
1595 Tue Mar 15 12:04:25 2011 Child 3 finished creating 1926 directories.
1596 Tue Mar 15 12:04:25 2011 Child 3 will create 58925 files.
1597 Tue Mar 15 12:04:49 2011 Child 5 finished creating 1926 directories.
1598 Tue Mar 15 12:04:49 2011 Child 5 will create 58925 files.
1599 Tue Mar 15 12:05:36 2011 Child 0 finished creating 1926 directories.
1600 Tue Mar 15 12:05:36 2011 Child 0 will create 58925 files.
1601 Tue Mar 15 12:05:40 2011 Child 6 finished creating 1926 directories.
1602 Tue Mar 15 12:05:40 2011 Child 6 will create 58925 files.
1603 Tue Mar 15 12:07:50 2011 Child 1 verified 55480 files (3636 creates).
1604 Tue Mar 15 12:08:08 2011 Child 7 verified 54679 files (2835 creates).
1605 Tue Mar 15 12:08:42 2011 Child 2 verified 54374 files (2530 creates).
1606 Tue Mar 15 12:08:49 2011 Child 4 verified 54122 files (2278 creates).
1607 Tue Mar 15 12:09:27 2011 Child 3 verified 53831 files (1987 creates).
1608 Tue Mar 15 12:09:52 2011 Child 5 verified 53786 files (1942 creates).
1609 Tue Mar 15 12:10:37 2011 Child 0 verified 53496 files (1652 creates).
1610 Tue Mar 15 12:10:41 2011 Child 6 verified 53486 files (1642 creates).
1611 Tue Mar 15 12:13:06 2011 Child 1 verified 58925 files, created 6504
1612 Tue Mar 15 12:13:06 2011 Child 1 will create 3 symlinks.
1613 Tue Mar 15 12:13:06 2011 Child 1 finished creating 3 symlinks.
1614 Tue Mar 15 12:13:12 2011 Child 7 verified 57240 files (5396 creates).
1615 Tue Mar 15 12:13:45 2011 Child 2 verified 57004 files (5160 creates).
1616 Tue Mar 15 12:13:50 2011 Child 4 verified 56638 files (4794 creates).
1617 Tue Mar 15 12:14:28 2011 Child 3 verified 56498 files (4654 creates).
1618 Tue Mar 15 12:14:38 2011 Child 7 verified 58925 files, created 6504
1619 Tue Mar 15 12:14:38 2011 Child 7 will create 3 symlinks.
1620 Tue Mar 15 12:14:38 2011 Child 7 finished creating 3 symlinks.
1621 Tue Mar 15 12:14:52 2011 Child 5 verified 56534 files (4690 creates).
1622 Tue Mar 15 12:15:18 2011 Child 2 verified 58925 files, created 6504
1623 Tue Mar 15 12:15:18 2011 Child 2 will create 3 symlinks.
1624 Tue Mar 15 12:15:18 2011 Child 2 finished creating 3 symlinks.
1625 Tue Mar 15 12:15:37 2011 Child 4 verified 58925 files, created 6504
1626 Tue Mar 15 12:15:37 2011 Child 4 will create 3 symlinks.
1627 Tue Mar 15 12:15:37 2011 Child 4 finished creating 3 symlinks.
1628 Tue Mar 15 12:15:38 2011 Child 0 verified 56525 files (4681 creates).
1629 Tue Mar 15 12:15:42 2011 Child 6 verified 56651 files (4807 creates).
1630 Tue Mar 15 12:16:01 2011 Child 3 verified 58925 files, created 6504
1631 Tue Mar 15 12:16:01 2011 Child 3 will create 3 symlinks.
1632 Tue Mar 15 12:16:02 2011 Child 3 finished creating 3 symlinks.
1633 Tue Mar 15 12:16:10 2011 Child 5 verified 58925 files, created 6504
1634 Tue Mar 15 12:16:10 2011 Child 5 will create 3 symlinks.
1635 Tue Mar 15 12:16:10 2011 Child 5 finished creating 3 symlinks.
1636 Tue Mar 15 12:16:21 2011 Child 6 verified 58925 files, created 6504
1637 Tue Mar 15 12:16:21 2011 Child 6 will create 3 symlinks.
1638 Tue Mar 15 12:16:21 2011 Child 6 finished creating 3 symlinks.
1639 Tue Mar 15 12:16:21 2011 Child 0 verified 58925 files, created 6504
1640 Tue Mar 15 12:16:21 2011 Child 0 will create 3 symlinks.
1641 Tue Mar 15 12:16:21 2011 Child 0 finished creating 3 symlinks.
1642 Tue Mar 15 12:16:22 2011 Completed.
1643 Tue Mar 15 12:16:22 2011 Sending DONE-INIT message to Prime Client(c09-44.sysnet.ucsd.edu).
1644 Tue Mar 15 12:16:22 2011 Completed.
1645 Tue Mar 15 12:16:22 2011 Waiting on DO-WARMUP message from Prime Client(c09-44.sysnet.ucsd.edu).
1646 Tue Mar 15 12:16:23 2011 Received.
1647 Tue Mar 15 12:16:23 2011 Performing 300 seconds pretest warmup.
1648 Tue Mar 15 12:21:23 2011 Completed.
1649 Tue Mar 15 12:21:23 2011 Sending READY message to Prime Client(c09-44.sysnet.ucsd.edu).
1650 Tue Mar 15 12:21:23 2011 Completed.
1651 Tue Mar 15 12:21:23 2011 Waiting on START message from Prime Client(c09-44.sysnet.ucsd.edu).
1652 Tue Mar 15 12:21:24 2011 Received.
1653 Tue Mar 15 12:21:24 2011 Starting 300 seconds test run.
1654 SFS Single Client (c09-44) Results, Tue Mar 15 12:26:34 2011
1655 --------------------------------------------------------------------------------------
1656 NFS V3     Target   Actual  NFS Op  NFS Op    NFS    Mean     Std Dev  Std Error Pcnt
1657 Op         Logical  Logical Logical Physical  Op     Response Response of Mean,  of
1658 Type       Mix      Mix     Success Success   Error  Time     Time     95% Conf  Total
1659            Pcnt     Pcnt    Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
1660 --------------------------------------------------------------------------------------
1661 getattr     26.0%    26.0%    13080    13080      0      5.27    49.49      0.12  2.7%
1662 setattr      4.0%     4.0%     2019     2019      0    345.20   503.58      0.98 27.2%
1663 lookup      24.0%    23.7%    11898    11898      0      5.90    46.05      0.12  2.7%
1664 readlink     1.0%     0.9%      474      474      0      3.21    10.59      0.29  0.1%
1665 read        18.0%    18.0%     9038    11165      0     75.27    86.52      0.19 26.5%
1666 write       10.0%    10.1%     5059     6126      0     41.54    87.48      0.26  8.2%
1667 create       1.0%     1.0%      522      522      0    693.53   680.23      2.24 14.1%
1668 remove       1.0%     1.0%      479      479      0    300.77   434.61      1.87  5.6%
1669 readdir      1.0%     1.0%      484      484      0      4.32    10.60      0.29  0.1%
1670 fsstat       1.0%     1.0%      509      509      0      6.67    44.72      0.58  0.1%
1671 access      11.0%    11.3%     5662     5662      0      7.03    63.04      0.21  1.6%
1672 commit       0.0%     0.0%        0     1734      0      0.00     0.00      0.00 10.8%
1673 readdirplus  2.0%     2.0%      998      998      0      7.54    33.17      0.36  0.3%
1674 --------------------------------------------------------------------------------------
1675
1676       --------------------------------------------------
1677       |   SPEC SFS 2008 SINGLE CLIENT RESULTS SUMMARY  |
1678       --------------------------+-----------------------
1679 SFS NFS V3 THROUGHPUT:  167.96 Ops/Sec   AVG. RESPONSE TIME:   51.03 Msec/Op
1680 TCP PROTOCOL
1681 FAST CALLS: 0
1682 NFS V3 MIXFILE: [ SFS Default ]
1683 CLIENT REQUESTED LOAD: 2000 Ops/Sec
1684 TOTAL LOGICAL NFS V3 OPERATIONS:  50222          TEST TIME: 299 Sec
1685 TOTAL PHYSICAL NFS V3 OPERATIONS: 55150
1686 PHYSICAL NFS V3 THROUGHPUT:  184.44 Ops/Sec
1687 FILE SET SIZE CREATED: 245402720.0 KB
1688 FILE SET SIZE ACCESSED: 73622088.0 - 73731952.0 KB  (100.00% to 100.15% of Base)
1689
1690 ------------------------------------------------------------------------
1691
1692 Tue Mar 15 12:26:34 2011 Completed.
1693
1694 Client Test Parameters:
1695         Number of processes = 8
1696         Requested Load (NFS V3 operations/second) = 2000
1697         Maximum number of outstanding biod writes = 8
1698         Maximum number of outstanding biod reads = 8
1699         Warm-up time (seconds) = 300
1700         Run time (seconds) = 300
1701         File Set = 462152 Files created for I/O operations
1702                    138640 Files accessed for I/O operations
1703                    9248 Files for non-I/O operations
1704                      24 Symlinks
1705                    15400 Directories
1706                         Additional non-I/O files created as necessary
1707
1708
1709 SPEC SFS 2008 Benchmark, Creation - 1 February 2008
1710 Tue Mar 15 12:26:34 2011 Sending DONE-TEST message to Prime Client(c09-44.sysnet.ucsd.edu).
1711 Tue Mar 15 12:26:34 2011 Completed.
1712 Tue Mar 15 12:26:34 2011 Waiting on MOVE-DATA message from Prime Client(c09-44.sysnet.ucsd.edu).
1713
1714 ************************************************************************
1715 Tue Mar 15 12:26:35 2011 Received.
1716 Tue Mar 15 12:26:35 2011 Sending results to Prime Client(c09-44.sysnet.ucsd.edu)
1717 Tue Mar 15 12:26:35 2011 Completed.