1VARNISHNCSA(1)                                                  VARNISHNCSA(1)
2
3
4

NAME

6       varnishncsa - Display Varnish logs in Apache / NCSA combined log format
7

SYNOPSIS

9       varnishncsa  [-a] [-b] [-c] [-C] [-d] [-D] [-E] [-F <format>] [-f <for‐
10       matfile>] [-g <request|vxid>] [-h] [-L <limit>] [-n <dir>] [-P  <file>]
11       [-Q  <file>]  [-q  <query>] [-r <filename>] [-R <limit[/duration]>] [-t
12       <seconds|off>] [-V] [-w <filename>]
13

DESCRIPTION

15       The varnishncsa  utility  reads  varnishd(1)  shared  memory  logs  and
16       presents them in the Apache / NCSA "combined" log format.
17
18       Each  log  line  produced is based on a single Request type transaction
19       gathered from the shared memory log. The Request  transaction  is  then
20       scanned for the relevant parts in order to output one log line. To fil‐
21       ter the log lines produced, use the query language to select the appli‐
22       cable transactions. Non-request transactions are ignored.
23
24       The following options are available:
25
26       -a     When  writing  output  to a file, append to it rather than over‐
27              write it.
28
29       -b     Log backend requests. If -c is not specified, then only  backend
30              requests will trigger log lines.
31
32       -c     Log  client  requests.  This is the default. If -b is specified,
33              then -c is needed to also log client requests
34
35       -C     Do all regular expression and string matching caseless.
36
37       -d     Process log records at the head of the log and exit.
38
39       -D     Daemonize.
40
41       -E     Show ESI request.
42
43       -F <format>
44              Set the output log format string.
45
46       -f <formatfile>
47              Read output format from a file. Will read a single line from the
48              specified file, and use that line as the format.
49
50       -g <request|vxid>
51              The  grouping  of  the  log  records. The default is to group by
52              vxid.
53
54       -h     Print program usage and exit
55
56       -L <limit>
57              Sets the upper limit of incomplete transactions kept before  the
58              oldest  transaction is force completed. A warning record is syn‐
59              thesized when this happens. This setting keeps an upper bound on
60              the  memory  usage of running queries. Defaults to 1000 transac‐
61              tions.
62
63       -n <dir>
64              Specify the varnishd working directory (also known  as  instance
65              name) to get logs from. If -n is not specified, the host name is
66              used.
67
68       -P <file>
69              Write the process' PID to the specified file.
70
71       -Q <file>
72              Specifies the file containing the VSL query to use. When  multi‐
73              ple  -Q  or -q options are specified, all queries are considered
74              as if the 'or' operator was used to combine them.
75
76       -q <query>
77              Specifies the VSL query to use. When multiple -q or  -Q  options
78              are  specified, all queries are considered as if the 'or' opera‐
79              tor was used to combine them.
80
81       -r <filename>
82              Read log in binary file format from this file. The file  can  be
83              created with varnishlog -w filename.
84
85       -R <limit[/duration]>
86              Restrict the output to the specified limit. Transactions exceed‐
87              ing the limit will be suppressed. The limit is specified as  the
88              maximum  number  of  transactions  (with  respect  to the chosen
89              grouping method) and an optional time period. If no duration  is
90              specified,  a  default  of  s is used. The duration field can be
91              formatted as in VCL (e.g. -R 10/2m) or as a simple  time  period
92              without  the prefix (e.g. -R 5/m). When in -g raw grouping mode,
93              this setting can not be used alongside -i, -I, -x or -X, and  we
94              advise using -q instead.
95
96       -t <seconds|off>
97              Timeout before returning error on initial VSM connection. If set
98              the VSM connection is retried every 0.5 seconds  for  this  many
99              seconds.  If zero the connection is attempted only once and will
100              fail immediately if unsuccessful. If set to "off",  the  connec‐
101              tion will not fail, allowing the utility to start and wait inde‐
102              finetely for the Varnish instance to appear.  Defaults to 5 sec‐
103              onds.
104
105       -V     Print version information and exit.
106
107       -w <filename>
108              Redirect output to file. The file will be overwritten unless the
109              -a option was specified. If the application receives a SIGHUP in
110              daemon mode the file will be reopened allowing the old one to be
111              rotated away. This option is required  when  running  in  daemon
112              mode.
113
114       --optstring
115              Print the optstring parameter to getopt(3) to help writing wrap‐
116              per scripts.
117

MODES

119       The default mode of varnishncsa is "client mode".  In  this  mode,  the
120       log  will  be similar to what a web server would produce in the absence
121       of varnish.  Client mode can be explicitly selected by using -c.
122
123       If the -b switch is specified, varnishncsa  will  operate  in  "backend
124       mode".   In  this  mode,  requests generated by varnish to the backends
125       will be logged.  Unless -c is also specified, client requests  received
126       by varnish will be ignored.
127
128       When  running  varnishncsa  in  both  backend  and  client  mode, it is
129       strongly advised to include the format  specifier  %{Varnish:side}x  to
130       distinguish between backend and client requests.
131
132       Client  requests that results in a pipe (ie. return(pipe) in vcl), will
133       not generate logging in backend mode. This is because  varnish  is  not
134       generating  requests,  but  blindly passes on bytes in both directions.
135       However, a varnishncsa instance running in normal  mode  can  see  this
136       case by using the formatter %{Varnish:handling}x, which will be 'pipe'.
137
138       In  backend mode, some of the fields in the format string get different
139       meanings.  Most notably, the byte counting formatters (%b, %I, %O) con‐
140       siders varnish to be the client.
141
142       It  is possible to keep two varnishncsa instances running, one in back‐
143       end mode, and one in client mode, logging to different files.
144

FORMAT

146       Specify the log format to use. If no format is  specified  the  default
147       log format is used:
148
149          %h %l %u %t "%r" %s %b "%{Referer}i" "%{User-agent}i"
150
151       Escape sequences \n and \t are supported.
152
153       Supported formatters are:
154
155       %b     In  client mode, size of response in bytes, excluding HTTP head‐
156              ers.  In backend mode, the number of  bytes  received  from  the
157              backend,  excluding  HTTP  headers.   In  CLF format, i.e. a '-'
158              rather than a 0 when no bytes are sent.
159
160       %D     In client mode, time taken to serve the  request,  in  microsec‐
161              onds.   In  backend  mode, time from the request was sent to the
162              entire body had been received.
163
164       %H     The request protocol. Defaults to HTTP/1.0 if not known.
165
166       %h     Remote host. Defaults to '-' if not known.  In backend mode this
167              is the IP of the backend server.
168
169       %I     In  client  mode,  total bytes received from client.  In backend
170              mode, total bytes sent to the backend.
171
172       %{X}i  The contents of request header X. If the header appears multiple
173              times in a single transaction, the last occurrence is used.
174
175       %l     Remote logname. Always '-'.
176
177       %m     Request method. Defaults to '-' if not known.
178
179       %{X}o  The  contents of response header X. If the header appears multi‐
180              ple times in a single transaction, the last occurrence is used.
181
182       %O     In client mode, total bytes sent to client.   In  backend  mode,
183              total bytes received from the backend.
184
185       %q     The query string. Defaults to an empty string if not present.
186
187       %r     The first line of the request. Synthesized from other fields, so
188              it may not be the request verbatim. See the NOTES section.
189
190       %s     Status sent to the client.  In  backend  mode,  status  received
191              from the backend.
192
193       %t     In  client  mode,  time  when  the request was received, in HTTP
194              date/time format.  In backend mode, time when  the  request  was
195              sent.
196
197       %{X}t  In  client mode, time when the request was received, in the for‐
198              mat specified by X.  In backend mode, time when the request  was
199              sent.   The  time  specification format is the same as for strf‐
200              time(3).
201
202       %T     In client mode, time taken to serve the request, in seconds.  In
203              backend  mode, time from the request was sent to the entire body
204              had been received.
205
206       %U     The request URL without the query string. Defaults to '-' if not
207              known.
208
209       %u     Remote user from auth.
210
211       %{X}x  Extended variables.  Supported variables are:
212
213              Varnish:time_firstbyte
214                     Time  from  when  the request processing starts until the
215                     first byte is sent to the client, in seconds.  For  back‐
216                     end  mode:  Time from the request was sent to the backend
217                     to the entire header had been received.
218
219              Varnish:hitmiss
220                     One of the 'hit' or 'miss' strings, depending on  whether
221                     the request was a cache hit or miss. Pipe, pass and synth
222                     are considered misses.
223
224              Varnish:handling
225                     One of the  'hit',  'miss',  'pass',  'pipe'  or  'synth'
226                     strings indicating how the request was handled.
227
228              Varnish:side
229                     Backend  or  client  side. One of two values, 'b' or 'c',
230                     depending on where the request was made. In pure  backend
231                     or client mode, this field will be constant.
232
233              Varnish:vxid
234                     The VXID of the varnish transaction.
235
236              VCL_Log:key
237                     The value set by std.log("key:value") in VCL.
238
239              VSL:tag:record-prefix[field]
240                     The  value of the VSL entry for the given tag-record pre‐
241                     fix-field combination. Tag is mandatory, the other compo‐
242                     nents are optional.
243
244                     The record prefix will limit the matches to those records
245                     that have this prefix as the first  part  of  the  record
246                     content followed by a colon.
247
248                     The  field  will,  if  present, treat the log record as a
249                     white space separated list of fields, and  only  the  nth
250                     part  of the record will be matched against. Fields start
251                     counting at 1 and run up to 255.
252
253                     Defaults to '-' when the tag is not seen, the record pre‐
254                     fix  does  not  match or the field is out of bounds. If a
255                     tag appears multiple times in a single  transaction,  the
256                     first occurrence is used.
257

SIGNALS

259       · SIGHUP
260
261         Rotate  the  log  file (see -w option) in daemon mode, abort the loop
262         and die gracefully when running in the foreground.
263
264       · SIGUSR1
265
266         Flush any outstanding transactions.
267

NOTES

269       The %r formatter is equivalent to  "%m  http://%{Host}i%U%q  %H".  This
270       differs  from  apache's  %r behavior, equivalent to "%m %U%q %H".  Fur‐
271       thermore, when using the %r formatter, if the Host header appears  mul‐
272       tiple times in a single transaction, the first occurrence is used.
273

EXAMPLE

275       Log  the second field of the Begin record, corresponding to the VXID of
276       the parent transaction:
277
278          varnishncsa -F "%{VSL:Begin[2]}x"
279
280       Log the entire Timestamp record associated with the processing length:
281
282          varnishncsa -F "%{VSL:Timestamp:Process}x"
283

SEE ALSO

285       varnishd(1) varnishlog(1) varnishstat(1) vsl(7)
286

HISTORY

288       The varnishncsa utility was developed by Poul-Henning Kamp in  coopera‐
289       tion with Verdens Gang AS and Varnish Software AS. This manual page was
290       initially  written  by  Dag-Erling  Smørgrav  <des@des.no>,  and  later
291       updated by Martin Blix Grydeland and Pål Hermunn Johansen.
292
294       This document is licensed under the same licence as Varnish itself. See
295       LICENCE for details.
296
297       · Copyright (c) 2006 Verdens Gang AS
298
299       · Copyright (c) 2006-2016 Varnish Software AS
300
301
302
303
304                                                                VARNISHNCSA(1)
Impressum