1 # -*- encoding: binary -*-
4 # Not at all optimized for performance, this was written based on
5 # the original C extension code so it's not very Ruby-ish...
8 attr_accessor :env, :status, :headers, :body
9 attr_writer :body_bytes_sent
11 def initialize(app, opts = {})
12 # trigger autoload to avoid thread-safety issues later on
13 Rack::Utils::HeaderHash
16 @logger = opts[:logger]
19 raise ArgumentError, ":logger and :path are independent"
20 path and @logger = File.open(path, "ab")
22 @logger.sync = true if @logger.respond_to?(:sync=)
23 @fmt_ops = compile_format(opts[:format] || Format::Common, opts)
24 @wrap_body = need_wrap_body?(@fmt_ops)
25 @reentrant = opts[:reentrant]
26 @need_resp = need_response_headers?(@fmt_ops)
33 unless resp.instance_of?(Array) && resp.size == 3
35 raise TypeError, "app response not a 3 element Array: #{resp.inspect}"
37 status, headers, body = resp
38 headers = Rack::Utils::HeaderHash.new(headers) if @need_resp
40 @reentrant = env['rack.multithread'] if @reentrant.nil?
41 wbody = @reentrant ? self.dup : self
44 wbody.headers = headers
46 return [ status, headers, wbody ]
48 log(env, status, headers)
49 [ status, headers, body ]
55 @body_bytes_sent += Rack::Utils.bytesize(part)
62 @body.close if @body.respond_to?(:close)
64 log(@env, @status, @headers)
76 @logger.respond_to?(:fileno) ? @logger.fileno : nil
80 :close == m.to_sym || @body.respond_to?(m)
85 @body_bytes_sent = File.size(rv)
93 s.force_encoding(Encoding::BINARY) if defined?(Encoding::BINARY)
94 s.gsub!(/(['"\x00-\x1f\x7f-\xff])/) do |x|
95 "\\x#{$1.unpack('H2').first.upcase}"
100 SPECIAL_RMAP = SPECIAL_VARS.inject([]) { |ary, (k,v)| ary[v] = k; ary }
103 ru = env['REQUEST_URI'] and return byte_xs(ru)
104 qs = env['QUERY_STRING']
105 qs.empty? or qs = "?#{byte_xs(qs)}"
106 "#{byte_xs(env['PATH_INFO'])}#{qs}"
109 def special_var(special_nr, env, status, headers)
110 case SPECIAL_RMAP[special_nr]
111 when :body_bytes_sent
112 @body_bytes_sent.to_s
115 status >= 100 && status <= 999 ? ('%03d' % status) : '-'
117 version = env['HTTP_VERSION'] and version = " #{byte_xs(version)}"
118 qs = env['QUERY_STRING']
119 qs.empty? or qs = "?#{byte_xs(qs)}"
120 "#{env['REQUEST_METHOD']} " \
121 "#{request_uri(env)}#{version}"
125 env['rack.input'].size.to_s
126 when :response_length
127 @body_bytes_sent == 0 ? '-' : @body_bytes_sent.to_s
129 xff = env['HTTP_X_FORWARDED_FOR'] and return byte_xs(xff)
130 env['REMOTE_ADDR'] || '-'
138 sign = off < 0 ? '-' : '+'
139 sprintf("%02d/%s/%d:%02d:%02d:%02d #{sign}%02d%02d",
140 t.mday, Time::RFC2822_MONTH_NAME[t.mon - 1],
141 t.year, t.hour, t.min, t.sec, *(off.abs / 60).divmod(60))
144 sprintf("%02d/%s/%d:%02d:%02d:%02d +0000",
145 t.mday, Time::RFC2822_MONTH_NAME[t.mon - 1],
146 t.year, t.hour, t.min, t.sec)
148 raise "EDOOFUS #{special_nr}"
152 def time_format(sec, usec, format, div)
153 format % [ sec, usec / div ]
156 def log(env, status, headers)
157 str = @fmt_ops.map { |op|
159 when OP_LITERAL; op[1]
160 when OP_REQUEST; byte_xs(env[op[1]] || "-")
161 when OP_RESPONSE; byte_xs(headers[op[1]] || "-")
162 when OP_SPECIAL; special_var(op[1], env, status, headers)
163 when OP_EVAL; eval(op[1]).to_s rescue "-"
164 when OP_TIME_LOCAL; Time.now.strftime(op[1])
165 when OP_TIME_UTC; Time.now.utc.strftime(op[1])
167 t = Time.now - @start
168 time_format(t.to_i, (t - t.to_i) * 1000000, op[1], op[2])
171 time_format(t.to_i, t.usec, op[1], op[2])
173 (byte_xs(env['rack.request.cookie_hash'][op[1]]) rescue "-") || "-"
175 raise "EDOOFUS #{op.inspect}"
183 env['rack.errors'].write(str)