results/20110227a/sfslog.20110227-cifs-bluesky-smallcache

   1 Mon Feb 28 05:34:57 PST 2011 Configuration parameters passed validation
   2
   3 Mon Feb 28 05:34:57 PST 2011 ========================================================================
   4 SFS Benchmark Prime Client Logfile.
   5         Creation Date: Mon Feb 28 05:34:57 PST 2011
   6         Prime Client hostname: c09-44.sysnet.ucsd.edu
   7 Mon Feb 28 05:35:02 PST 2011         Number of Clients: 1
   8         Client hostname(s): c09-44.sysnet.ucsd.edu
   9
  10 Mon Feb 28 05:35:02 PST 2011 SfsManager: Started sfs_syncd on c09-44.sysnet.ucsd.edu
  11 Mon Feb 28 05:35:12 PST 2011
  12 ************************************************************************
  13 Mon Feb 28 05:35:12 PST 2011 Test Run 1 of 20
  14
  15 Mon Feb 28 05:35:12 PST 2011 Mon Feb 28 05:35:12 PST 2011 c09-44.sysnet.ucsd.edu start:
  16 Mon Feb 28 05:35:12 PST 2011         sfscifs -N 1 -l 50  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
  17
  18 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
  19 Executing SFS Benchmark on 1 Client(s).
  20 Mon Feb 28 05:35:27 2011 Waiting on DONE-MOUNT message from 1 client(s).
  21
  22 ../binaries/linux-x86/sfs_prime: Caught Signal 2 SIGINT
  23
  24 Sending interupt signal to clients ... c09-44.sysnet.ucsd.edu: RPC: Unable to receive; errno = Connection reset by peer
  25 Error calling signal_sfs_clients. Exit(9)
  26 Mon Feb 28 05:37:08 PST 2011 Configuration parameters passed validation
  27
  28 Mon Feb 28 05:37:08 PST 2011 ========================================================================
  29 SFS Benchmark Prime Client Logfile.
  30         Creation Date: Mon Feb 28 05:37:08 PST 2011
  31         Prime Client hostname: c09-44.sysnet.ucsd.edu
  32 Mon Feb 28 05:37:13 PST 2011         Number of Clients: 1
  33         Client hostname(s): c09-44.sysnet.ucsd.edu
  34
  35 Mon Feb 28 05:37:13 PST 2011 SfsManager: Started sfs_syncd on c09-44.sysnet.ucsd.edu
  36 Mon Feb 28 05:37:23 PST 2011
  37 ************************************************************************
  38 Mon Feb 28 05:37:23 PST 2011 Test Run 1 of 20
  39
  40 Mon Feb 28 05:37:23 PST 2011 Mon Feb 28 05:37:23 PST 2011 c09-44.sysnet.ucsd.edu start:
  41 Mon Feb 28 05:37:23 PST 2011         sfscifs -N 1 -l 50  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
  42
  43 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
  44 Executing SFS Benchmark on 1 Client(s).
  45 Mon Feb 28 05:37:38 2011 Waiting on DONE-MOUNT message from 1 client(s).
  46 Mon Feb 28 05:37:39 2011 Received.
  47 Mon Feb 28 05:37:39 2011 Sending DO-INIT message to 1 client(s).
  48 Mon Feb 28 05:37:39 2011 Completed.
  49 Mon Feb 28 05:37:39 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
  50 Mon Feb 28 05:46:48 2011 Received.
  51 Mon Feb 28 05:46:48 2011 Sending DO-WARMUP message to 1 client(s).
  52 Mon Feb 28 05:46:48 2011 Completed.
  53 Mon Feb 28 05:46:48 2011 Waiting on READY message from 1 client(s).
  54 Mon Feb 28 05:51:49 2011 Received.
  55 Mon Feb 28 05:51:49 2011 Sending START message to 1 client(s).
  56 Mon Feb 28 05:51:49 2011 Completed.
  57 Mon Feb 28 05:56:49 2011 Sending STOP message to 1 client(s).
  58 Mon Feb 28 05:56:49 2011 Completed.
  59 Mon Feb 28 05:56:49 2011 Waiting on DONE-TEST message from 1 client(s).
  60 Mon Feb 28 05:57:00 2011 Received.
  61 Mon Feb 28 05:57:00 2011 Sending MOVE-DATA message to 1 client(s).
  62 Mon Feb 28 05:57:00 2011 Completed.
  63 Mon Feb 28 05:57:00 2011 Waiting on SEND-DATA message from 1 client(s).
  64 Mon Feb 28 05:57:01 2011 Received.
  65 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
  66 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 50 -C ../result/sfssum.20110227-cifs-bluesky-smallcache -c -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu
  67
  68 Aggregate Test Parameters:
  69     Number of processes = 4
  70     Requested Load (CIFS operations/second) = 50
  71     Maximum number of outstanding biod writes = 2
  72     Maximum number of outstanding biod reads = 2
  73     Warm-up time (seconds) = 300
  74     Run time (seconds) = 300
  75     File Set =   9876 Files created for I/O operations
  76                  2960 Files accessed for I/O operations
  77                   200 Files for non-I/O operations
  78                    24 Symlinks
  79                   328 Directories
  80                       Additional non-I/O files created as necessary
  81
  82 SFS Aggregate Results for 1 Client(s), Mon Feb 28 05:57:01 2011
  83 CIFS Protocol
  84
  85 ---------------------------------------------------------------------------------------------------------
  86 CIFS                             Target Actual CIFS Op CIFS Op   CIFS   Mean     Std Dev  Std Error Pcnt
  87 Op                               CIFS   CIFS   Logical Physical  Op     Response Response of Mean,  of
  88 Type                             Mix    Mix    Success Success   Error  Time     Time     95% Conf  Total
  89                                  Pcnt   Pcnt   Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
  90 ---------------------------------------------------------------------------------------------------------
  91 ECHO                              0.5%   0.5%       76       76      0      0.13     0.01      0.02  0.0%
  92 LOCKING_ANDX                      1.1%   0.9%      142      142      0      0.14     0.01      0.01  0.0%
  93 NT_TRANSACT_QUERY_SECURITY_DES    1.6%   1.5%      229      229      0      0.20     0.02      0.02  0.0%
  94 READ_ANDX                        20.5%  20.2%     3023     3256      0     32.38    85.76      0.33 79.3%
  95 TRANS2_QUERY_FS_INFORMATION       1.6%   1.7%      250      250      0      0.16     0.01      0.01  0.0%
  96 TRANS2_QUERY_FILE_INFORMATION    12.9%  11.9%     1785     1785      0      0.20     0.05      0.01  0.3%
  97 TRANS2_QUERY_PATH_INFORMATION    21.5%  22.4%     3358     3358      0      0.21     0.03      0.01  0.6%
  98 TRANS2_SET_FILE_INFORMATION       3.2%   3.2%      483      483      0      0.16     0.01      0.01  0.1%
  99 TRANS2_FIND_FIRST2                8.6%   9.0%     1351     1351      0      0.31     0.02      0.01  0.3%
 100 WRITE_ANDX                        8.6%   8.7%     1300     1410      0     17.73    62.65      0.43 18.7%
 101 NT_CREATE_ANDX                    9.7%   9.7%     1460     1460      0      0.21     0.02      0.01  0.2%
 102 CLOSE                             9.7%   9.7%     1460     1460      0      0.15     0.08      0.01  0.2%
 103 FLUSH                             0.5%   0.5%       74       74      0      3.04     1.94      0.32  0.2%
 104 ---------------------------------------------------------------------------------------------------------
 105
 106         ---------------------------------------------
 107         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
 108         ---------------------------------------------
 109 SFS CIFS THROUGHPUT:      50 Ops/Sec   AVG. RESPONSE TIME:     8.2 Msec/Op
 110 TCP PROTOCOL (IPv4)
 111 CIFS MIXFILE: [ SFS default ]
 112 AGGREGATE REQUESTED LOAD: 50 Ops/Sec
 113 TOTAL LOGICAL CIFS OPERATIONS:  14991          TEST TIME: 300 Sec
 114 TOTAL PHYSICAL CIFS OPERATIONS: 15334
 115 PHYSICAL CIFS IO THROUGHPUT: 51 Ops/sec
 116 NUMBER OF SFS CLIENTS: 1
 117 TOTAL FILE SET SIZE CREATED: 5121.2 MB
 118 TOTAL FILE SET SIZE ACCESSED: 1537.0 - 1571.2 MB  (100.00% to 102.23% of Base)
 119
 120 ------------------------------------------------------------------------
 121
 122 Mon Feb 28 05:57:02 PST 2011
 123 ************************************************************************
 124 Mon Feb 28 05:57:02 PST 2011
 125 ************************************************************************
 126 Mon Feb 28 05:57:02 PST 2011 Test Run 2 of 20
 127
 128 Mon Feb 28 05:57:02 PST 2011 Mon Feb 28 05:57:02 PST 2011 c09-44.sysnet.ucsd.edu start:
 129 Mon Feb 28 05:57:02 PST 2011         sfscifs -N 1 -l 100  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
 130
 131 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 132 Executing SFS Benchmark on 1 Client(s).
 133 Mon Feb 28 05:57:17 2011 Waiting on DONE-MOUNT message from 1 client(s).
 134 Mon Feb 28 05:57:18 2011 Received.
 135 Mon Feb 28 05:57:18 2011 Sending DO-INIT message to 1 client(s).
 136 Mon Feb 28 05:57:18 2011 Completed.
 137 Mon Feb 28 05:57:18 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
 138 Mon Feb 28 06:09:19 2011 Received.
 139 Mon Feb 28 06:09:19 2011 Sending DO-WARMUP message to 1 client(s).
 140 Mon Feb 28 06:09:19 2011 Completed.
 141 Mon Feb 28 06:09:19 2011 Waiting on READY message from 1 client(s).
 142 Mon Feb 28 06:14:20 2011 Received.
 143 Mon Feb 28 06:14:20 2011 Sending START message to 1 client(s).
 144 Mon Feb 28 06:14:20 2011 Completed.
 145 Mon Feb 28 06:19:20 2011 Sending STOP message to 1 client(s).
 146 Mon Feb 28 06:19:20 2011 Completed.
 147 Mon Feb 28 06:19:20 2011 Waiting on DONE-TEST message from 1 client(s).
 148 Mon Feb 28 06:19:31 2011 Received.
 149 Mon Feb 28 06:19:31 2011 Sending MOVE-DATA message to 1 client(s).
 150 Mon Feb 28 06:19:31 2011 Completed.
 151 Mon Feb 28 06:19:31 2011 Waiting on SEND-DATA message from 1 client(s).
 152 Mon Feb 28 06:19:32 2011 Received.
 153 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 154 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 100 -C ../result/sfssum.20110227-cifs-bluesky-smallcache -c -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu
 155
 156 Aggregate Test Parameters:
 157     Number of processes = 4
 158     Requested Load (CIFS operations/second) = 100
 159     Maximum number of outstanding biod writes = 2
 160     Maximum number of outstanding biod reads = 2
 161     Warm-up time (seconds) = 300
 162     Run time (seconds) = 300
 163     File Set =  21728 Files created for I/O operations
 164                  6516 Files accessed for I/O operations
 165                   436 Files for non-I/O operations
 166                    24 Symlinks
 167                   724 Directories
 168                       Additional non-I/O files created as necessary
 169
 170 SFS Aggregate Results for 1 Client(s), Mon Feb 28 06:19:32 2011
 171 CIFS Protocol
 172
 173 ---------------------------------------------------------------------------------------------------------
 174 CIFS                             Target Actual CIFS Op CIFS Op   CIFS   Mean     Std Dev  Std Error Pcnt
 175 Op                               CIFS   CIFS   Logical Physical  Op     Response Response of Mean,  of
 176 Type                             Mix    Mix    Success Success   Error  Time     Time     95% Conf  Total
 177                                  Pcnt   Pcnt   Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 178 ---------------------------------------------------------------------------------------------------------
 179 ECHO                              0.5%   0.4%      133      133      0      0.14     0.01      0.02  0.0%
 180 LOCKING_ANDX                      1.1%   1.0%      290      290      0      0.14     0.02      0.02  0.0%
 181 NT_TRANSACT_QUERY_SECURITY_DES    1.6%   1.6%      474      474      0      0.20     0.02      0.01  0.0%
 182 READ_ANDX                        20.5%  20.3%     6108     6587      0     40.42    88.13      0.24 84.2%
 183 TRANS2_QUERY_FS_INFORMATION       1.6%   1.7%      510      510      0      0.16     0.03      0.02  0.0%
 184 TRANS2_QUERY_FILE_INFORMATION    12.9%  12.6%     3777     3777      0      0.20     0.10      0.01  0.3%
 185 TRANS2_QUERY_PATH_INFORMATION    21.5%  22.3%     6701     6701      0      0.21     0.07      0.01  0.5%
 186 TRANS2_SET_FILE_INFORMATION       3.2%   3.2%      963      963      0      0.16     0.03      0.01  0.1%
 187 TRANS2_FIND_FIRST2                8.6%   8.6%     2573     2573      0      0.48     0.08      0.01  0.4%
 188 WRITE_ANDX                        8.6%   8.4%     2517     2692      0     16.25    53.45      0.29 14.0%
 189 NT_CREATE_ANDX                    9.7%   9.8%     2956     2956      0      0.21     0.15      0.01  0.2%
 190 CLOSE                             9.7%   9.8%     2956     2956      0      0.15     0.06      0.01  0.2%
 191 FLUSH                             0.5%   0.4%      132      132      0      3.45     3.45      0.32  0.2%
 192 ---------------------------------------------------------------------------------------------------------
 193
 194         ---------------------------------------------
 195         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
 196         ---------------------------------------------
 197 SFS CIFS THROUGHPUT:     101 Ops/Sec   AVG. RESPONSE TIME:     9.7 Msec/Op
 198 TCP PROTOCOL (IPv4)
 199 CIFS MIXFILE: [ SFS default ]
 200 AGGREGATE REQUESTED LOAD: 100 Ops/Sec
 201 TOTAL LOGICAL CIFS OPERATIONS:  30090          TEST TIME: 299 Sec
 202 TOTAL PHYSICAL CIFS OPERATIONS: 30744
 203 PHYSICAL CIFS IO THROUGHPUT: 102 Ops/sec
 204 NUMBER OF SFS CLIENTS: 1
 205 TOTAL FILE SET SIZE CREATED: 11267.2 MB
 206 TOTAL FILE SET SIZE ACCESSED: 3381.0 - 3444.5 MB  (100.00% to 101.88% of Base)
 207
 208 ------------------------------------------------------------------------
 209
 210 Mon Feb 28 06:19:33 PST 2011
 211 ************************************************************************
 212 Mon Feb 28 06:19:33 PST 2011
 213 ************************************************************************
 214 Mon Feb 28 06:19:33 PST 2011 Test Run 3 of 20
 215
 216 Mon Feb 28 06:19:33 PST 2011 Mon Feb 28 06:19:33 PST 2011 c09-44.sysnet.ucsd.edu start:
 217 Mon Feb 28 06:19:33 PST 2011         sfscifs -N 1 -l 150  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
 218
 219 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 220 Executing SFS Benchmark on 1 Client(s).
 221 Mon Feb 28 06:19:48 2011 Waiting on DONE-MOUNT message from 1 client(s).
 222 Mon Feb 28 06:19:49 2011 Received.
 223 Mon Feb 28 06:19:49 2011 Sending DO-INIT message to 1 client(s).
 224 Mon Feb 28 06:19:49 2011 Completed.
 225 Mon Feb 28 06:19:49 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
 226 Mon Feb 28 06:29:41 2011 Received.
 227 Mon Feb 28 06:29:41 2011 Sending DO-WARMUP message to 1 client(s).
 228 Mon Feb 28 06:29:41 2011 Completed.
 229 Mon Feb 28 06:29:41 2011 Waiting on READY message from 1 client(s).
 230 Mon Feb 28 06:34:42 2011 Received.
 231 Mon Feb 28 06:34:42 2011 Sending START message to 1 client(s).
 232 Mon Feb 28 06:34:42 2011 Completed.
 233 Mon Feb 28 06:39:42 2011 Sending STOP message to 1 client(s).
 234 Mon Feb 28 06:39:42 2011 Completed.
 235 Mon Feb 28 06:39:42 2011 Waiting on DONE-TEST message from 1 client(s).
 236 Mon Feb 28 06:39:53 2011 Received.
 237 Mon Feb 28 06:39:53 2011 Sending MOVE-DATA message to 1 client(s).
 238 Mon Feb 28 06:39:53 2011 Completed.
 239 Mon Feb 28 06:39:53 2011 Waiting on SEND-DATA message from 1 client(s).
 240 Mon Feb 28 06:39:54 2011 Received.
 241 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 242 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 150 -C ../result/sfssum.20110227-cifs-bluesky-smallcache -c -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu
 243
 244 Aggregate Test Parameters:
 245     Number of processes = 4
 246     Requested Load (CIFS operations/second) = 150
 247     Maximum number of outstanding biod writes = 2
 248     Maximum number of outstanding biod reads = 2
 249     Warm-up time (seconds) = 300
 250     Run time (seconds) = 300
 251     File Set =  33576 Files created for I/O operations
 252                 10072 Files accessed for I/O operations
 253                   672 Files for non-I/O operations
 254                    24 Symlinks
 255                  1116 Directories
 256                       Additional non-I/O files created as necessary
 257
 258 SFS Aggregate Results for 1 Client(s), Mon Feb 28 06:39:54 2011
 259 CIFS Protocol
 260
 261 ---------------------------------------------------------------------------------------------------------
 262 CIFS                             Target Actual CIFS Op CIFS Op   CIFS   Mean     Std Dev  Std Error Pcnt
 263 Op                               CIFS   CIFS   Logical Physical  Op     Response Response of Mean,  of
 264 Type                             Mix    Mix    Success Success   Error  Time     Time     95% Conf  Total
 265                                  Pcnt   Pcnt   Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 266 ---------------------------------------------------------------------------------------------------------
 267 ECHO                              0.5%   0.5%      223      223      0      0.15     0.12      0.05  0.0%
 268 LOCKING_ANDX                      1.1%   1.3%      581      581      0      0.15     0.05      0.02  0.0%
 269 NT_TRANSACT_QUERY_SECURITY_DES    1.6%   1.7%      760      760      0      0.20     0.07      0.02  0.0%
 270 READ_ANDX                        20.5%  20.0%     9047     9783      0     41.30    90.84      0.20 82.2%
 271 TRANS2_QUERY_FS_INFORMATION       1.6%   1.6%      729      729      0      0.16     0.04      0.01  0.0%
 272 TRANS2_QUERY_FILE_INFORMATION    12.9%  13.6%     6139     6139      0      0.20     0.14      0.01  0.3%
 273 TRANS2_QUERY_PATH_INFORMATION    21.5%  21.4%     9666     9666      0      0.22     0.13      0.01  0.5%
 274 TRANS2_SET_FILE_INFORMATION       3.2%   3.3%     1487     1487      0      0.16     0.05      0.01  0.1%
 275 TRANS2_FIND_FIRST2                8.6%   8.5%     3817     3817      0      0.67     0.07      0.01  0.6%
 276 WRITE_ANDX                        8.6%   8.3%     3761     4015      0     19.07    60.88      0.25 15.8%
 277 NT_CREATE_ANDX                    9.7%   9.7%     4363     4363      0      0.22     0.12      0.01  0.2%
 278 CLOSE                             9.7%   9.7%     4361     4361      0      0.15     0.08      0.01  0.1%
 279 FLUSH                             0.5%   0.5%      208      208      0      4.50     4.26      0.28  0.2%
 280 ---------------------------------------------------------------------------------------------------------
 281
 282         ---------------------------------------------
 283         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
 284         ---------------------------------------------
 285 SFS CIFS THROUGHPUT:     150 Ops/Sec   AVG. RESPONSE TIME:    10.1 Msec/Op
 286 TCP PROTOCOL (IPv4)
 287 CIFS MIXFILE: [ SFS default ]
 288 AGGREGATE REQUESTED LOAD: 150 Ops/Sec
 289 TOTAL LOGICAL CIFS OPERATIONS:  45142          TEST TIME: 300 Sec
 290 TOTAL PHYSICAL CIFS OPERATIONS: 46132
 291 PHYSICAL CIFS IO THROUGHPUT: 153 Ops/sec
 292 NUMBER OF SFS CLIENTS: 1
 293 TOTAL FILE SET SIZE CREATED: 17411.0 MB
 294 TOTAL FILE SET SIZE ACCESSED: 5225.0 - 5324.2 MB  (100.00% to 101.90% of Base)
 295
 296 ------------------------------------------------------------------------
 297
 298 Mon Feb 28 06:39:55 PST 2011
 299 ************************************************************************
 300 Mon Feb 28 06:39:55 PST 2011
 301 ************************************************************************
 302 Mon Feb 28 06:39:55 PST 2011 Test Run 4 of 20
 303
 304 Mon Feb 28 06:39:55 PST 2011 Mon Feb 28 06:39:55 PST 2011 c09-44.sysnet.ucsd.edu start:
 305 Mon Feb 28 06:39:55 PST 2011         sfscifs -N 1 -l 200  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
 306
 307 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 308 Executing SFS Benchmark on 1 Client(s).
 309 Mon Feb 28 06:40:10 2011 Waiting on DONE-MOUNT message from 1 client(s).
 310 Mon Feb 28 06:40:11 2011 Received.
 311 Mon Feb 28 06:40:11 2011 Sending DO-INIT message to 1 client(s).
 312 Mon Feb 28 06:40:11 2011 Completed.
 313 Mon Feb 28 06:40:11 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
 314 Mon Feb 28 06:51:20 2011 Received.
 315 Mon Feb 28 06:51:20 2011 Sending DO-WARMUP message to 1 client(s).
 316 Mon Feb 28 06:51:20 2011 Completed.
 317 Mon Feb 28 06:51:20 2011 Waiting on READY message from 1 client(s).
 318 Mon Feb 28 06:56:21 2011 Received.
 319 Mon Feb 28 06:56:21 2011 Sending START message to 1 client(s).
 320 Mon Feb 28 06:56:21 2011 Completed.
 321 Mon Feb 28 07:01:21 2011 Sending STOP message to 1 client(s).
 322 Mon Feb 28 07:01:21 2011 Completed.
 323 Mon Feb 28 07:01:21 2011 Waiting on DONE-TEST message from 1 client(s).
 324 Mon Feb 28 07:01:32 2011 Received.
 325 Mon Feb 28 07:01:32 2011 Sending MOVE-DATA message to 1 client(s).
 326 Mon Feb 28 07:01:32 2011 Completed.
 327 Mon Feb 28 07:01:32 2011 Waiting on SEND-DATA message from 1 client(s).
 328 Mon Feb 28 07:01:33 2011 Received.
 329 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 330 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 200 -C ../result/sfssum.20110227-cifs-bluesky-smallcache -c -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu
 331
 332 Aggregate Test Parameters:
 333     Number of processes = 4
 334     Requested Load (CIFS operations/second) = 200
 335     Maximum number of outstanding biod writes = 2
 336     Maximum number of outstanding biod reads = 2
 337     Warm-up time (seconds) = 300
 338     Run time (seconds) = 300
 339     File Set =  45428 Files created for I/O operations
 340                 13628 Files accessed for I/O operations
 341                   912 Files for non-I/O operations
 342                    24 Symlinks
 343                  1512 Directories
 344                       Additional non-I/O files created as necessary
 345
 346 SFS Aggregate Results for 1 Client(s), Mon Feb 28 07:01:33 2011
 347 CIFS Protocol
 348
 349 ---------------------------------------------------------------------------------------------------------
 350 CIFS                             Target Actual CIFS Op CIFS Op   CIFS   Mean     Std Dev  Std Error Pcnt
 351 Op                               CIFS   CIFS   Logical Physical  Op     Response Response of Mean,  of
 352 Type                             Mix    Mix    Success Success   Error  Time     Time     95% Conf  Total
 353                                  Pcnt   Pcnt   Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 354 ---------------------------------------------------------------------------------------------------------
 355 ECHO                              0.5%   0.5%      294      294      0      0.14     0.07      0.03  0.0%
 356 LOCKING_ANDX                      1.1%   1.2%      716      716      0      0.14     0.04      0.02  0.0%
 357 NT_TRANSACT_QUERY_SECURITY_DES    1.6%   1.6%      975      975      0      0.21     0.14      0.02  0.0%
 358 READ_ANDX                        20.5%  20.9%    12648    13640      0     45.56   100.52      0.17 81.7%
 359 TRANS2_QUERY_FS_INFORMATION       1.6%   1.5%      935      935      0      0.17     0.12      0.02  0.0%
 360 TRANS2_QUERY_FILE_INFORMATION    12.9%  13.2%     7958     7958      0      0.20     0.10      0.01  0.2%
 361 TRANS2_QUERY_PATH_INFORMATION    21.5%  21.5%    12972    12972      0      0.22     0.10      0.01  0.4%
 362 TRANS2_SET_FILE_INFORMATION       3.2%   3.1%     1860     1860      0      0.16     0.07      0.01  0.0%
 363 TRANS2_FIND_FIRST2                8.6%   8.4%     5048     5048      0      0.91     0.14      0.01  0.6%
 364 WRITE_ANDX                        8.6%   8.1%     4908     5267      0     23.37    76.69      0.24 16.3%
 365 NT_CREATE_ANDX                    9.7%   9.8%     5898     5898      0      0.22     0.10      0.01  0.2%
 366 CLOSE                             9.7%   9.8%     5899     5899      0      0.15     0.09      0.01  0.1%
 367 FLUSH                             0.5%   0.4%      270      270      0      7.91    20.63      0.54  0.3%
 368 ---------------------------------------------------------------------------------------------------------
 369
 370         ---------------------------------------------
 371         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
 372         ---------------------------------------------
 373 SFS CIFS THROUGHPUT:     202 Ops/Sec   AVG. RESPONSE TIME:    11.7 Msec/Op
 374 TCP PROTOCOL (IPv4)
 375 CIFS MIXFILE: [ SFS default ]
 376 AGGREGATE REQUESTED LOAD: 200 Ops/Sec
 377 TOTAL LOGICAL CIFS OPERATIONS:  60381          TEST TIME: 299 Sec
 378 TOTAL PHYSICAL CIFS OPERATIONS: 61732
 379 PHYSICAL CIFS IO THROUGHPUT: 206 Ops/sec
 380 NUMBER OF SFS CLIENTS: 1
 381 TOTAL FILE SET SIZE CREATED: 23556.9 MB
 382 TOTAL FILE SET SIZE ACCESSED: 7068.9 - 7179.6 MB  (100.00% to 101.57% of Base)
 383
 384 ------------------------------------------------------------------------
 385
 386 Mon Feb 28 07:01:34 PST 2011
 387 ************************************************************************
 388 Mon Feb 28 07:01:34 PST 2011
 389 ************************************************************************
 390 Mon Feb 28 07:01:34 PST 2011 Test Run 5 of 20
 391
 392 Mon Feb 28 07:01:34 PST 2011 Mon Feb 28 07:01:34 PST 2011 c09-44.sysnet.ucsd.edu start:
 393 Mon Feb 28 07:01:34 PST 2011         sfscifs -N 1 -l 250  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
 394
 395 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 396 Executing SFS Benchmark on 1 Client(s).
 397 Mon Feb 28 07:01:49 2011 Waiting on DONE-MOUNT message from 1 client(s).
 398 Mon Feb 28 07:01:51 2011 Received.
 399 Mon Feb 28 07:01:51 2011 Sending DO-INIT message to 1 client(s).
 400 Mon Feb 28 07:01:51 2011 Completed.
 401 Mon Feb 28 07:01:51 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
 402 Mon Feb 28 07:12:58 2011 Received.
 403 Mon Feb 28 07:12:58 2011 Sending DO-WARMUP message to 1 client(s).
 404 Mon Feb 28 07:12:58 2011 Completed.
 405 Mon Feb 28 07:12:58 2011 Waiting on READY message from 1 client(s).
 406 Mon Feb 28 07:17:59 2011 Received.
 407 Mon Feb 28 07:17:59 2011 Sending START message to 1 client(s).
 408 Mon Feb 28 07:17:59 2011 Completed.
 409 Mon Feb 28 07:22:59 2011 Sending STOP message to 1 client(s).
 410 Mon Feb 28 07:22:59 2011 Completed.
 411 Mon Feb 28 07:22:59 2011 Waiting on DONE-TEST message from 1 client(s).
 412 Mon Feb 28 07:23:10 2011 Received.
 413 Mon Feb 28 07:23:10 2011 Sending MOVE-DATA message to 1 client(s).
 414 Mon Feb 28 07:23:10 2011 Completed.
 415 Mon Feb 28 07:23:10 2011 Waiting on SEND-DATA message from 1 client(s).
 416 Mon Feb 28 07:23:11 2011 Received.
 417 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 418 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 250 -C ../result/sfssum.20110227-cifs-bluesky-smallcache -c -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu
 419
 420 Aggregate Test Parameters:
 421     Number of processes = 4
 422     Requested Load (CIFS operations/second) = 250
 423     Maximum number of outstanding biod writes = 2
 424     Maximum number of outstanding biod reads = 2
 425     Warm-up time (seconds) = 300
 426     Run time (seconds) = 300
 427     File Set =  57276 Files created for I/O operations
 428                 17180 Files accessed for I/O operations
 429                  1148 Files for non-I/O operations
 430                    24 Symlinks
 431                  1908 Directories
 432                       Additional non-I/O files created as necessary
 433
 434 SFS Aggregate Results for 1 Client(s), Mon Feb 28 07:23:11 2011
 435 CIFS Protocol
 436
 437 ---------------------------------------------------------------------------------------------------------
 438 CIFS                             Target Actual CIFS Op CIFS Op   CIFS   Mean     Std Dev  Std Error Pcnt
 439 Op                               CIFS   CIFS   Logical Physical  Op     Response Response of Mean,  of
 440 Type                             Mix    Mix    Success Success   Error  Time     Time     95% Conf  Total
 441                                  Pcnt   Pcnt   Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 442 ---------------------------------------------------------------------------------------------------------
 443 ECHO                              0.5%   0.5%      400      400      0      0.17     0.31      0.05  0.0%
 444 LOCKING_ANDX                      1.1%   1.1%      864      864      0      0.15     0.09      0.02  0.0%
 445 NT_TRANSACT_QUERY_SECURITY_DES    1.6%   1.6%     1187     1187      0      0.21     0.20      0.03  0.0%
 446 READ_ANDX                        20.5%  20.1%    15124    16267      0     51.87   106.44      0.16 81.0%
 447 TRANS2_QUERY_FS_INFORMATION       1.6%   1.7%     1246     1246      0      0.15     0.09      0.02  0.0%
 448 TRANS2_QUERY_FILE_INFORMATION    12.9%  12.8%     9666     9666      0      0.20     0.14      0.01  0.2%
 449 TRANS2_QUERY_PATH_INFORMATION    21.5%  21.7%    16317    16317      0      0.22     0.17      0.01  0.4%
 450 TRANS2_SET_FILE_INFORMATION       3.2%   3.2%     2431     2431      0      0.16     0.10      0.01  0.0%
 451 TRANS2_FIND_FIRST2                8.6%   8.7%     6528     6528      0      1.18     0.19      0.01  0.8%
 452 WRITE_ANDX                        8.6%   8.9%     6687     7132      0     24.30    76.58      0.21 16.8%
 453 NT_CREATE_ANDX                    9.7%   9.6%     7229     7229      0      0.22     0.14      0.01  0.2%
 454 CLOSE                             9.7%   9.6%     7229     7229      0      0.16     0.11      0.01  0.1%
 455 FLUSH                             0.5%   0.5%      383      383      0     12.96    57.31      0.76  0.5%
 456 ---------------------------------------------------------------------------------------------------------
 457
 458         ---------------------------------------------
 459         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
 460         ---------------------------------------------
 461 SFS CIFS THROUGHPUT:     252 Ops/Sec   AVG. RESPONSE TIME:    12.9 Msec/Op
 462 TCP PROTOCOL (IPv4)
 463 CIFS MIXFILE: [ SFS default ]
 464 AGGREGATE REQUESTED LOAD: 250 Ops/Sec
 465 TOTAL LOGICAL CIFS OPERATIONS:  75291          TEST TIME: 299 Sec
 466 TOTAL PHYSICAL CIFS OPERATIONS: 76879
 467 PHYSICAL CIFS IO THROUGHPUT: 257 Ops/sec
 468 NUMBER OF SFS CLIENTS: 1
 469 TOTAL FILE SET SIZE CREATED: 29700.7 MB
 470 TOTAL FILE SET SIZE ACCESSED: 8910.8 - 9044.1 MB  (100.00% to 101.50% of Base)
 471
 472 ------------------------------------------------------------------------
 473
 474 Mon Feb 28 07:23:12 PST 2011
 475 ************************************************************************
 476 Mon Feb 28 07:23:12 PST 2011
 477 ************************************************************************
 478 Mon Feb 28 07:23:12 PST 2011 Test Run 6 of 20
 479
 480 Mon Feb 28 07:23:12 PST 2011 Mon Feb 28 07:23:12 PST 2011 c09-44.sysnet.ucsd.edu start:
 481 Mon Feb 28 07:23:12 PST 2011         sfscifs -N 1 -l 300  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
 482
 483 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 484 Executing SFS Benchmark on 1 Client(s).
 485 Mon Feb 28 07:23:27 2011 Waiting on DONE-MOUNT message from 1 client(s).
 486 Mon Feb 28 07:23:29 2011 Received.
 487 Mon Feb 28 07:23:29 2011 Sending DO-INIT message to 1 client(s).
 488 Mon Feb 28 07:23:29 2011 Completed.
 489 Mon Feb 28 07:23:29 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
 490 Mon Feb 28 07:33:19 2011 Received.
 491 Mon Feb 28 07:33:19 2011 Sending DO-WARMUP message to 1 client(s).
 492 Mon Feb 28 07:33:19 2011 Completed.
 493 Mon Feb 28 07:33:19 2011 Waiting on READY message from 1 client(s).
 494 Mon Feb 28 07:38:20 2011 Received.
 495 Mon Feb 28 07:38:20 2011 Sending START message to 1 client(s).
 496 Mon Feb 28 07:38:20 2011 Completed.
 497 Mon Feb 28 07:43:20 2011 Sending STOP message to 1 client(s).
 498 Mon Feb 28 07:43:20 2011 Completed.
 499 Mon Feb 28 07:43:20 2011 Waiting on DONE-TEST message from 1 client(s).
 500 Mon Feb 28 07:43:31 2011 Received.
 501 Mon Feb 28 07:43:31 2011 Sending MOVE-DATA message to 1 client(s).
 502 Mon Feb 28 07:43:31 2011 Completed.
 503 Mon Feb 28 07:43:31 2011 Waiting on SEND-DATA message from 1 client(s).
 504 Mon Feb 28 07:43:32 2011 Received.
 505 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 506 Started on client (c09-44): ../binaries/linux-x86/sfs_prime -l 300 -C ../result/sfssum.20110227-cifs-bluesky-smallcache -c -t 300 -a 30 -A 70 -R 2 -W 2 -Q -p 4 -w 300 -X 8000 c09-44.sysnet.ucsd.edu
 507
 508 Aggregate Test Parameters:
 509     Number of processes = 4
 510     Requested Load (CIFS operations/second) = 300
 511     Maximum number of outstanding biod writes = 2
 512     Maximum number of outstanding biod reads = 2
 513     Warm-up time (seconds) = 300
 514     Run time (seconds) = 300
 515     File Set =  69128 Files created for I/O operations
 516                 20736 Files accessed for I/O operations
 517                  1384 Files for non-I/O operations
 518                    24 Symlinks
 519                  2304 Directories
 520                       Additional non-I/O files created as necessary
 521
 522 SFS Aggregate Results for 1 Client(s), Mon Feb 28 07:43:32 2011
 523 CIFS Protocol
 524
 525 ---------------------------------------------------------------------------------------------------------
 526 CIFS                             Target Actual CIFS Op CIFS Op   CIFS   Mean     Std Dev  Std Error Pcnt
 527 Op                               CIFS   CIFS   Logical Physical  Op     Response Response of Mean,  of
 528 Type                             Mix    Mix    Success Success   Error  Time     Time     95% Conf  Total
 529                                  Pcnt   Pcnt   Count   Count     Count  Msec/Op  Msec/Op  +-Msec/Op Time
 530 ---------------------------------------------------------------------------------------------------------
 531 ECHO                              0.5%   0.5%      365      365      0      0.12     0.04      0.02  0.0%
 532 LOCKING_ANDX                      1.1%   1.2%      993      993      0      0.14     0.10      0.02  0.0%
 533 NT_TRANSACT_QUERY_SECURITY_DES    1.6%   1.7%     1353     1353      0      0.20     0.16      0.02  0.0%
 534 READ_ANDX                        20.5%  20.8%    16674    17984      0     61.25   112.81      0.16 85.1%
 535 TRANS2_QUERY_FS_INFORMATION       1.6%   1.6%     1295     1295      0      0.15     0.15      0.02  0.0%
 536 TRANS2_QUERY_FILE_INFORMATION    12.9%  13.2%    10598    10598      0      0.20     0.19      0.01  0.2%
 537 TRANS2_QUERY_PATH_INFORMATION    21.5%  21.5%    17257    17257      0      0.22     0.14      0.01  0.3%
 538 TRANS2_SET_FILE_INFORMATION       3.2%   3.1%     2498     2498      0      0.15     0.12      0.01  0.0%
 539 TRANS2_FIND_FIRST2                8.6%   8.7%     6972     6972      0      1.43     0.25      0.01  0.8%
 540 WRITE_ANDX                        8.6%   7.8%     6305     6733      0     24.35    73.26      0.21 12.8%
 541 NT_CREATE_ANDX                    9.7%   9.7%     7828     7828      0      0.22     0.13      0.01  0.1%
 542 CLOSE                             9.7%   9.7%     7828     7828      0      0.15     0.14      0.01  0.1%
 543 FLUSH                             0.5%   0.5%      387      387      0     13.35    61.91      0.78  0.4%
 544 ---------------------------------------------------------------------------------------------------------
 545
 546         ---------------------------------------------
 547         |  SPEC SFS 2008 AGGREGATE RESULTS SUMMARY  |
 548         ---------------------------------------------
 549 SFS CIFS THROUGHPUT:     268 Ops/Sec   AVG. RESPONSE TIME:    14.9 Msec/Op
 550 TCP PROTOCOL (IPv4)
 551 CIFS MIXFILE: [ SFS default ]
 552 AGGREGATE REQUESTED LOAD: 300 Ops/Sec
 553 TOTAL LOGICAL CIFS OPERATIONS:  80353          TEST TIME: 300 Sec
 554 TOTAL PHYSICAL CIFS OPERATIONS: 82091
 555 PHYSICAL CIFS IO THROUGHPUT: 273 Ops/sec
 556 NUMBER OF SFS CLIENTS: 1
 557 TOTAL FILE SET SIZE CREATED: 35846.6 MB
 558 TOTAL FILE SET SIZE ACCESSED: 10754.8 - 10877.6 MB  (100.00% to 101.14% of Base)
 559
 560 ------------------------------------------------------------------------
 561
 562 Mon Feb 28 07:43:33 PST 2011
 563 ************************************************************************
 564 Mon Feb 28 07:43:33 PST 2011
 565 ************************************************************************
 566 Mon Feb 28 07:43:33 PST 2011 Test Run 7 of 20
 567
 568 Mon Feb 28 07:43:33 PST 2011 Mon Feb 28 07:43:33 PST 2011 c09-44.sysnet.ucsd.edu start:
 569 Mon Feb 28 07:43:33 PST 2011         sfscifs -N 1 -l 350  -o password -u spec -G SPECDOMAIN -t 300 -a 30 -A 70 -R 2 -W 2 -D 30 -S 20 -Q -p 4 -w 300 -U 500 -g 500 -M c09-44.sysnet.ucsd.edu  \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky \\c09-45.sysnet.ucsd.edu\bluesky
 570
 571 SPEC SFS Benchmark Version 2008, Creation - 1 February 2008
 572 Executing SFS Benchmark on 1 Client(s).
 573 Mon Feb 28 07:43:48 2011 Waiting on DONE-MOUNT message from 1 client(s).
 574 Mon Feb 28 07:43:49 2011 Received.
 575 Mon Feb 28 07:43:49 2011 Sending DO-INIT message to 1 client(s).
 576 Mon Feb 28 07:43:49 2011 Completed.
 577 Mon Feb 28 07:43:49 2011 Waiting on DONE-INIT message from 1 client(s) (timeout is 8000 seconds).
 578 Mon Feb 28 07:54:23 2011 Received.
 579 Mon Feb 28 07:54:23 2011 Sending DO-WARMUP message to 1 client(s).
 580 Mon Feb 28 07:54:23 2011 Completed.
 581 Mon Feb 28 07:54:23 2011 Waiting on READY message from 1 client(s).
 582
 583 ../binaries/linux-x86/sfs_prime: Prime Client got too many signals - expected 1 got 1000
 584
 585 ../binaries/linux-x86/sfs_prime: Unable to perform remote procedure on c09-44.sysnet.ucsd.edu .
 586 Mon Feb 28 07:59:25 PST 2011 ERROR: SfsManager: sfs_prime returned error code: 51, exiting