process_encrypted_request(): Use the MESSED_UP_REQUEST_RESPONSE when the rewritten...
[privoxy.git] / jcc.c
1 /*********************************************************************
2  *
3  * File        :  $Source: /cvsroot/ijbswa/current/jcc.c,v $
4  *
5  * Purpose     :  Main file.  Contains main() method, main loop, and
6  *                the main connection-handling function.
7  *
8  * Copyright   :  Written by and Copyright (C) 2001-2021 the
9  *                Privoxy team. https://www.privoxy.org/
10  *
11  *                Based on the Internet Junkbuster originally written
12  *                by and Copyright (C) 1997 Anonymous Coders and
13  *                Junkbusters Corporation.  http://www.junkbusters.com
14  *
15  *                This program is free software; you can redistribute it
16  *                and/or modify it under the terms of the GNU General
17  *                Public License as published by the Free Software
18  *                Foundation; either version 2 of the License, or (at
19  *                your option) any later version.
20  *
21  *                This program is distributed in the hope that it will
22  *                be useful, but WITHOUT ANY WARRANTY; without even the
23  *                implied warranty of MERCHANTABILITY or FITNESS FOR A
24  *                PARTICULAR PURPOSE.  See the GNU General Public
25  *                License for more details.
26  *
27  *                The GNU General Public License should be included with
28  *                this file.  If not, you can view it at
29  *                http://www.gnu.org/copyleft/gpl.html
30  *                or write to the Free Software Foundation, Inc., 59
31  *                Temple Place - Suite 330, Boston, MA  02111-1307, USA.
32  *
33  *********************************************************************/
34
35
36 #include "config.h"
37
38 #include <stdio.h>
39 #include <sys/types.h>
40 #include <stdlib.h>
41 #include <string.h>
42 #include <signal.h>
43 #include <fcntl.h>
44 #include <errno.h>
45 #include <assert.h>
46
47 #ifdef _WIN32
48 # ifndef FEATURE_PTHREAD
49 #  ifndef STRICT
50 #   define STRICT
51 #  endif
52 #  include <winsock2.h>
53 #  include <windows.h>
54 #  include <process.h>
55 # endif /* ndef FEATURE_PTHREAD */
56
57 # include "win32.h"
58 # ifndef _WIN_CONSOLE
59 #  include "w32log.h"
60 # endif /* ndef _WIN_CONSOLE */
61 # include "w32svrapi.h"
62
63 #else /* ifndef _WIN32 */
64
65 # include <unistd.h>
66 # include <sys/wait.h>
67 # include <sys/time.h>
68 # include <sys/stat.h>
69 # include <sys/ioctl.h>
70
71 #ifdef sun
72 #include <sys/termios.h>
73 #endif /* sun */
74
75 #ifdef unix
76 #include <pwd.h>
77 #include <grp.h>
78 #endif
79
80 # include <signal.h>
81
82 # ifdef __BEOS__
83 #  include <socket.h>  /* BeOS has select() for sockets only. */
84 #  include <OS.h>      /* declarations for threads and stuff. */
85 # endif
86
87 #ifdef HAVE_POLL
88 #ifdef __GLIBC__
89 #include <sys/poll.h>
90 #else
91 #include <poll.h>
92 #endif /* def __GLIBC__ */
93 #else
94 # ifndef FD_ZERO
95 #  include <select.h>
96 # endif
97 #warning poll() appears to be unavailable. Your platform will become unsupported in the future.
98 #endif /* HAVE_POLL */
99
100 #endif
101
102 #include "project.h"
103 #include "list.h"
104 #include "jcc.h"
105 #ifdef FEATURE_HTTPS_INSPECTION
106 #include "ssl.h"
107 #endif
108 #include "filters.h"
109 #include "loaders.h"
110 #include "parsers.h"
111 #include "miscutil.h"
112 #include "errlog.h"
113 #include "jbsockets.h"
114 #include "gateway.h"
115 #include "actions.h"
116 #include "cgi.h"
117 #include "loadcfg.h"
118 #include "urlmatch.h"
119 #ifdef FEATURE_CLIENT_TAGS
120 #include "client-tags.h"
121 #endif
122
123 int daemon_mode = 1;
124 struct client_states clients[1];
125 struct file_list     files[1];
126
127 #ifdef FEATURE_STATISTICS
128 int urls_read     = 0;     /* total nr of urls read inc rejected */
129 int urls_rejected = 0;     /* total nr of urls rejected */
130 #endif /* def FEATURE_STATISTICS */
131
132 #ifdef FEATURE_GRACEFUL_TERMINATION
133 int g_terminate = 0;
134 #endif
135
136 #if !defined(_WIN32)
137 static void sig_handler(int the_signal);
138 #endif
139 static int client_protocol_is_unsupported(struct client_state *csp, char *req);
140 static jb_err get_request_destination_elsewhere(struct client_state *csp, struct list *headers);
141 static jb_err get_server_headers(struct client_state *csp);
142 static const char *crunch_reason(const struct http_response *rsp);
143 static void send_crunch_response(struct client_state *csp, struct http_response *rsp);
144 static char *get_request_line(struct client_state *csp);
145 static jb_err receive_client_request(struct client_state *csp);
146 static jb_err parse_client_request(struct client_state *csp);
147 static void build_request_line(struct client_state *csp, const struct forward_spec *fwd, char **request_line);
148 static jb_err change_request_destination(struct client_state *csp);
149 static void handle_established_connection(struct client_state *csp);
150 static void chat(struct client_state *csp);
151 static void serve(struct client_state *csp);
152 #if !defined(_WIN32) || defined(_WIN_CONSOLE)
153 static void usage(const char *myname);
154 #endif
155 static void initialize_mutexes(void);
156 static jb_socket bind_port_helper(const char *haddr, int hport, int backlog);
157 static void bind_ports_helper(struct configuration_spec *config, jb_socket sockets[]);
158 static void close_ports_helper(jb_socket sockets[]);
159 static void listen_loop(void);
160 static void serve(struct client_state *csp);
161
162 #ifdef __BEOS__
163 static int32 server_thread(void *data);
164 #endif /* def __BEOS__ */
165
166 #ifdef _WIN32
167 #define sleep(N)  Sleep(((N) * 1000))
168 #endif
169
170 #ifdef FUZZ
171 int process_fuzzed_input(char *fuzz_input_type, char *fuzz_input_file);
172 void show_fuzz_usage(const char *name);
173 #endif
174
175 #ifdef MUTEX_LOCKS_AVAILABLE
176 /*
177  * XXX: Does the locking stuff really belong in this file?
178  */
179 privoxy_mutex_t log_mutex;
180 privoxy_mutex_t log_init_mutex;
181 privoxy_mutex_t connection_reuse_mutex;
182
183 #ifdef FEATURE_HTTPS_INSPECTION
184 privoxy_mutex_t certificate_mutex;
185 privoxy_mutex_t ssl_init_mutex;
186 #endif
187
188 #ifdef FEATURE_EXTERNAL_FILTERS
189 privoxy_mutex_t external_filter_mutex;
190 #endif
191 #ifdef FEATURE_CLIENT_TAGS
192 privoxy_mutex_t client_tags_mutex;
193 #endif
194 #ifdef FEATURE_EXTENDED_STATISTICS
195 privoxy_mutex_t filter_statistics_mutex;
196 privoxy_mutex_t block_statistics_mutex;
197 #endif
198
199 #if !defined(HAVE_GETHOSTBYADDR_R) || !defined(HAVE_GETHOSTBYNAME_R)
200 privoxy_mutex_t resolver_mutex;
201 #endif /* !defined(HAVE_GETHOSTBYADDR_R) || !defined(HAVE_GETHOSTBYNAME_R) */
202
203 #ifndef HAVE_GMTIME_R
204 privoxy_mutex_t gmtime_mutex;
205 #endif /* ndef HAVE_GMTIME_R */
206
207 #ifndef HAVE_LOCALTIME_R
208 privoxy_mutex_t localtime_mutex;
209 #endif /* ndef HAVE_GMTIME_R */
210
211 #if !defined(HAVE_ARC4RANDOM) && !defined(HAVE_RANDOM)
212 privoxy_mutex_t rand_mutex;
213 #endif /* !defined(HAVE_ARC4RANDOM) && !defined(HAVE_RANDOM) */
214
215 #endif /* def MUTEX_LOCKS_AVAILABLE */
216
217 #if defined(unix)
218 const char *basedir = NULL;
219 const char *pidfile = NULL;
220 static int received_hup_signal = 0;
221 #endif /* defined unix */
222
223 /* HTTP snipplets. */
224 static const char CSUCCEED[] =
225    "HTTP/1.1 200 Connection established\r\n\r\n";
226
227 static const char CHEADER[] =
228    "HTTP/1.1 400 Invalid header received from client\r\n"
229    "Content-Type: text/plain\r\n"
230    "Connection: close\r\n\r\n"
231    "Invalid header received from client.\r\n";
232
233 static const char FTP_RESPONSE[] =
234    "HTTP/1.1 400 Invalid request received from client\r\n"
235    "Content-Type: text/plain\r\n"
236    "Connection: close\r\n\r\n"
237    "Invalid request. Privoxy doesn't support FTP.\r\n";
238
239 static const char GOPHER_RESPONSE[] =
240    "HTTP/1.1 400 Invalid request received from client\r\n"
241    "Content-Type: text/plain\r\n"
242    "Connection: close\r\n\r\n"
243    "Invalid request. Privoxy doesn't support gopher.\r\n";
244
245 /* XXX: should be a template */
246 static const char MISSING_DESTINATION_RESPONSE[] =
247    "HTTP/1.1 400 Bad request received from client\r\n"
248    "Content-Type: text/plain\r\n"
249    "Connection: close\r\n\r\n"
250    "Bad request. Privoxy was unable to extract the destination.\r\n";
251
252 /* XXX: should be a template */
253 static const char INVALID_SERVER_HEADERS_RESPONSE[] =
254    "HTTP/1.1 502 Server or forwarder response invalid\r\n"
255    "Content-Type: text/plain\r\n"
256    "Connection: close\r\n\r\n"
257    "Bad response. The server or forwarder response doesn't look like HTTP.\r\n";
258
259 /* XXX: should be a template */
260 static const char MESSED_UP_REQUEST_RESPONSE[] =
261    "HTTP/1.1 400 Malformed request after rewriting\r\n"
262    "Content-Type: text/plain\r\n"
263    "Connection: close\r\n\r\n"
264    "Bad request. Messed up with header filters.\r\n";
265
266 static const char TOO_MANY_CONNECTIONS_RESPONSE[] =
267    "HTTP/1.1 503 Too many open connections\r\n"
268    "Content-Type: text/plain\r\n"
269    "Connection: close\r\n\r\n"
270    "Maximum number of open connections reached.\r\n";
271
272 static const char CLIENT_CONNECTION_TIMEOUT_RESPONSE[] =
273    "HTTP/1.1 504 Connection timeout\r\n"
274    "Content-Type: text/plain\r\n"
275    "Connection: close\r\n\r\n"
276    "The connection timed out because the client request didn't arrive in time.\r\n";
277
278 static const char CLIENT_BODY_PARSE_ERROR_RESPONSE[] =
279    "HTTP/1.1 400 Failed reading client body\r\n"
280    "Content-Type: text/plain\r\n"
281    "Connection: close\r\n\r\n"
282    "Failed parsing or buffering the chunk-encoded client body.\r\n";
283
284 static const char UNSUPPORTED_CLIENT_EXPECTATION_ERROR_RESPONSE[] =
285    "HTTP/1.1 417 Expecting too much\r\n"
286    "Content-Type: text/plain\r\n"
287    "Connection: close\r\n\r\n"
288    "Privoxy detected an unsupported Expect header value.\r\n";
289
290 /* A function to crunch a response */
291 typedef struct http_response *(*crunch_func_ptr)(struct client_state *);
292
293 /* Crunch function flags */
294 #define CF_NO_FLAGS        0
295 /* Cruncher applies to forced requests as well */
296 #define CF_IGNORE_FORCE    1
297 /* Crunched requests are counted for the block statistics */
298 #define CF_COUNT_AS_REJECT 2
299
300 /* A crunch function and its flags */
301 struct cruncher
302 {
303    const crunch_func_ptr cruncher;
304    const int flags;
305 };
306
307 static int crunch_response_triggered(struct client_state *csp, const struct cruncher crunchers[]);
308
309 /* Complete list of cruncher functions */
310 static const struct cruncher crunchers_all[] = {
311    { direct_response, CF_COUNT_AS_REJECT|CF_IGNORE_FORCE},
312    { block_url,       CF_COUNT_AS_REJECT },
313 #ifdef FEATURE_TRUST
314    { trust_url,       CF_COUNT_AS_REJECT },
315 #endif /* def FEATURE_TRUST */
316    { redirect_url,    CF_NO_FLAGS  },
317    { dispatch_cgi,    CF_IGNORE_FORCE},
318    { NULL,            0 }
319 };
320
321 /* Light version, used after tags are applied */
322 static const struct cruncher crunchers_light[] = {
323    { block_url,       CF_COUNT_AS_REJECT },
324    { redirect_url,    CF_NO_FLAGS },
325    { NULL,            0 }
326 };
327
328
329 /*
330  * XXX: Don't we really mean
331  *
332  * #if defined(unix)
333  *
334  * here?
335  */
336 #if !defined(_WIN32)
337 /*********************************************************************
338  *
339  * Function    :  sig_handler
340  *
341  * Description :  Signal handler for different signals.
342  *                Exit gracefully on TERM and INT
343  *                or set a flag that will cause the errlog
344  *                to be reopened by the main thread on HUP.
345  *
346  * Parameters  :
347  *          1  :  the_signal = the signal cause this function to call
348  *
349  * Returns     :  -
350  *
351  *********************************************************************/
352 static void sig_handler(int the_signal)
353 {
354    switch(the_signal)
355    {
356       case SIGTERM:
357       case SIGINT:
358          log_error(LOG_LEVEL_INFO, "exiting by signal %d .. bye", the_signal);
359 #if defined(unix)
360          if (pidfile)
361          {
362             unlink(pidfile);
363          }
364 #endif /* unix */
365          exit(the_signal);
366          break;
367
368       case SIGHUP:
369 #if defined(unix)
370          received_hup_signal = 1;
371 #endif
372          break;
373
374       default:
375          /*
376           * We shouldn't be here, unless we catch signals
377           * in main() that we can't handle here!
378           */
379          log_error(LOG_LEVEL_FATAL, "sig_handler: exiting on unexpected signal %d", the_signal);
380    }
381    return;
382
383 }
384 #endif
385
386
387 /*********************************************************************
388  *
389  * Function    :  get_write_delay
390  *
391  * Description :  Parse the delay-response parameter.
392  *
393  * Parameters  :
394  *          1  :  csp = Current client state (buffers, headers, etc...)
395  *
396  * Returns     :  Number of milliseconds to delay writes.
397  *
398  *********************************************************************/
399 static unsigned int get_write_delay(const struct client_state *csp)
400 {
401    unsigned int delay;
402    char *endptr;
403    char *newval;
404
405    if ((csp->action->flags & ACTION_DELAY_RESPONSE) == 0)
406    {
407       return 0;
408    }
409    newval = csp->action->string[ACTION_STRING_DELAY_RESPONSE];
410
411    delay = (unsigned)strtol(newval, &endptr, 0);
412    if (*endptr != '\0')
413    {
414       log_error(LOG_LEVEL_FATAL,
415          "Invalid delay-response{} parameter: '%s'", newval);
416    }
417
418    return delay;
419
420 }
421
422
423 /*********************************************************************
424  *
425  * Function    :  client_protocol_is_unsupported
426  *
427  * Description :  Checks if the client used a known unsupported
428  *                protocol and deals with it by sending an error
429  *                response.
430  *
431  * Parameters  :
432  *          1  :  csp = Current client state (buffers, headers, etc...)
433  *          2  :  req = the first request line send by the client
434  *
435  * Returns     :  TRUE if an error response has been generated, or
436  *                FALSE if the request doesn't look invalid.
437  *
438  *********************************************************************/
439 static int client_protocol_is_unsupported(struct client_state *csp, char *req)
440 {
441    /*
442     * If it's a FTP or gopher request, we don't support it.
443     *
444     * These checks are better than nothing, but they might
445     * not work in all configurations and some clients might
446     * have problems digesting the answer.
447     *
448     * They should, however, never cause more problems than
449     * Privoxy's old behaviour (returning the misleading HTML
450     * error message:
451     *
452     * "Could not resolve http://(ftp|gopher)://example.org").
453     */
454    if (!strncmpic(req, "GET ftp://", 10) || !strncmpic(req, "GET gopher://", 13))
455    {
456       const char *response = NULL;
457       const char *protocol = NULL;
458
459       if (!strncmpic(req, "GET ftp://", 10))
460       {
461          response = FTP_RESPONSE;
462          protocol = "FTP";
463       }
464       else
465       {
466          response = GOPHER_RESPONSE;
467          protocol = "GOPHER";
468       }
469       log_error(LOG_LEVEL_ERROR,
470          "%s tried to use Privoxy as %s proxy: %s",
471          csp->ip_addr_str, protocol, req);
472       log_error(LOG_LEVEL_CLF,
473          "%s - - [%T] \"%s\" 400 0", csp->ip_addr_str, req);
474       freez(req);
475
476 #ifdef FEATURE_HTTPS_INSPECTION
477       if (client_use_ssl(csp))
478       {
479          ssl_send_data_delayed(&(csp->ssl_client_attr),
480             (const unsigned char *)response, strlen(response),
481             get_write_delay(csp));
482       }
483       else
484 #endif
485       {
486          write_socket_delayed(csp->cfd, response, strlen(response),
487             get_write_delay(csp));
488       }
489
490       return TRUE;
491    }
492
493    return FALSE;
494 }
495
496
497 /*********************************************************************
498  *
499  * Function    :  client_has_unsupported_expectations
500  *
501  * Description :  Checks if the client used an unsupported expectation
502  *                in which case an error message is delivered.
503  *
504  * Parameters  :
505  *          1  :  csp = Current client state (buffers, headers, etc...)
506  *
507  * Returns     :  TRUE if an error response has been generated, or
508  *                FALSE if the request doesn't look invalid.
509  *
510  *********************************************************************/
511 static int client_has_unsupported_expectations(const struct client_state *csp)
512 {
513    if ((csp->flags & CSP_FLAG_UNSUPPORTED_CLIENT_EXPECTATION))
514    {
515       log_error(LOG_LEVEL_ERROR,
516          "Rejecting request from client %s with unsupported Expect header value",
517          csp->ip_addr_str);
518       log_error(LOG_LEVEL_CLF,
519          "%s - - [%T] \"%s\" 417 0", csp->ip_addr_str, csp->http->cmd);
520       write_socket_delayed(csp->cfd,
521          UNSUPPORTED_CLIENT_EXPECTATION_ERROR_RESPONSE,
522          strlen(UNSUPPORTED_CLIENT_EXPECTATION_ERROR_RESPONSE),
523          get_write_delay(csp));
524
525       return TRUE;
526    }
527
528    return FALSE;
529
530 }
531
532
533 /*********************************************************************
534  *
535  * Function    :  get_request_destination_elsewhere
536  *
537  * Description :  If the client's request was redirected into
538  *                Privoxy without the client's knowledge,
539  *                the request line lacks the destination host.
540  *
541  *                This function tries to get it elsewhere,
542  *                provided accept-intercepted-requests is enabled.
543  *
544  *                "Elsewhere" currently only means "Host: header",
545  *                but in the future we may ask the redirecting
546  *                packet filter to look the destination up.
547  *
548  *                If the destination stays unknown, an error
549  *                response is send to the client and headers
550  *                are freed so that chat() can return directly.
551  *
552  * Parameters  :
553  *          1  :  csp = Current client state (buffers, headers, etc...)
554  *          2  :  headers = a header list
555  *
556  * Returns     :  JB_ERR_OK if the destination is now known, or
557  *                JB_ERR_PARSE if it isn't.
558  *
559  *********************************************************************/
560 static jb_err get_request_destination_elsewhere(struct client_state *csp, struct list *headers)
561 {
562    if (!(csp->config->feature_flags & RUNTIME_FEATURE_ACCEPT_INTERCEPTED_REQUESTS))
563    {
564       log_error(LOG_LEVEL_ERROR, "%s's request: \'%s\' is invalid."
565          " Privoxy isn't configured to accept intercepted requests.",
566          csp->ip_addr_str, csp->http->cmd);
567       /* XXX: Use correct size */
568       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s\" 400 0",
569          csp->ip_addr_str, csp->http->cmd);
570
571       write_socket_delayed(csp->cfd, CHEADER, strlen(CHEADER),
572          get_write_delay(csp));
573       destroy_list(headers);
574
575       return JB_ERR_PARSE;
576    }
577    else if (JB_ERR_OK == get_destination_from_headers(headers, csp->http))
578    {
579       /* Split the domain we just got for pattern matching */
580       init_domain_components(csp->http);
581
582       return JB_ERR_OK;
583    }
584    else
585    {
586       /* We can't work without destination. Go spread the news.*/
587
588       /* XXX: Use correct size */
589       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s\" 400 0",
590          csp->ip_addr_str, csp->http->cmd);
591       log_error(LOG_LEVEL_ERROR,
592          "Privoxy was unable to get the destination for %s's request: %s",
593          csp->ip_addr_str, csp->http->cmd);
594
595       write_socket_delayed(csp->cfd, MISSING_DESTINATION_RESPONSE,
596          strlen(MISSING_DESTINATION_RESPONSE), get_write_delay(csp));
597       destroy_list(headers);
598
599       return JB_ERR_PARSE;
600    }
601    /*
602     * TODO: If available, use PF's ioctl DIOCNATLOOK as last resort
603     * to get the destination IP address, use it as host directly
604     * or do a reverse DNS lookup first.
605     */
606 }
607
608
609 /*********************************************************************
610  *
611  * Function    :  get_server_headers
612  *
613  * Description :  Parses server headers in iob and fills them
614  *                into csp->headers so that they can later be
615  *                handled by sed().
616  *
617  * Parameters  :
618  *          1  :  csp = Current client state (buffers, headers, etc...)
619  *
620  * Returns     :  JB_ERR_OK if everything went fine, or
621  *                JB_ERR_PARSE if the headers were incomplete.
622  *
623  *********************************************************************/
624 static jb_err get_server_headers(struct client_state *csp)
625 {
626    int continue_hack_in_da_house = 0;
627    char * header;
628
629    while (((header = get_header(csp->iob)) != NULL) || continue_hack_in_da_house)
630    {
631       if (header == NULL)
632       {
633          /*
634           * continue hack in da house. Ignore the ending of
635           * this head and continue enlisting header lines.
636           * The reason is described below.
637           */
638          enlist(csp->headers, "");
639          continue_hack_in_da_house = 0;
640          continue;
641       }
642       else if (0 == strncmpic(header, "HTTP/1.1 100", 12))
643       {
644          /*
645           * It's a bodyless continue response, don't
646           * stop header parsing after reaching its end.
647           *
648           * As a result Privoxy will concatenate the
649           * next response's head and parse and deliver
650           * the headers as if they belonged to one request.
651           *
652           * The client will separate them because of the
653           * empty line between them.
654           *
655           * XXX: What we're doing here is clearly against
656           * the intended purpose of the continue header,
657           * and under some conditions (HTTP/1.0 client request)
658           * it's a standard violation.
659           *
660           * Anyway, "sort of against the spec" is preferable
661           * to "always getting confused by Continue responses"
662           * (Privoxy's behaviour before this hack was added)
663           */
664          log_error(LOG_LEVEL_HEADER, "Continue hack in da house.");
665          continue_hack_in_da_house = 1;
666       }
667       else if (*header == '\0')
668       {
669          /*
670           * If the header is empty, but the Continue hack
671           * isn't active, we can assume that we reached the
672           * end of the buffer before we hit the end of the
673           * head.
674           *
675           * Inform the caller an let it decide how to handle it.
676           */
677          return JB_ERR_PARSE;
678       }
679
680       if (JB_ERR_MEMORY == enlist(csp->headers, header))
681       {
682          /*
683           * XXX: Should we quit the request and return a
684           * out of memory error page instead?
685           */
686          log_error(LOG_LEVEL_ERROR,
687             "Out of memory while enlisting server headers. %s lost.",
688             header);
689       }
690       freez(header);
691    }
692
693    return JB_ERR_OK;
694 }
695
696
697 /*********************************************************************
698  *
699  * Function    :  crunch_reason
700  *
701  * Description :  Translates the crunch reason code into a string.
702  *
703  * Parameters  :
704  *          1  :  rsp = a http_response
705  *
706  * Returns     :  A string with the crunch reason or an error description.
707  *
708  *********************************************************************/
709 static const char *crunch_reason(const struct http_response *rsp)
710 {
711    char * reason = NULL;
712
713    assert(rsp != NULL);
714    if (rsp == NULL)
715    {
716       return "Internal error while searching for crunch reason";
717    }
718
719    switch (rsp->crunch_reason)
720    {
721       case UNSUPPORTED:
722          reason = "Unsupported HTTP feature";
723          break;
724       case BLOCKED:
725          reason = "Blocked";
726          break;
727       case UNTRUSTED:
728          reason = "Untrusted";
729          break;
730       case REDIRECTED:
731          reason = "Redirected";
732          break;
733       case CGI_CALL:
734          reason = "CGI Call";
735          break;
736       case NO_SUCH_DOMAIN:
737          reason = "DNS failure";
738          break;
739       case FORWARDING_FAILED:
740          reason = "Forwarding failed";
741          break;
742       case CONNECT_FAILED:
743          reason = "Connection failure";
744          break;
745       case OUT_OF_MEMORY:
746          reason = "Out of memory (may mask other reasons)";
747          break;
748       case CONNECTION_TIMEOUT:
749          reason = "Connection timeout";
750          break;
751       case NO_SERVER_DATA:
752          reason = "No server data received";
753          break;
754       default:
755          reason = "No reason recorded";
756          break;
757    }
758
759    return reason;
760 }
761
762
763 /*********************************************************************
764  *
765  * Function    :  log_applied_actions
766  *
767  * Description :  Logs the applied actions if LOG_LEVEL_ACTIONS is
768  *                enabled.
769  *
770  * Parameters  :
771  *          1  :  actions = Current action spec to log
772  *
773  * Returns     :  Nothing.
774  *
775  *********************************************************************/
776 static void log_applied_actions(const struct current_action_spec *actions)
777 {
778    /*
779     * The conversion to text requires lots of memory allocations so
780     * we only do the conversion if the user is actually interested.
781     */
782    if (debug_level_is_enabled(LOG_LEVEL_ACTIONS))
783    {
784       char *actions_as_text = actions_to_line_of_text(actions);
785       log_error(LOG_LEVEL_ACTIONS, "%s", actions_as_text);
786       freez(actions_as_text);
787    }
788 }
789
790
791 /*********************************************************************
792  *
793  * Function    :  send_crunch_response
794  *
795  * Description :  Delivers already prepared response for
796  *                intercepted requests, logs the interception
797  *                and frees the response.
798  *
799  * Parameters  :
800  *          1  :  csp = Current client state (buffers, headers, etc...)
801  *          2  :  rsp = Fully prepared response. Will be freed on exit.
802  *
803  * Returns     :  Nothing.
804  *
805  *********************************************************************/
806 static void send_crunch_response(struct client_state *csp, struct http_response *rsp)
807 {
808       const struct http_request *http = csp->http;
809       char status_code[4];
810
811       assert(rsp != NULL);
812       assert(rsp->head != NULL);
813
814       if (rsp == NULL)
815       {
816          log_error(LOG_LEVEL_FATAL, "NULL response in send_crunch_response.");
817       }
818
819       /*
820        * Extract the status code from the actual head
821        * that will be send to the client. It is the only
822        * way to get it right for all requests, including
823        * the fixed ones for out-of-memory problems.
824        *
825        * A head starts like this: 'HTTP/1.1 200...'
826        *                           0123456789|11
827        *                                     10
828        */
829       status_code[0] = rsp->head[9];
830       status_code[1] = rsp->head[10];
831       status_code[2] = rsp->head[11];
832       status_code[3] = '\0';
833
834       /* Log that the request was crunched and why. */
835       log_applied_actions(csp->action);
836 #ifdef FEATURE_HTTPS_INSPECTION
837       if (client_use_ssl(csp))
838       {
839          log_error(LOG_LEVEL_CRUNCH, "%s: https://%s%s", crunch_reason(rsp),
840             http->hostport, http->path);
841          log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s https://%s%s %s\" %s %lu",
842             csp->ip_addr_str, http->gpc, http->hostport, http->path,
843             http->version, status_code, rsp->content_length);
844       }
845       else
846 #endif
847       {
848          log_error(LOG_LEVEL_CRUNCH, "%s: %s", crunch_reason(rsp), http->url);
849          log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s\" %s %lu",
850             csp->ip_addr_str, http->ocmd, status_code, rsp->content_length);
851       }
852       /* Write the answer to the client */
853 #ifdef FEATURE_HTTPS_INSPECTION
854       if (client_use_ssl(csp))
855       {
856          if ((ssl_send_data_delayed(&(csp->ssl_client_attr),
857                 (const unsigned char *)rsp->head, rsp->head_length,
858                 get_write_delay(csp)) < 0)
859           || (ssl_send_data_delayed(&(csp->ssl_client_attr),
860                 (const unsigned char *)rsp->body, rsp->content_length,
861                 get_write_delay(csp)) < 0))
862          {
863             /* There is nothing we can do about it. */
864             log_error(LOG_LEVEL_CONNECT, "Couldn't deliver the error message "
865                "for https://%s%s through client socket %d using TLS/SSL",
866                http->hostport, http->url, csp->cfd);
867          }
868       }
869       else
870 #endif
871       {
872          if (write_socket_delayed(csp->cfd, rsp->head, rsp->head_length,
873                 get_write_delay(csp))
874           || write_socket_delayed(csp->cfd, rsp->body, rsp->content_length,
875                 get_write_delay(csp)))
876          {
877             /* There is nothing we can do about it. */
878             log_error(LOG_LEVEL_CONNECT,
879                "Couldn't deliver the error message for %s through client socket %d: %E",
880                http->url, csp->cfd);
881          }
882       }
883
884       /* Clean up and return */
885       if (cgi_error_memory() != rsp)
886       {
887          free_http_response(rsp);
888       }
889       return;
890 }
891
892
893 /*********************************************************************
894  *
895  * Function    :  crunch_response_triggered
896  *
897  * Description :  Checks if the request has to be crunched,
898  *                and delivers the crunch response if necessary.
899  *
900  * Parameters  :
901  *          1  :  csp = Current client state (buffers, headers, etc...)
902  *          2  :  crunchers = list of cruncher functions to run
903  *
904  * Returns     :  TRUE if the request was answered with a crunch response
905  *                FALSE otherwise.
906  *
907  *********************************************************************/
908 static int crunch_response_triggered(struct client_state *csp, const struct cruncher crunchers[])
909 {
910    struct http_response *rsp = NULL;
911    const struct cruncher *c;
912
913    /*
914     * If CGI request crunching is disabled,
915     * check the CGI dispatcher out of order to
916     * prevent unintentional blocks or redirects.
917     */
918    if (!(csp->config->feature_flags & RUNTIME_FEATURE_CGI_CRUNCHING)
919        && (NULL != (rsp = dispatch_cgi(csp))))
920    {
921       /* Deliver, log and free the interception response. */
922       send_crunch_response(csp, rsp);
923       csp->flags |= CSP_FLAG_CRUNCHED;
924       return TRUE;
925    }
926
927    for (c = crunchers; c->cruncher != NULL; c++)
928    {
929       /*
930        * Check the cruncher if either Privoxy is toggled
931        * on and the request isn't forced, or if the cruncher
932        * applies to forced requests as well.
933        */
934       if (((csp->flags & CSP_FLAG_TOGGLED_ON) &&
935           !(csp->flags & CSP_FLAG_FORCED)) ||
936           (c->flags & CF_IGNORE_FORCE))
937       {
938          rsp = c->cruncher(csp);
939          if (NULL != rsp)
940          {
941             /* Deliver, log and free the interception response. */
942             send_crunch_response(csp, rsp);
943             csp->flags |= CSP_FLAG_CRUNCHED;
944 #ifdef FEATURE_STATISTICS
945             if (c->flags & CF_COUNT_AS_REJECT)
946             {
947                csp->flags |= CSP_FLAG_REJECTED;
948             }
949 #endif /* def FEATURE_STATISTICS */
950
951             return TRUE;
952          }
953       }
954    }
955
956    return FALSE;
957 }
958
959
960 /*********************************************************************
961  *
962  * Function    :  build_request_line
963  *
964  * Description :  Builds the HTTP request line.
965  *
966  *                If a HTTP forwarder is used it expects the whole URL,
967  *                web servers only get the path.
968  *
969  * Parameters  :
970  *          1  :  csp = Current client state (buffers, headers, etc...)
971  *          2  :  fwd = The forwarding spec used for the request.
972  *                      Can be NULL.
973  *          3  :  request_line = The old request line which will be replaced.
974  *
975  * Returns     :  Nothing. Terminates in case of memory problems.
976  *
977  *********************************************************************/
978 static void build_request_line(struct client_state *csp, const struct forward_spec *fwd, char **request_line)
979 {
980    struct http_request *http = csp->http;
981
982    /*
983     * Downgrade http version from 1.1 to 1.0
984     * if +downgrade action applies.
985     */
986    if ((csp->action->flags & ACTION_DOWNGRADE)
987      && (!strcmpic(http->version, "HTTP/1.1")))
988    {
989       freez(http->version);
990       http->version = strdup_or_die("HTTP/1.0");
991    }
992
993    /*
994     * Rebuild the request line.
995     */
996    freez(*request_line);
997    *request_line = strdup(http->gpc);
998    string_append(request_line, " ");
999
1000    if (fwd != NULL && fwd->forward_host && fwd->type != FORWARD_WEBSERVER)
1001    {
1002       string_append(request_line, http->url);
1003    }
1004    else
1005    {
1006       string_append(request_line, http->path);
1007    }
1008    string_append(request_line, " ");
1009    string_append(request_line, http->version);
1010
1011    if (*request_line == NULL)
1012    {
1013       log_error(LOG_LEVEL_FATAL, "Out of memory writing HTTP command");
1014    }
1015    log_error(LOG_LEVEL_HEADER, "New HTTP Request-Line: %s", *request_line);
1016 }
1017
1018
1019 /*********************************************************************
1020  *
1021  * Function    :  change_request_destination
1022  *
1023  * Description :  Parse a (rewritten) request line and regenerate
1024  *                the http request data.
1025  *
1026  * Parameters  :
1027  *          1  :  csp = Current client state (buffers, headers, etc...)
1028  *
1029  * Returns     :  Forwards the parse_http_request() return code.
1030  *                Terminates in case of memory problems.
1031  *
1032  *********************************************************************/
1033 static jb_err change_request_destination(struct client_state *csp)
1034 {
1035    struct http_request *http = csp->http;
1036    jb_err err;
1037
1038    log_error(LOG_LEVEL_REDIRECTS, "Rewrite detected: %s",
1039       csp->headers->first->str);
1040    free_http_request(http);
1041    err = parse_http_request(csp->headers->first->str, http);
1042    if (JB_ERR_OK != err)
1043    {
1044       log_error(LOG_LEVEL_ERROR, "Couldn't parse rewritten request: %s.",
1045          jb_err_to_string(err));
1046    }
1047    if (http->ssl && strcmpic(csp->http->gpc, "CONNECT"))
1048    {
1049       /*
1050        * A client header filter changed the request URL from
1051        * http:// to https:// which we currently don't support.
1052        */
1053       log_error(LOG_LEVEL_ERROR, "Changing the request destination from http "
1054          "to https behind the client's back currently isn't supported.");
1055       return JB_ERR_PARSE;
1056    }
1057
1058    return err;
1059 }
1060
1061
1062 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
1063 /*********************************************************************
1064  *
1065  * Function    :  server_response_is_complete
1066  *
1067  * Description :  Determines whether we should stop reading
1068  *                from the server socket.
1069  *
1070  * Parameters  :
1071  *          1  :  csp = Current client state (buffers, headers, etc...)
1072  *          2  :  content_length = Length of content received so far.
1073  *
1074  * Returns     :  TRUE if the response is complete,
1075  *                FALSE otherwise.
1076  *
1077  *********************************************************************/
1078 static int server_response_is_complete(struct client_state *csp,
1079    unsigned long long content_length)
1080 {
1081    int content_length_known = !!(csp->flags & CSP_FLAG_CONTENT_LENGTH_SET);
1082
1083    if (!strcmpic(csp->http->gpc, "HEAD"))
1084    {
1085       /*
1086        * "HEAD" implies no body, we are thus expecting
1087        * no content. XXX: incomplete "list" of methods?
1088        */
1089       csp->expected_content_length = 0;
1090       content_length_known = TRUE;
1091       csp->flags |= CSP_FLAG_SERVER_CONTENT_LENGTH_SET;
1092    }
1093
1094    if (csp->http->status == 204 || csp->http->status == 304)
1095    {
1096       /*
1097        * Expect no body. XXX: incomplete "list" of status codes?
1098        */
1099       csp->expected_content_length = 0;
1100       content_length_known = TRUE;
1101       csp->flags |= CSP_FLAG_SERVER_CONTENT_LENGTH_SET;
1102    }
1103
1104    return (content_length_known && ((0 == csp->expected_content_length)
1105             || (csp->expected_content_length <= content_length)));
1106 }
1107
1108
1109 #ifdef FEATURE_CONNECTION_SHARING
1110 /*********************************************************************
1111  *
1112  * Function    :  wait_for_alive_connections
1113  *
1114  * Description :  Waits for alive connections to timeout.
1115  *
1116  * Parameters  :  N/A
1117  *
1118  * Returns     :  N/A
1119  *
1120  *********************************************************************/
1121 static void wait_for_alive_connections(void)
1122 {
1123    int connections_alive = close_unusable_connections();
1124
1125    while (0 < connections_alive)
1126    {
1127       log_error(LOG_LEVEL_CONNECT,
1128          "Waiting for %d connections to timeout.",
1129          connections_alive);
1130       sleep(60);
1131       connections_alive = close_unusable_connections();
1132    }
1133
1134    log_error(LOG_LEVEL_CONNECT, "No connections to wait for left.");
1135
1136 }
1137 #endif /* def FEATURE_CONNECTION_SHARING */
1138
1139
1140 /*********************************************************************
1141  *
1142  * Function    :  save_connection_destination
1143  *
1144  * Description :  Remembers a connection for reuse later on.
1145  *
1146  * Parameters  :
1147  *          1  :  sfd  = Open socket to remember.
1148  *          2  :  http = The destination for the connection.
1149  *          3  :  fwd  = The forwarder settings used.
1150  *          4  :  server_connection  = storage.
1151  *
1152  * Returns     : void
1153  *
1154  *********************************************************************/
1155 void save_connection_destination(jb_socket sfd,
1156                                  const struct http_request *http,
1157                                  const struct forward_spec *fwd,
1158                                  struct reusable_connection *server_connection)
1159 {
1160    assert(sfd != JB_INVALID_SOCKET);
1161    assert(NULL != http->host);
1162
1163    server_connection->sfd = sfd;
1164    server_connection->host = strdup_or_die(http->host);
1165    server_connection->port = http->port;
1166
1167    assert(NULL != fwd);
1168    assert(server_connection->gateway_host == NULL);
1169    assert(server_connection->gateway_port == 0);
1170    assert(server_connection->forwarder_type == 0);
1171    assert(server_connection->forward_host == NULL);
1172    assert(server_connection->forward_port == 0);
1173
1174    server_connection->forwarder_type = fwd->type;
1175    if (NULL != fwd->gateway_host)
1176    {
1177       server_connection->gateway_host = strdup_or_die(fwd->gateway_host);
1178    }
1179    else
1180    {
1181       server_connection->gateway_host = NULL;
1182    }
1183    server_connection->gateway_port = fwd->gateway_port;
1184    if (NULL != fwd->auth_username)
1185    {
1186       server_connection->auth_username = strdup_or_die(fwd->auth_username);
1187    }
1188    else
1189    {
1190       server_connection->auth_username = NULL;
1191    }
1192    if (NULL != fwd->auth_password)
1193    {
1194       server_connection->auth_password = strdup_or_die(fwd->auth_password);
1195    }
1196    else
1197    {
1198       server_connection->auth_password = NULL;
1199    }
1200
1201    if (NULL != fwd->forward_host)
1202    {
1203       server_connection->forward_host = strdup_or_die(fwd->forward_host);
1204    }
1205    else
1206    {
1207       server_connection->forward_host = NULL;
1208    }
1209    server_connection->forward_port = fwd->forward_port;
1210 }
1211 #endif /* FEATURE_CONNECTION_KEEP_ALIVE */
1212
1213
1214 /*********************************************************************
1215  *
1216  * Function    : verify_request_length
1217  *
1218  * Description : Checks if we already got the whole client requests
1219  *               and sets CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ if
1220  *               we do.
1221  *
1222  *               Data that doesn't belong to the current request is
1223  *               either thrown away to let the client retry on a clean
1224  *               socket, or stashed to be dealt with after the current
1225  *               request is served.
1226  *
1227  * Parameters  :
1228  *          1  :  csp = Current client state (buffers, headers, etc...)
1229  *
1230  * Returns     :  void
1231  *
1232  *********************************************************************/
1233 static void verify_request_length(struct client_state *csp)
1234 {
1235    unsigned long long buffered_request_bytes =
1236       (unsigned long long)(csp->client_iob->eod - csp->client_iob->cur);
1237
1238    if ((csp->expected_client_content_length != 0)
1239       && (buffered_request_bytes != 0))
1240    {
1241       if (csp->expected_client_content_length >= buffered_request_bytes)
1242       {
1243          csp->expected_client_content_length -= buffered_request_bytes;
1244          log_error(LOG_LEVEL_CONNECT, "Reduced expected bytes to %llu "
1245             "to account for the %llu ones we already got.",
1246             csp->expected_client_content_length, buffered_request_bytes);
1247       }
1248       else
1249       {
1250          assert(csp->client_iob->eod > csp->client_iob->cur + csp->expected_client_content_length);
1251          csp->client_iob->eod = csp->client_iob->cur + csp->expected_client_content_length;
1252          log_error(LOG_LEVEL_CONNECT, "Reducing expected bytes to 0. "
1253             "Marking the server socket tainted after throwing %llu bytes away.",
1254             buffered_request_bytes - csp->expected_client_content_length);
1255          csp->expected_client_content_length = 0;
1256          csp->flags |= CSP_FLAG_SERVER_SOCKET_TAINTED;
1257       }
1258
1259       if (csp->expected_client_content_length == 0)
1260       {
1261          csp->flags |= CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ;
1262       }
1263    }
1264
1265    if (!(csp->flags & CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ)
1266       && ((csp->client_iob->cur < csp->client_iob->eod)
1267          || (csp->expected_client_content_length != 0)))
1268    {
1269       if (strcmpic(csp->http->gpc, "GET")
1270          && strcmpic(csp->http->gpc, "HEAD")
1271          && strcmpic(csp->http->gpc, "TRACE")
1272          && strcmpic(csp->http->gpc, "OPTIONS")
1273          && strcmpic(csp->http->gpc, "DELETE"))
1274       {
1275          /* XXX: this is an incomplete hack */
1276          csp->flags &= ~CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ;
1277          log_error(LOG_LEVEL_CONNECT, "There better be a request body.");
1278       }
1279       else
1280       {
1281          csp->flags |= CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ;
1282
1283          if ((csp->config->feature_flags & RUNTIME_FEATURE_TOLERATE_PIPELINING) == 0)
1284          {
1285             csp->flags |= CSP_FLAG_SERVER_SOCKET_TAINTED;
1286             log_error(LOG_LEVEL_CONNECT,
1287                "Possible pipeline attempt detected. The connection will not "
1288                "be kept alive and we will only serve the first request.");
1289             /* Nuke the pipelined requests from orbit, just to be sure. */
1290             clear_iob(csp->client_iob);
1291          }
1292          else
1293          {
1294             /*
1295              * Keep the pipelined data around for now, we'll deal with
1296              * it once we're done serving the current request.
1297              */
1298             csp->flags |= CSP_FLAG_PIPELINED_REQUEST_WAITING;
1299             assert(csp->client_iob->eod >= csp->client_iob->cur);
1300             log_error(LOG_LEVEL_CONNECT, "Complete client request followed by "
1301                "%d bytes of pipelined data received.",
1302                (int)(csp->client_iob->eod - csp->client_iob->cur));
1303          }
1304       }
1305    }
1306    else
1307    {
1308       csp->flags |= CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ;
1309       log_error(LOG_LEVEL_CONNECT, "Complete client request received.");
1310    }
1311 }
1312
1313
1314 /*********************************************************************
1315  *
1316  * Function    :  mark_server_socket_tainted
1317  *
1318  * Description :  Makes sure we don't reuse a server socket
1319  *                (if we didn't read everything the server sent
1320  *                us reusing the socket would lead to garbage).
1321  *
1322  * Parameters  :
1323  *          1  :  csp = Current client state (buffers, headers, etc...)
1324  *
1325  * Returns     :  void.
1326  *
1327  *********************************************************************/
1328 static void mark_server_socket_tainted(struct client_state *csp)
1329 {
1330    /*
1331     * For consistency we always mark the server socket
1332     * tainted, however, to reduce the log noise we only
1333     * emit a log message if the server socket could have
1334     * actually been reused.
1335     */
1336    if ((csp->flags & CSP_FLAG_SERVER_CONNECTION_KEEP_ALIVE)
1337       && !(csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED))
1338    {
1339       log_error(LOG_LEVEL_CONNECT,
1340          "Marking the server socket %d tainted.",
1341          csp->server_connection.sfd);
1342    }
1343    csp->flags |= CSP_FLAG_SERVER_SOCKET_TAINTED;
1344 }
1345
1346 /*********************************************************************
1347  *
1348  * Function    :  get_request_line
1349  *
1350  * Description : Read the client request line.
1351  *
1352  * Parameters  :
1353  *          1  :  csp = Current client state (buffers, headers, etc...)
1354  *
1355  * Returns     :  Pointer to request line or NULL in case of errors.
1356  *
1357  *********************************************************************/
1358 static char *get_request_line(struct client_state *csp)
1359 {
1360    char buf[BUFFER_SIZE];
1361    char *request_line = NULL;
1362    int len;
1363
1364    memset(buf, 0, sizeof(buf));
1365
1366    if ((csp->flags & CSP_FLAG_PIPELINED_REQUEST_WAITING) != 0)
1367    {
1368       /*
1369        * If there are multiple pipelined requests waiting,
1370        * the flag will be set again once the next request
1371        * has been parsed.
1372        */
1373       csp->flags &= ~CSP_FLAG_PIPELINED_REQUEST_WAITING;
1374
1375       request_line = get_header(csp->client_iob);
1376       if ((NULL != request_line) && ('\0' != *request_line))
1377       {
1378          return request_line;
1379       }
1380       else
1381       {
1382          log_error(LOG_LEVEL_CONNECT, "No complete request line "
1383             "received yet. Continuing reading from %d.", csp->cfd);
1384       }
1385    }
1386
1387    do
1388    {
1389       if (
1390 #ifdef FUZZ
1391           0 == (csp->flags & CSP_FLAG_FUZZED_INPUT) &&
1392 #endif
1393           !data_is_available(csp->cfd, csp->config->socket_timeout)
1394           )
1395       {
1396          if (socket_is_still_alive(csp->cfd))
1397          {
1398             log_error(LOG_LEVEL_CONNECT,
1399                "No request line on socket %d received in time. Timeout: %d.",
1400                csp->cfd, csp->config->socket_timeout);
1401             write_socket_delayed(csp->cfd, CLIENT_CONNECTION_TIMEOUT_RESPONSE,
1402                strlen(CLIENT_CONNECTION_TIMEOUT_RESPONSE),
1403                get_write_delay(csp));
1404          }
1405          else
1406          {
1407             log_error(LOG_LEVEL_CONNECT,
1408                "The client side of the connection on socket %d got "
1409                "closed without sending a complete request line.", csp->cfd);
1410          }
1411          return NULL;
1412       }
1413
1414       len = read_socket(csp->cfd, buf, sizeof(buf) - 1);
1415
1416       if (len <= 0) return NULL;
1417
1418       /*
1419        * If there is no memory left for buffering the
1420        * request, there is nothing we can do but hang up
1421        */
1422       if (add_to_iob(csp->client_iob, csp->config->buffer_limit, buf, len))
1423       {
1424          return NULL;
1425       }
1426
1427       request_line = get_header(csp->client_iob);
1428
1429    } while ((NULL != request_line) && ('\0' == *request_line));
1430
1431    return request_line;
1432
1433 }
1434
1435 enum chunk_status
1436 {
1437    CHUNK_STATUS_MISSING_DATA,
1438    CHUNK_STATUS_BODY_COMPLETE,
1439    CHUNK_STATUS_PARSE_ERROR
1440 };
1441
1442
1443 /*********************************************************************
1444  *
1445  * Function    :  chunked_body_is_complete
1446  *
1447  * Description :  Figures out whether or not a chunked body is complete.
1448  *
1449  *                Currently it always starts at the beginning of the
1450  *                buffer which is somewhat wasteful and prevents Privoxy
1451  *                from starting to forward the correctly parsed chunks
1452  *                as soon as theoretically possible.
1453  *
1454  *                Should be modified to work with a common buffer,
1455  *                and allow the caller to skip already parsed chunks.
1456  *
1457  *                This would allow the function to be used for unbuffered
1458  *                response bodies as well.
1459  *
1460  * Parameters  :
1461  *          1  :  iob = Buffer with the body to check.
1462  *          2  :  length = Length of complete body
1463  *
1464  * Returns     :  Enum with the result of the check.
1465  *
1466  *********************************************************************/
1467 static enum chunk_status chunked_body_is_complete(struct iob *iob, size_t *length)
1468 {
1469    unsigned int chunksize;
1470    char *p = iob->cur;
1471
1472    do
1473    {
1474       /*
1475        * We need at least a single digit, followed by "\r\n",
1476        * followed by an unknown amount of data, followed by "\r\n".
1477        */
1478       if (p + 5 > iob->eod)
1479       {
1480          return CHUNK_STATUS_MISSING_DATA;
1481       }
1482       if (sscanf(p, "%x", &chunksize) != 1)
1483       {
1484          return CHUNK_STATUS_PARSE_ERROR;
1485       }
1486
1487       /*
1488        * We want at least a single digit, followed by "\r\n",
1489        * followed by the specified amount of data, followed by "\r\n".
1490        */
1491       if (p + chunksize + 5 > iob->eod)
1492       {
1493          return CHUNK_STATUS_MISSING_DATA;
1494       }
1495
1496       /* Skip chunk-size. */
1497       p = strstr(p, "\r\n");
1498       if (NULL == p)
1499       {
1500          return CHUNK_STATUS_PARSE_ERROR;
1501       }
1502       /* Move beyond the chunkdata. */
1503       p += 2 + chunksize;
1504
1505       /* There should be another "\r\n" to skip */
1506       if (memcmp(p, "\r\n", 2))
1507       {
1508          return CHUNK_STATUS_PARSE_ERROR;
1509       }
1510       p += 2;
1511    } while (chunksize > 0U);
1512
1513    *length = (size_t)(p - iob->cur);
1514    assert(*length <= (size_t)(iob->eod - iob->cur));
1515    assert(p <= iob->eod);
1516
1517    return CHUNK_STATUS_BODY_COMPLETE;
1518
1519 }
1520
1521
1522 /*********************************************************************
1523  *
1524  * Function    : receive_chunked_client_request_body
1525  *
1526  * Description : Read the chunk-encoded client request body.
1527  *               Failures are dealt with.
1528  *
1529  * Parameters  :
1530  *          1  :  csp = Current client state (buffers, headers, etc...)
1531  *
1532  * Returns     :  JB_ERR_OK or JB_ERR_PARSE
1533  *
1534  *********************************************************************/
1535 static jb_err receive_chunked_client_request_body(struct client_state *csp)
1536 {
1537    size_t body_length;
1538    enum chunk_status status;
1539
1540    while (CHUNK_STATUS_MISSING_DATA ==
1541       (status = chunked_body_is_complete(csp->client_iob, &body_length)))
1542    {
1543       char buf[BUFFER_SIZE];
1544       int len;
1545
1546       if (!data_is_available(csp->cfd, csp->config->socket_timeout))
1547       {
1548          log_error(LOG_LEVEL_ERROR,
1549             "Timeout while waiting for the client body.");
1550          break;
1551       }
1552       len = read_socket(csp->cfd, buf, sizeof(buf) - 1);
1553       if (len <= 0)
1554       {
1555          log_error(LOG_LEVEL_ERROR, "Read the client body failed: %E");
1556          break;
1557       }
1558       if (add_to_iob(csp->client_iob, csp->config->buffer_limit, buf, len))
1559       {
1560          break;
1561       }
1562    }
1563    if (status != CHUNK_STATUS_BODY_COMPLETE)
1564    {
1565       write_socket_delayed(csp->cfd, CLIENT_BODY_PARSE_ERROR_RESPONSE,
1566          strlen(CLIENT_BODY_PARSE_ERROR_RESPONSE), get_write_delay(csp));
1567       log_error(LOG_LEVEL_CLF,
1568          "%s - - [%T] \"Failed reading chunked client body\" 400 0", csp->ip_addr_str);
1569       return JB_ERR_PARSE;
1570    }
1571    log_error(LOG_LEVEL_CONNECT,
1572       "Chunked client body completely read. Length: %lu", body_length);
1573    csp->expected_client_content_length = body_length;
1574
1575    return JB_ERR_OK;
1576
1577 }
1578
1579
1580 #ifdef FUZZ
1581 /*********************************************************************
1582  *
1583  * Function    :  fuzz_chunked_transfer_encoding
1584  *
1585  * Description :  Treat the fuzzed input as chunked transfer encoding
1586  *                to check and dechunk.
1587  *
1588  * Parameters  :
1589  *          1  :  csp      = Used to store the data.
1590  *          2  :  fuzz_input_file = File to read the input from.
1591  *
1592  * Returns     : Result of dechunking
1593  *
1594  *********************************************************************/
1595 extern int fuzz_chunked_transfer_encoding(struct client_state *csp, char *fuzz_input_file)
1596 {
1597    size_t length;
1598    size_t size = (size_t)(csp->iob->eod - csp->iob->cur);
1599    enum chunk_status status;
1600
1601    status = chunked_body_is_complete(csp->iob, &length);
1602    if (CHUNK_STATUS_BODY_COMPLETE != status)
1603    {
1604       log_error(LOG_LEVEL_INFO, "Chunked body is incomplete or invalid");
1605    }
1606
1607    return (JB_ERR_OK == remove_chunked_transfer_coding(csp->iob->cur, &size));
1608
1609 }
1610
1611
1612 /*********************************************************************
1613  *
1614  * Function    : fuzz_client_request
1615  *
1616  * Description : Try to get a client request from the fuzzed input.
1617  *
1618  * Parameters  :
1619  *          1  :  csp = Current client state (buffers, headers, etc...)
1620  *          2  :  fuzz_input_file = File to read the input from.
1621  *
1622  * Returns     :  Result of fuzzing.
1623  *
1624  *********************************************************************/
1625 extern int fuzz_client_request(struct client_state *csp, char *fuzz_input_file)
1626 {
1627    jb_err err;
1628
1629    csp->cfd = 0;
1630    csp->ip_addr_str = "fuzzer";
1631
1632    if (strcmp(fuzz_input_file, "-") != 0)
1633    {
1634       log_error(LOG_LEVEL_FATAL,
1635          "Fuzzed client requests can currently only be read from stdin (-).");
1636    }
1637    err = receive_client_request(csp);
1638    if (err != JB_ERR_OK)
1639    {
1640       return 1;
1641    }
1642    err = parse_client_request(csp);
1643    if (err != JB_ERR_OK)
1644    {
1645       return 1;
1646    }
1647
1648    return 0;
1649
1650 }
1651 #endif  /* def FUZZ */
1652
1653
1654 #ifdef FEATURE_FORCE_LOAD
1655 /*********************************************************************
1656  *
1657  * Function    :  force_required
1658  *
1659  * Description : Checks a request line to see if it contains
1660  *               the FORCE_PREFIX. If it does, it is removed
1661  *               unless enforcing requests has beend disabled.
1662  *
1663  * Parameters  :
1664  *          1  :  request_line = HTTP request line
1665  *
1666  * Returns     :  TRUE if force is required, FALSE otherwise.
1667  *
1668  *********************************************************************/
1669 static int force_required(const struct client_state *csp, char *request_line)
1670 {
1671    char *p;
1672
1673    p = strstr(request_line, "http://");
1674    if (p != NULL)
1675    {
1676       /* Skip protocol */
1677       p += strlen("http://");
1678    }
1679    else
1680    {
1681       /* Intercepted request usually don't specify the protocol. */
1682       p = request_line;
1683    }
1684
1685    /* Go to the beginning of the path */
1686    p = strstr(p, "/");
1687    if (p == NULL)
1688    {
1689       /*
1690        * If the path is missing the request line is invalid and we
1691        * are done here. The client-visible rejection happens later on.
1692        */
1693       return 0;
1694    }
1695
1696    if (0 == strncmpic(p, FORCE_PREFIX, strlen(FORCE_PREFIX) - 1))
1697    {
1698       if (!(csp->config->feature_flags & RUNTIME_FEATURE_ENFORCE_BLOCKS))
1699       {
1700          /* XXX: Should clean more carefully */
1701          strclean(request_line, FORCE_PREFIX);
1702          log_error(LOG_LEVEL_FORCE,
1703             "Enforcing request: \"%s\".", request_line);
1704
1705          return 1;
1706       }
1707       log_error(LOG_LEVEL_FORCE,
1708          "Ignored force prefix in request: \"%s\".", request_line);
1709    }
1710
1711    return 0;
1712
1713 }
1714 #endif /* def FEATURE_FORCE_LOAD */
1715
1716
1717 /*********************************************************************
1718  *
1719  * Function    :  receive_client_request
1720  *
1721  * Description : Read the client's request (more precisely the
1722  *               client headers) and answer it if necessary.
1723  *
1724  * Parameters  :
1725  *          1  :  csp = Current client state (buffers, headers, etc...)
1726  *
1727  * Returns     :  JB_ERR_OK, JB_ERR_PARSE or JB_ERR_MEMORY
1728  *
1729  *********************************************************************/
1730 static jb_err receive_client_request(struct client_state *csp)
1731 {
1732    char buf[BUFFER_SIZE];
1733    char *p;
1734    char *req = NULL;
1735    struct http_request *http;
1736    int len;
1737    jb_err err;
1738
1739    /* Temporary copy of the client's headers before they get enlisted in csp->headers */
1740    struct list header_list;
1741    struct list *headers = &header_list;
1742
1743    /* We don't care if the arriving data is a valid HTTP request or not. */
1744    csp->requests_received_total++;
1745
1746    http = csp->http;
1747
1748    memset(buf, 0, sizeof(buf));
1749
1750    req = get_request_line(csp);
1751    if (req == NULL)
1752    {
1753       mark_server_socket_tainted(csp);
1754       return JB_ERR_PARSE;
1755    }
1756    assert(*req != '\0');
1757
1758    if (client_protocol_is_unsupported(csp, req))
1759    {
1760       return JB_ERR_PARSE;
1761    }
1762
1763 #ifdef FEATURE_FORCE_LOAD
1764    if (force_required(csp, req))
1765    {
1766       csp->flags |= CSP_FLAG_FORCED;
1767    }
1768 #endif /* def FEATURE_FORCE_LOAD */
1769
1770    err = parse_http_request(req, http);
1771    freez(req);
1772    if (JB_ERR_OK != err)
1773    {
1774       write_socket_delayed(csp->cfd, CHEADER, strlen(CHEADER),
1775          get_write_delay(csp));
1776       /* XXX: Use correct size */
1777       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"Invalid request\" 400 0", csp->ip_addr_str);
1778       log_error(LOG_LEVEL_ERROR,
1779          "Couldn't parse request line received from %s: %s",
1780          csp->ip_addr_str, jb_err_to_string(err));
1781
1782       free_http_request(http);
1783       return JB_ERR_PARSE;
1784    }
1785
1786    /* grab the rest of the client's headers */
1787    init_list(headers);
1788    for (;;)
1789    {
1790       p = get_header(csp->client_iob);
1791
1792       if (p == NULL)
1793       {
1794          /* There are no additional headers to read. */
1795          break;
1796       }
1797
1798       if (*p == '\0')
1799       {
1800          /*
1801           * We didn't receive a complete header
1802           * line yet, get the rest of it.
1803           */
1804          if (!data_is_available(csp->cfd, csp->config->socket_timeout))
1805          {
1806             log_error(LOG_LEVEL_ERROR,
1807                "Stopped grabbing the client headers.");
1808             destroy_list(headers);
1809             return JB_ERR_PARSE;
1810          }
1811
1812          len = read_socket(csp->cfd, buf, sizeof(buf) - 1);
1813          if (len <= 0)
1814          {
1815             log_error(LOG_LEVEL_ERROR, "read from client failed: %E");
1816             destroy_list(headers);
1817             return JB_ERR_PARSE;
1818          }
1819
1820          if (add_to_iob(csp->client_iob, csp->config->buffer_limit, buf, len))
1821          {
1822             /*
1823              * If there is no memory left for buffering the
1824              * request, there is nothing we can do but hang up
1825              */
1826             destroy_list(headers);
1827             return JB_ERR_MEMORY;
1828          }
1829       }
1830       else
1831       {
1832          if (!strncmpic(p, "Transfer-Encoding:", 18))
1833          {
1834             /*
1835              * XXX: should be called through sed()
1836              *      but currently can't.
1837              */
1838             client_transfer_encoding(csp, &p);
1839          }
1840          /*
1841           * We were able to read a complete
1842           * header and can finally enlist it.
1843           */
1844          enlist(headers, p);
1845          freez(p);
1846       }
1847    }
1848
1849    if (http->host == NULL)
1850    {
1851       /*
1852        * If we still don't know the request destination,
1853        * the request is invalid or the client uses
1854        * Privoxy without its knowledge.
1855        */
1856       if (JB_ERR_OK != get_request_destination_elsewhere(csp, headers))
1857       {
1858          /*
1859           * Our attempts to get the request destination
1860           * elsewhere failed or Privoxy is configured
1861           * to only accept proxy requests.
1862           *
1863           * An error response has already been send
1864           * and we're done here.
1865           */
1866          return JB_ERR_PARSE;
1867       }
1868    }
1869
1870 #ifdef FEATURE_CLIENT_TAGS
1871    /* XXX: If the headers were enlisted sooner, passing csp would do. */
1872    set_client_address(csp, headers);
1873    get_tag_list_for_client(csp->client_tags, csp->client_address);
1874 #endif
1875
1876    /*
1877     * Determine the actions for this URL
1878     */
1879 #ifdef FEATURE_TOGGLE
1880    if (!(csp->flags & CSP_FLAG_TOGGLED_ON))
1881    {
1882       /* Most compatible set of actions (i.e. none) */
1883       init_current_action(csp->action);
1884    }
1885    else
1886 #endif /* ndef FEATURE_TOGGLE */
1887    {
1888       get_url_actions(csp, http);
1889    }
1890
1891    enlist(csp->headers, http->cmd);
1892
1893    /* Append the previously read headers */
1894    err = list_append_list_unique(csp->headers, headers);
1895    destroy_list(headers);
1896
1897    return err;
1898
1899 }
1900
1901
1902 /*********************************************************************
1903  *
1904  * Function    : parse_client_request
1905  *
1906  * Description : Parses the client's request and decides what to do
1907  *               with it.
1908  *
1909  *               Note that since we're not using select() we could get
1910  *               blocked here if a client connected, then didn't say
1911  *               anything!
1912  *
1913  * Parameters  :
1914  *          1  :  csp = Current client state (buffers, headers, etc...)
1915  *
1916  * Returns     :  JB_ERR_OK or JB_ERR_PARSE
1917  *
1918  *********************************************************************/
1919 static jb_err parse_client_request(struct client_state *csp)
1920 {
1921    struct http_request *http = csp->http;
1922    jb_err err;
1923
1924 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
1925    if ((csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_KEEP_ALIVE)
1926     && (!strcmpic(csp->http->version, "HTTP/1.1"))
1927     && (csp->http->ssl == 0))
1928    {
1929       /* Assume persistence until further notice */
1930       csp->flags |= CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
1931    }
1932 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
1933
1934    if (csp->http->ssl == 0)
1935    {
1936       /*
1937        * This whole block belongs to chat() but currently
1938        * has to be executed before sed().
1939        */
1940       if (csp->flags & CSP_FLAG_CHUNKED_CLIENT_BODY)
1941       {
1942          if (receive_chunked_client_request_body(csp) != JB_ERR_OK)
1943          {
1944             return JB_ERR_PARSE;
1945          }
1946       }
1947       else
1948       {
1949          csp->expected_client_content_length = get_expected_content_length(csp->headers);
1950       }
1951       verify_request_length(csp);
1952    }
1953 #ifndef FEATURE_HTTPS_INSPECTION
1954    else
1955    {
1956       csp->flags |= CSP_FLAG_SERVER_SOCKET_TAINTED;
1957    }
1958 #endif
1959
1960    err = sed(csp, FILTER_CLIENT_HEADERS);
1961    if (JB_ERR_OK != err)
1962    {
1963       log_error(LOG_LEVEL_ERROR, "Failed to parse client request from %s.",
1964          csp->ip_addr_str);
1965       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s\" 400 0",
1966          csp->ip_addr_str, csp->http->cmd);
1967       write_socket_delayed(csp->cfd, CHEADER, strlen(CHEADER), get_write_delay(csp));
1968       return JB_ERR_PARSE;
1969    }
1970    csp->flags |= CSP_FLAG_CLIENT_HEADER_PARSING_DONE;
1971
1972    /* Check request line for rewrites. */
1973    if ((NULL == csp->headers->first->str)
1974       || (strcmp(http->cmd, csp->headers->first->str) &&
1975          (JB_ERR_OK != change_request_destination(csp))))
1976    {
1977       /*
1978        * A header filter broke the request line - bail out.
1979        */
1980       write_socket_delayed(csp->cfd, MESSED_UP_REQUEST_RESPONSE,
1981          strlen(MESSED_UP_REQUEST_RESPONSE), get_write_delay(csp));
1982       /* XXX: Use correct size */
1983       log_error(LOG_LEVEL_CLF,
1984          "%s - - [%T] \"Invalid request generated\" 500 0", csp->ip_addr_str);
1985       log_error(LOG_LEVEL_ERROR,
1986          "Invalid request line after applying header filters.");
1987       free_http_request(http);
1988
1989       return JB_ERR_PARSE;
1990    }
1991
1992    if (client_has_unsupported_expectations(csp))
1993    {
1994       return JB_ERR_PARSE;
1995    }
1996
1997    return JB_ERR_OK;
1998
1999 }
2000
2001
2002 /*********************************************************************
2003  *
2004  * Function    : read_http_request_body
2005  *
2006  * Description : Reads remaining request body from the client.
2007  *
2008  * Parameters  :
2009  *          1  :  csp = Current client state (buffers, headers, etc...)
2010  *
2011  * Returns     :  0 on success, anything else is an error.
2012  *
2013  *********************************************************************/
2014 static int read_http_request_body(struct client_state *csp)
2015 {
2016    size_t to_read = csp->expected_client_content_length;
2017    int len;
2018
2019    assert(to_read != 0);
2020
2021    /* check if all data has been already read */
2022    if (to_read <= (csp->client_iob->eod - csp->client_iob->cur))
2023    {
2024       return 0;
2025    }
2026
2027    for (to_read -= (size_t)(csp->client_iob->eod - csp->client_iob->cur);
2028         to_read > 0 && data_is_available(csp->cfd, csp->config->socket_timeout);
2029         to_read -= (unsigned)len)
2030    {
2031       char buf[BUFFER_SIZE];
2032       size_t max_bytes_to_read = to_read < sizeof(buf) ? to_read : sizeof(buf);
2033
2034       log_error(LOG_LEVEL_CONNECT,
2035          "Waiting for up to %d bytes of request body from the client.",
2036          max_bytes_to_read);
2037       len = read_socket(csp->cfd, buf, (int)max_bytes_to_read);
2038       if (len <= -1)
2039       {
2040          log_error(LOG_LEVEL_CONNECT, "Failed receiving request body from %s: %E", csp->ip_addr_str);
2041          return 1;
2042       }
2043       if (add_to_iob(csp->client_iob, csp->config->buffer_limit, (char *)buf, len))
2044       {
2045          return 1;
2046       }
2047       assert(to_read >= len);
2048    }
2049
2050    if (to_read != 0)
2051    {
2052       log_error(LOG_LEVEL_CONNECT, "Not enough request body has been read: expected %d more bytes",
2053          csp->expected_client_content_length);
2054       return 1;
2055    }
2056    log_error(LOG_LEVEL_CONNECT, "The last %d bytes of the request body have been read",
2057       csp->expected_client_content_length);
2058    return 0;
2059 }
2060
2061
2062 /*********************************************************************
2063  *
2064  * Function    : update_client_headers
2065  *
2066  * Description : Updates the HTTP headers from the client request.
2067  *
2068  * Parameters  :
2069  *          1  :  csp = Current client state (buffers, headers, etc...)
2070  *          2  :  new_content_length = new content length value to set
2071  *
2072  * Returns     :  0 on success, anything else is an error.
2073  *
2074  *********************************************************************/
2075 static int update_client_headers(struct client_state *csp, size_t new_content_length)
2076 {
2077    static const char content_length[] = "Content-Length:";
2078    int updated = 0;
2079    struct list_entry *p;
2080
2081 #ifndef FEATURE_HTTPS_INSPECTION
2082    for (p = csp->headers->first;
2083 #else
2084    for (p = csp->http->client_ssl ? csp->https_headers->first : csp->headers->first;
2085 #endif
2086         !updated  && (p != NULL); p = p->next)
2087    {
2088       /* Header crunch()ed in previous run? -> ignore */
2089       if (p->str == NULL)
2090       {
2091          continue;
2092       }
2093
2094       /* Does the current parser handle this header? */
2095       if (0 == strncmpic(p->str, content_length, sizeof(content_length) - 1))
2096       {
2097          updated = (JB_ERR_OK == header_adjust_content_length((char **)&(p->str), new_content_length));
2098          if (!updated)
2099          {
2100             return 1;
2101          }
2102       }
2103    }
2104
2105    return !updated;
2106 }
2107
2108
2109 /*********************************************************************
2110  *
2111  * Function    : can_filter_request_body
2112  *
2113  * Description : Checks if the current request body can be stored in
2114  *               the client_iob without hitting buffer limit.
2115  *
2116  * Parameters  :
2117  *          1  : csp = Current client state (buffers, headers, etc...)
2118  *
2119  * Returns     : TRUE if the current request size do not exceed buffer limit
2120  *               FALSE otherwise.
2121  *
2122  *********************************************************************/
2123 static int can_filter_request_body(const struct client_state *csp)
2124 {
2125    if (!can_add_to_iob(csp->client_iob, csp->config->buffer_limit,
2126                        csp->expected_client_content_length))
2127    {
2128       log_error(LOG_LEVEL_INFO,
2129          "Not filtering request body from %s: buffer limit %d will be exceeded "
2130          "(content length %d)", csp->ip_addr_str, csp->config->buffer_limit,
2131          csp->expected_client_content_length);
2132       return FALSE;
2133    }
2134    return TRUE;
2135 }
2136
2137
2138 /*********************************************************************
2139  *
2140  * Function    : send_http_request
2141  *
2142  * Description : Sends the HTTP headers from the client request
2143  *               and all the body data that has already been received.
2144  *
2145  * Parameters  :
2146  *          1  :  csp = Current client state (buffers, headers, etc...)
2147  *
2148  * Returns     :  0 on success, anything else is an error.
2149  *
2150  *********************************************************************/
2151 static int send_http_request(struct client_state *csp)
2152 {
2153    char *hdr;
2154    int write_failure;
2155    const char *to_send;
2156    size_t to_send_len;
2157    int filter_client_body = csp->expected_client_content_length != 0 &&
2158       client_body_filters_enabled(csp->action) && can_filter_request_body(csp);
2159
2160    if (filter_client_body)
2161    {
2162       if (read_http_request_body(csp))
2163       {
2164          return 1;
2165       }
2166       to_send_len = csp->expected_client_content_length;
2167       to_send = execute_client_body_filters(csp, &to_send_len);
2168       if (to_send == NULL)
2169       {
2170          /* just flush client_iob */
2171          filter_client_body = FALSE;
2172       }
2173       else if (to_send_len != csp->expected_client_content_length &&
2174          update_client_headers(csp, to_send_len))
2175       {
2176          log_error(LOG_LEVEL_HEADER, "Error updating client headers");
2177          return 1;
2178       }
2179       csp->expected_client_content_length = 0;
2180    }
2181
2182    hdr = list_to_text(csp->headers);
2183    if (hdr == NULL)
2184    {
2185       /* FIXME Should handle error properly */
2186       log_error(LOG_LEVEL_FATAL, "Out of memory parsing client header");
2187    }
2188    list_remove_all(csp->headers);
2189
2190    /*
2191     * Write the client's (modified) header to the server
2192     * (along with anything else that may be in the buffer)
2193     */
2194    write_failure = 0 != write_socket(csp->server_connection.sfd, hdr, strlen(hdr));
2195    freez(hdr);
2196
2197    if (write_failure)
2198    {
2199       log_error(LOG_LEVEL_CONNECT, "Failed sending request headers to: %s: %E",
2200          csp->http->hostport);
2201       return 1;
2202    }
2203
2204    if (filter_client_body)
2205    {
2206       write_failure = 0 != write_socket(csp->server_connection.sfd, to_send, to_send_len);
2207       freez(to_send);
2208       if (write_failure)
2209       {
2210          log_error(LOG_LEVEL_CONNECT, "Failed sending filtered request body to: %s: %E",
2211             csp->http->hostport);
2212          return 1;
2213       }
2214    }
2215
2216    if (((csp->flags & CSP_FLAG_PIPELINED_REQUEST_WAITING) == 0)
2217       && (flush_iob(csp->server_connection.sfd, csp->client_iob, 0) < 0))
2218    {
2219       log_error(LOG_LEVEL_CONNECT, "Failed sending request body to: %s: %E",
2220          csp->http->hostport);
2221       return 1;
2222    }
2223    return 0;
2224 }
2225
2226
2227 #ifdef FEATURE_HTTPS_INSPECTION
2228 /*********************************************************************
2229  *
2230  * Function    : read_https_request_body
2231  *
2232  * Description : Reads remaining request body from the client.
2233  *
2234  * Parameters  :
2235  *          1  :  csp = Current client state (buffers, headers, etc...)
2236  *
2237  * Returns     :  0 on success, anything else is an error.
2238  *
2239  *********************************************************************/
2240 static int read_https_request_body(struct client_state *csp)
2241 {
2242    size_t to_read = csp->expected_client_content_length;
2243    int len;
2244
2245    assert(to_read != 0);
2246
2247    /* check if all data has been already read */
2248    if (to_read <= (csp->client_iob->eod - csp->client_iob->cur))
2249    {
2250       return 0;
2251    }
2252
2253    for (to_read -= (size_t)(csp->client_iob->eod - csp->client_iob->cur);
2254         to_read > 0 && (is_ssl_pending(&(csp->ssl_client_attr)) ||
2255           data_is_available(csp->cfd, csp->config->socket_timeout));
2256         to_read -= (unsigned)len)
2257    {
2258       unsigned char buf[BUFFER_SIZE];
2259       size_t max_bytes_to_read = to_read < sizeof(buf) ? to_read : sizeof(buf);
2260
2261       log_error(LOG_LEVEL_CONNECT,
2262          "Waiting for up to %d bytes of request body from the client.",
2263          max_bytes_to_read);
2264       len = ssl_recv_data(&(csp->ssl_client_attr), buf,
2265          (unsigned)max_bytes_to_read);
2266       if (len <= 0)
2267       {
2268          log_error(LOG_LEVEL_CONNECT, "Failed receiving request body from %s", csp->ip_addr_str);
2269          return 1;
2270       }
2271       if (add_to_iob(csp->client_iob, csp->config->buffer_limit, (char *)buf, len))
2272       {
2273          return 1;
2274       }
2275       assert(to_read >= len);
2276    }
2277
2278    if (to_read != 0)
2279    {
2280       log_error(LOG_LEVEL_CONNECT, "Not enough request body has been read: expected %d more bytes", to_read);
2281       return 1;
2282    }
2283
2284    log_error(LOG_LEVEL_CONNECT, "The last %d bytes of the request body have been read",
2285       csp->expected_client_content_length);
2286    return 0;
2287 }
2288
2289
2290 /*********************************************************************
2291  *
2292  * Function    : receive_and_send_encrypted_post_data
2293  *
2294  * Description : Reads remaining request body from the client and sends
2295  *               it to the server.
2296  *
2297  * Parameters  :
2298  *          1  :  csp = Current client state (buffers, headers, etc...)
2299  *
2300  * Returns     :  0 on success, anything else is an error.
2301  *
2302  *********************************************************************/
2303 static int receive_and_send_encrypted_post_data(struct client_state *csp)
2304 {
2305    int content_length_known = csp->expected_client_content_length != 0;
2306
2307    while (is_ssl_pending(&(csp->ssl_client_attr))
2308       || (content_length_known && csp->expected_client_content_length != 0))
2309    {
2310       unsigned char buf[BUFFER_SIZE];
2311       int len;
2312       int max_bytes_to_read = sizeof(buf);
2313
2314       if (content_length_known && csp->expected_client_content_length < sizeof(buf))
2315       {
2316          max_bytes_to_read = (int)csp->expected_client_content_length;
2317       }
2318       log_error(LOG_LEVEL_CONNECT,
2319          "Waiting for up to %d bytes of request body from the client.",
2320          max_bytes_to_read);
2321       len = ssl_recv_data(&(csp->ssl_client_attr), buf,
2322          (unsigned)max_bytes_to_read);
2323       if (len == -1)
2324       {
2325          return 1;
2326       }
2327       if (len == 0)
2328       {
2329          /* XXX: Does this actually happen? */
2330          break;
2331       }
2332       log_error(LOG_LEVEL_CONNECT, "Forwarding %d bytes of encrypted request body",
2333          len);
2334       len = ssl_send_data(&(csp->ssl_server_attr), buf, (size_t)len);
2335       if (len == -1)
2336       {
2337          return 1;
2338       }
2339       if (csp->expected_client_content_length != 0)
2340       {
2341          if (csp->expected_client_content_length >= len)
2342          {
2343             csp->expected_client_content_length -= (unsigned)len;
2344          }
2345          if (csp->expected_client_content_length == 0)
2346          {
2347             log_error(LOG_LEVEL_CONNECT, "Forwarded the last %d bytes", len);
2348             break;
2349          }
2350       }
2351    }
2352
2353    log_error(LOG_LEVEL_CONNECT, "Done forwarding encrypted request body");
2354
2355    return 0;
2356
2357 }
2358
2359
2360 /*********************************************************************
2361  *
2362  * Function    : send_https_request
2363  *
2364  * Description : Sends the HTTP headers from the client request
2365  *               and all the body data that has already been received.
2366  *
2367  * Parameters  :
2368  *          1  :  csp = Current client state (buffers, headers, etc...)
2369  *
2370  * Returns     :  0 on success, anything else is an error.
2371  *
2372  *********************************************************************/
2373 static int send_https_request(struct client_state *csp)
2374 {
2375    char *hdr;
2376    int ret;
2377    long flushed = 0;
2378    const char *to_send;
2379    size_t to_send_len;
2380    int filter_client_body = csp->expected_client_content_length != 0 &&
2381       client_body_filters_enabled(csp->action) && can_filter_request_body(csp);
2382
2383    if (filter_client_body)
2384    {
2385       if (read_https_request_body(csp))
2386       {
2387          return 1;
2388       }
2389       to_send_len = csp->expected_client_content_length;
2390       to_send = execute_client_body_filters(csp, &to_send_len);
2391       if (to_send == NULL)
2392       {
2393          /* just flush client_iob */
2394          filter_client_body = FALSE;
2395       }
2396       else if (to_send_len != csp->expected_client_content_length &&
2397          update_client_headers(csp, to_send_len))
2398       {
2399          log_error(LOG_LEVEL_HEADER, "Error updating client headers");
2400          return 1;
2401       }
2402       csp->expected_client_content_length = 0;
2403    }
2404
2405    hdr = list_to_text(csp->https_headers);
2406    if (hdr == NULL)
2407    {
2408       /* FIXME Should handle error properly */
2409       log_error(LOG_LEVEL_FATAL, "Out of memory parsing client header");
2410    }
2411    list_remove_all(csp->https_headers);
2412
2413    /*
2414     * Write the client's (modified) header to the server
2415     * (along with anything else that may be in the buffer)
2416     */
2417    ret = ssl_send_data(&(csp->ssl_server_attr),
2418       (const unsigned char *)hdr, strlen(hdr));
2419    freez(hdr);
2420
2421    if (ret < 0)
2422    {
2423       log_error(LOG_LEVEL_CONNECT,
2424          "Failed sending encrypted request headers to: %s: %E",
2425          csp->http->hostport);
2426       mark_server_socket_tainted(csp);
2427       return 1;
2428    }
2429
2430    if (filter_client_body)
2431    {
2432       ret = ssl_send_data(&(csp->ssl_server_attr), (const unsigned char *)to_send, to_send_len);
2433       freez(to_send);
2434       if (ret < 0)
2435       {
2436          log_error(LOG_LEVEL_CONNECT, "Failed sending filtered request body to: %s",
2437             csp->http->hostport);
2438          return 1;
2439       }
2440    }
2441
2442    if (((csp->flags & CSP_FLAG_PIPELINED_REQUEST_WAITING) == 0)
2443       && ((flushed = ssl_flush_socket(&(csp->ssl_server_attr),
2444             csp->client_iob)) < 0))
2445    {
2446       log_error(LOG_LEVEL_CONNECT, "Failed sending request body to: %s: %E",
2447          csp->http->hostport);
2448       return 1;
2449    }
2450    if (flushed != 0 || csp->expected_client_content_length != 0)
2451    {
2452       if (csp->expected_client_content_length != 0)
2453       {
2454          if (csp->expected_client_content_length < flushed)
2455          {
2456             log_error(LOG_LEVEL_ERROR,
2457                "Flushed %ld bytes of request body while only expecting %llu",
2458                flushed, csp->expected_client_content_length);
2459             csp->expected_client_content_length = 0;
2460          }
2461          else
2462          {
2463             log_error(LOG_LEVEL_CONNECT,
2464                "Flushed %ld bytes of request body while expecting %llu",
2465                flushed, csp->expected_client_content_length);
2466             csp->expected_client_content_length -= (unsigned)flushed;
2467             if (receive_and_send_encrypted_post_data(csp))
2468             {
2469                return 1;
2470             }
2471          }
2472       }
2473       else
2474       {
2475          log_error(LOG_LEVEL_CONNECT,
2476             "Flushed %ld bytes of request body", flushed);
2477       }
2478    }
2479
2480    log_error(LOG_LEVEL_CONNECT, "Encrypted request sent");
2481
2482    return 0;
2483
2484 }
2485
2486
2487 /*********************************************************************
2488  *
2489  * Function    :  receive_encrypted_request
2490  *
2491  * Description :  Receives an encrypted request.
2492  *
2493  * Parameters  :
2494  *          1  :  csp = Current client state (buffers, headers, etc...)
2495  *
2496  * Returns     :  JB_ERR_OK on success,
2497  *                JB_ERR_PARSE or JB_ERR_MEMORY otherwise
2498  *
2499  *********************************************************************/
2500 static jb_err receive_encrypted_request(struct client_state *csp)
2501 {
2502    char buf[BUFFER_SIZE];
2503    int len;
2504    char *p;
2505
2506    do
2507    {
2508       log_error(LOG_LEVEL_HEADER, "Reading encrypted headers");
2509       if (!is_ssl_pending(&(csp->ssl_client_attr)) &&
2510           !data_is_available(csp->cfd, csp->config->socket_timeout))
2511       {
2512          log_error(LOG_LEVEL_CONNECT,
2513             "Socket %d timed out while waiting for client headers", csp->cfd);
2514          return JB_ERR_PARSE;
2515       }
2516       len = ssl_recv_data(&(csp->ssl_client_attr),
2517          (unsigned char *)buf, sizeof(buf));
2518       if (len == 0)
2519       {
2520          log_error(LOG_LEVEL_CONNECT,
2521             "Socket %d closed while waiting for client headers", csp->cfd);
2522          return JB_ERR_PARSE;
2523       }
2524       if (len == -1)
2525       {
2526          return JB_ERR_PARSE;
2527       }
2528       if (add_to_iob(csp->client_iob, csp->config->buffer_limit, buf, len))
2529       {
2530          return JB_ERR_MEMORY;
2531       }
2532       p = strstr(csp->client_iob->cur, "\r\n\r\n");
2533    } while (p == NULL);
2534
2535    log_error(LOG_LEVEL_HEADER, "Encrypted headers received completely");
2536
2537    return JB_ERR_OK;
2538 }
2539
2540
2541 /*********************************************************************
2542  *
2543  * Function    :  change_encrypted_request_destination
2544  *
2545  * Description :  Parse a (rewritten) request line from an encrypted
2546  *                request and regenerate the http request data.
2547  *
2548  * Parameters  :
2549  *          1  :  csp = Current client state (buffers, headers, etc...)
2550  *
2551  * Returns     :  Forwards the parse_http_request() return code.
2552  *                Terminates in case of memory problems.
2553  *
2554  *********************************************************************/
2555 static jb_err change_encrypted_request_destination(struct client_state *csp)
2556 {
2557    jb_err err;
2558    char *original_host = csp->http->host;
2559
2560    log_error(LOG_LEVEL_REDIRECTS, "Rewrite detected: %s",
2561       csp->https_headers->first->str);
2562    csp->http->host = NULL;
2563    free_http_request(csp->http);
2564    err = parse_http_request(csp->https_headers->first->str, csp->http);
2565    if (JB_ERR_OK != err)
2566    {
2567       log_error(LOG_LEVEL_ERROR, "Couldn't parse rewritten request: %s.",
2568          jb_err_to_string(err));
2569       return err;
2570    }
2571
2572    if (csp->http->host == NULL)
2573    {
2574       /*
2575        * The rewritten request line did not specify a host
2576        * which means we can use the original host specified
2577        * by the client.
2578        */
2579       csp->http->host = original_host;
2580       log_error(LOG_LEVEL_REDIRECTS, "Keeping the original host: %s",
2581          csp->http->host);
2582       /*
2583        * If the rewritten request line didn't contain a host
2584        * it also didn't contain a port so we can reuse the host
2585        * and set the port to 443.
2586        */
2587       freez(csp->http->hostport);
2588       csp->http->hostport = strdup_or_die(csp->http->host);
2589       csp->http->port = 443;
2590       /*
2591        * While the request line didn't mention it,
2592        * we're https-inspecting and want to speak TLS
2593        * with the server.
2594        */
2595       csp->http->server_ssl = 1;
2596       csp->http->ssl = 1;
2597    }
2598    else
2599    {
2600       /* The rewrite filter added a host so we can ditch the original */
2601       freez(original_host);
2602       csp->http->server_ssl = csp->http->ssl;
2603    }
2604
2605    csp->http->client_ssl = 1;
2606
2607    freez(csp->https_headers->first->str);
2608    build_request_line(csp, NULL, &csp->https_headers->first->str);
2609
2610    if (!server_use_ssl(csp))
2611    {
2612       log_error(LOG_LEVEL_REDIRECTS,
2613          "Rewritten request line results in downgrade to http");
2614       /*
2615        * Replace the unencryptd headers received with the
2616        * CONNECT request with the ones we received securely.
2617        */
2618       destroy_list(csp->headers);
2619       csp->headers->first = csp->https_headers->first;
2620       csp->headers->last  = csp->https_headers->last;
2621       csp->https_headers->first = NULL;
2622       csp->https_headers->last = NULL;
2623    }
2624
2625    return JB_ERR_OK;
2626
2627 }
2628
2629
2630 /*********************************************************************
2631  *
2632  * Function    :  process_encrypted_request
2633  *
2634  * Description :  Receives and parses an encrypted request.
2635  *
2636  * Parameters  :
2637  *          1  :  csp = Current client state (buffers, headers, etc...)
2638  *
2639  * Returns     :  JB_ERR_OK on success,
2640  *                JB_ERR_PARSE or JB_ERR_MEMORY otherwise
2641  *
2642  *********************************************************************/
2643 static jb_err process_encrypted_request(struct client_state *csp)
2644 {
2645    char *p;
2646    char *request_line;
2647    jb_err err;
2648    /* Temporary copy of the client's headers before they get enlisted in csp->https_headers */
2649    struct list header_list;
2650    struct list *headers = &header_list;
2651
2652    assert(csp->ssl_with_client_is_opened);
2653
2654 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
2655    if (csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_KEEP_ALIVE)
2656    {
2657       csp->flags |= CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
2658    }
2659 #endif
2660    err = receive_encrypted_request(csp);
2661    if (err != JB_ERR_OK)
2662    {
2663       if (csp->client_iob->cur == NULL ||
2664           csp->client_iob->cur == csp->client_iob->eod)
2665       {
2666          /*
2667           * We did not receive any data, most likely because the
2668           * client is done. Don't log this as a parse failure.
2669           */
2670          return JB_ERR_PARSE;
2671       }
2672       /* XXX: Also used for JB_ERR_MEMORY */
2673       log_error(LOG_LEVEL_ERROR, "Failed to receive encrypted request: %s",
2674          jb_err_to_string(err));
2675       ssl_send_data_delayed(&(csp->ssl_client_attr),
2676          (const unsigned char *)CHEADER, strlen(CHEADER), get_write_delay(csp));
2677       return err;
2678    }
2679
2680    /* We don't need get_request_line() because the whole HTTP head is buffered. */
2681    request_line = get_header(csp->client_iob);
2682    if (request_line == NULL)
2683    {
2684       log_error(LOG_LEVEL_ERROR, "Failed to get the encrypted request line");
2685       ssl_send_data_delayed(&(csp->ssl_client_attr),
2686          (const unsigned char *)CHEADER, strlen(CHEADER), get_write_delay(csp));
2687       return JB_ERR_PARSE;
2688    }
2689    assert(*request_line != '\0');
2690
2691    if (client_protocol_is_unsupported(csp, request_line))
2692    {
2693       /*
2694        * If the protocol is unsupported we're done here.
2695        * client_protocol_is_unsupported() took care of sending
2696        * the error response and logging the error message.
2697        */
2698       return JB_ERR_PARSE;
2699    }
2700
2701 #ifdef FEATURE_FORCE_LOAD
2702    if (force_required(csp, request_line))
2703    {
2704       csp->flags |= CSP_FLAG_FORCED;
2705    }
2706 #endif /* def FEATURE_FORCE_LOAD */
2707
2708    free_http_request(csp->http);
2709
2710    err = parse_http_request(request_line, csp->http);
2711    /* XXX: Restore ssl setting. This is ugly */
2712    csp->http->client_ssl = 1;
2713    csp->http->server_ssl = 1;
2714
2715    freez(request_line);
2716    if (JB_ERR_OK != err)
2717    {
2718       ssl_send_data_delayed(&(csp->ssl_client_attr),
2719          (const unsigned char *)CHEADER, strlen(CHEADER), get_write_delay(csp));
2720       /* XXX: Use correct size */
2721       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"Invalid request\" 400 0", csp->ip_addr_str);
2722       log_error(LOG_LEVEL_ERROR,
2723          "Couldn't parse request line received from %s: %s",
2724          csp->ip_addr_str, jb_err_to_string(err));
2725
2726       free_http_request(csp->http);
2727       return JB_ERR_PARSE;
2728    }
2729
2730    /* Parse the rest of the client's headers. */
2731    init_list(headers);
2732    for (;;)
2733    {
2734       p = get_header(csp->client_iob);
2735
2736       if (p == NULL)
2737       {
2738          /* There are no additional headers to read. */
2739          break;
2740       }
2741       enlist(headers, p);
2742       freez(p);
2743    }
2744
2745    if (JB_ERR_OK != get_destination_from_https_headers(headers, csp->http))
2746    {
2747       /*
2748        * Our attempts to get the request destination
2749        * elsewhere failed.
2750        */
2751       log_error(LOG_LEVEL_ERROR,
2752          "Failed to get the encrypted request destination");
2753       ssl_send_data_delayed(&(csp->ssl_client_attr),
2754          (const unsigned char *)CHEADER, strlen(CHEADER), get_write_delay(csp));
2755       return JB_ERR_PARSE;
2756    }
2757
2758    /* Split the domain we just got for pattern matching */
2759    init_domain_components(csp->http);
2760
2761 #ifdef FEATURE_CLIENT_TAGS
2762    /* XXX: If the headers were enlisted sooner, passing csp would do. */
2763    if (csp->client_address == NULL)
2764    {
2765       set_client_address(csp, headers);
2766       get_tag_list_for_client(csp->client_tags, csp->client_address);
2767    }
2768 #endif
2769
2770 #ifdef FEATURE_TOGGLE
2771    if ((csp->flags & CSP_FLAG_TOGGLED_ON) != 0)
2772 #endif
2773    {
2774       /*
2775        * Determine the actions for this request after
2776        * clearing the ones from the previous one.
2777        */
2778       free_current_action(csp->action);
2779       get_url_actions(csp, csp->http);
2780    }
2781
2782    enlist(csp->https_headers, csp->http->cmd);
2783
2784    /* Append the previously read headers */
2785    err = list_append_list_unique(csp->https_headers, headers);
2786    destroy_list(headers);
2787    if (JB_ERR_OK != err)
2788    {
2789       /* XXX: Send error message */
2790       return err;
2791    }
2792
2793    /* XXX: Work around crash */
2794    csp->error_message = NULL;
2795
2796    /* XXX: Why do this here? */
2797    csp->http->ssl = 1;
2798
2799    err = sed_https(csp);
2800    if (JB_ERR_OK != err)
2801    {
2802       ssl_send_data_delayed(&(csp->ssl_client_attr),
2803          (const unsigned char *)CHEADER, strlen(CHEADER), get_write_delay(csp));
2804       log_error(LOG_LEVEL_ERROR, "Failed to parse client request from %s.",
2805          csp->ip_addr_str);
2806       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s\" 400 0",
2807          csp->ip_addr_str, csp->http->cmd);
2808       return JB_ERR_PARSE;
2809    }
2810
2811    if ((NULL == csp->https_headers->first->str)
2812       || (strcmp(csp->http->cmd, csp->https_headers->first->str) &&
2813          (JB_ERR_OK != change_encrypted_request_destination(csp))))
2814    {
2815       log_error(LOG_LEVEL_ERROR,
2816          "Failed to get the request destination in the rewritten headers");
2817       ssl_send_data_delayed(&(csp->ssl_client_attr),
2818          (const unsigned char *)MESSED_UP_REQUEST_RESPONSE,
2819          strlen(MESSED_UP_REQUEST_RESPONSE), get_write_delay(csp));
2820       return JB_ERR_PARSE;
2821    }
2822
2823    log_error(LOG_LEVEL_HEADER, "Encrypted request processed");
2824    log_applied_actions(csp->action);
2825    log_error(LOG_LEVEL_REQUEST, "https://%s%s", csp->http->hostport,
2826       csp->http->path);
2827
2828    return err;
2829
2830 }
2831
2832 /*********************************************************************
2833  *
2834  * Function    :  cgi_page_requested
2835  *
2836  * Description :  Checks if a request is for an internal CGI page.
2837  *
2838  * Parameters  :
2839  *          1  :  host = The host requested by the client.
2840  *
2841  * Returns     :  1 if a CGI page has been requested, 0 otherwise
2842  *
2843  *********************************************************************/
2844 static int cgi_page_requested(const char *host)
2845 {
2846    if ((0 == strcmpic(host, CGI_SITE_1_HOST))
2847     || (0 == strcmpic(host, CGI_SITE_1_HOST "."))
2848     || (0 == strcmpic(host, CGI_SITE_2_HOST))
2849     || (0 == strcmpic(host, CGI_SITE_2_HOST ".")))
2850    {
2851       return 1;
2852    }
2853
2854    return 0;
2855
2856 }
2857
2858
2859 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
2860 /*********************************************************************
2861  *
2862  * Function    :  continue_https_chat
2863  *
2864  * Description :  Behaves similar to chat() but only deals with
2865  *                https-inspected requests that arrive on an already
2866  *                established connection. The first request is always
2867  *                served by chat() which is a lot more complex as it
2868  *                has to deal with forwarding settings and connection
2869  *                failures etc.
2870  *
2871  *                If a connection to the server has already been
2872  *                opened it is reused unless the request is blocked
2873  *                or the forwarder changed.
2874  *
2875  *                If a connection to the server has not yet been
2876  *                opened (because the previous request was crunched),
2877  *                or the forwarder changed, the connection is dropped
2878  *                so that the client retries on a fresh one.
2879  *
2880  * Parameters  :
2881  *          1  :  csp = Current client state (buffers, headers, etc...)
2882  *
2883  * Returns     :  Nothing.
2884  *
2885  *********************************************************************/
2886 static void continue_https_chat(struct client_state *csp)
2887 {
2888    const struct forward_spec *fwd;
2889
2890    if (JB_ERR_OK != process_encrypted_request(csp))
2891    {
2892       return;
2893    }
2894
2895    csp->requests_received_total++;
2896
2897    /*
2898     * We have an encrypted request. Check if one of the crunchers wants it.
2899     */
2900    if (crunch_response_triggered(csp, crunchers_all))
2901    {
2902       /*
2903        * Yes. The client got the crunch response and we're done here.
2904        */
2905       return;
2906    }
2907    if (csp->ssl_with_server_is_opened == 0)
2908    {
2909       log_error(LOG_LEVEL_CONNECT,
2910          "Dropping the client connection on socket %d. "
2911          "The server connection has not been established yet.",
2912          csp->cfd);
2913       csp->flags &= ~CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
2914       return;
2915    }
2916    assert(csp->server_connection.sfd != JB_INVALID_SOCKET);
2917
2918    fwd = forward_url(csp, csp->http);
2919    if (!connection_destination_matches(&csp->server_connection, csp->http, fwd))
2920    {
2921       log_error(LOG_LEVEL_CONNECT,
2922          "Dropping the client connection on socket %d with "
2923          "server socket %d connected to %s. The forwarder has changed.",
2924          csp->cfd, csp->server_connection.sfd, csp->server_connection.host);
2925       csp->flags &= ~CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
2926       return;
2927    }
2928
2929    log_error(LOG_LEVEL_CONNECT,
2930       "Reusing server socket %d connected to %s. Requests already sent: %u.",
2931       csp->server_connection.sfd, csp->server_connection.host,
2932       csp->server_connection.requests_sent_total);
2933
2934    if (send_https_request(csp))
2935    {
2936       /*
2937        * Most likely the server connection timed out. We can't easily
2938        * create a new one so simply drop the client connection without a
2939        * error response to let the client retry.
2940        */
2941       log_error(LOG_LEVEL_CONNECT,
2942          "Dropping client connection on socket %d. "
2943          "Forwarding the encrypted client request failed.",
2944          csp->cfd);
2945       return;
2946    }
2947    csp->server_connection.requests_sent_total++;
2948    handle_established_connection(csp);
2949    freez(csp->receive_buffer);
2950 }
2951 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
2952 #endif
2953
2954
2955 /*********************************************************************
2956  *
2957  * Function    :  handle_established_connection
2958  *
2959  * Description :  Shuffle data between client and server once the
2960  *                connection has been established.
2961  *
2962  * Parameters  :
2963  *          1  :  csp = Current client state (buffers, headers, etc...)
2964  *
2965  * Returns     :  Nothing.
2966  *
2967  *********************************************************************/
2968 static void handle_established_connection(struct client_state *csp)
2969 {
2970    char *hdr;
2971    char *p;
2972    int n;
2973 #ifdef HAVE_POLL
2974    struct pollfd poll_fds[2];
2975 #else
2976    fd_set rfds;
2977    jb_socket maxfd;
2978    struct timeval timeout;
2979 #endif
2980    int server_body;
2981    int ms_iis5_hack = 0;
2982    unsigned long long byte_count = 0;
2983    struct http_request *http;
2984    long len = 0; /* for buffer sizes (and negative error codes) */
2985    int buffer_and_filter_content = 0;
2986    unsigned int write_delay;
2987 #ifdef FEATURE_HTTPS_INSPECTION
2988    int ret = 0;
2989    int use_ssl_tunnel = 0;
2990    csp->dont_verify_certificate = 0;
2991
2992    if (csp->http->ssl && !(csp->action->flags & ACTION_HTTPS_INSPECTION))
2993    {
2994       /* Pass encrypted content without filtering. */
2995       use_ssl_tunnel = 1;
2996    }
2997 #endif
2998
2999    /* Skeleton for HTTP response, if we should intercept the request */
3000    struct http_response *rsp;
3001 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3002    int watch_client_socket;
3003 #endif
3004
3005    csp->receive_buffer_size = csp->config->receive_buffer_size;
3006    csp->receive_buffer = zalloc(csp->receive_buffer_size + 1);
3007    if (csp->receive_buffer == NULL)
3008    {
3009       log_error(LOG_LEVEL_ERROR,
3010          "Out of memory. Failed to allocate the receive buffer.");
3011       rsp = cgi_error_memory();
3012       send_crunch_response(csp, rsp);
3013       return;
3014    }
3015
3016    http = csp->http;
3017
3018 #ifndef HAVE_POLL
3019    maxfd = (csp->cfd > csp->server_connection.sfd) ?
3020       csp->cfd : csp->server_connection.sfd;
3021 #endif
3022
3023    /* pass data between the client and server
3024     * until one or the other shuts down the connection.
3025     */
3026
3027    server_body = 0;
3028
3029 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3030    watch_client_socket = 0 == (csp->flags & CSP_FLAG_PIPELINED_REQUEST_WAITING);
3031 #endif
3032    write_delay = get_write_delay(csp);
3033
3034    for (;;)
3035    {
3036 #ifndef HAVE_POLL
3037       FD_ZERO(&rfds);
3038 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3039       if (!watch_client_socket)
3040       {
3041          maxfd = csp->server_connection.sfd;
3042       }
3043       else
3044 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3045       {
3046          FD_SET(csp->cfd, &rfds);
3047       }
3048
3049       FD_SET(csp->server_connection.sfd, &rfds);
3050 #endif /* ndef HAVE_POLL */
3051
3052 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3053       if ((csp->flags & CSP_FLAG_CHUNKED)
3054          && !(csp->flags & CSP_FLAG_CONTENT_LENGTH_SET)
3055          && ((csp->iob->eod - csp->iob->cur) >= 5)
3056          && !memcmp(csp->iob->eod-5, "0\r\n\r\n", 5))
3057       {
3058          /*
3059           * XXX: This check should be obsolete now,
3060           *      but let's wait a while to be sure.
3061           */
3062          log_error(LOG_LEVEL_CONNECT,
3063             "Looks like we got the last chunk together with "
3064             "the server headers but didn't detect it earlier. "
3065             "We better stop reading.");
3066          byte_count = (unsigned long long)(csp->iob->eod - csp->iob->cur);
3067          csp->expected_content_length = byte_count;
3068          csp->flags |= CSP_FLAG_CONTENT_LENGTH_SET;
3069       }
3070       if (server_body && server_response_is_complete(csp, byte_count))
3071       {
3072          if (csp->expected_content_length == byte_count)
3073          {
3074             log_error(LOG_LEVEL_CONNECT,
3075                "Done reading from server. Content length: %llu as expected. "
3076                "Bytes most recently read: %ld.",
3077                byte_count, len);
3078          }
3079          else
3080          {
3081             log_error(LOG_LEVEL_CONNECT,
3082                "Done reading from server. Expected content length: %llu. "
3083                "Actual content length: %llu. Bytes most recently read: %ld.",
3084                csp->expected_content_length, byte_count, len);
3085          }
3086          len = 0;
3087          /*
3088           * XXX: Should not jump around, handle_established_connection()
3089           * is complicated enough already.
3090           */
3091          goto reading_done;
3092       }
3093 #endif  /* FEATURE_CONNECTION_KEEP_ALIVE */
3094
3095 #ifdef HAVE_POLL
3096       poll_fds[0].fd = csp->cfd;
3097 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3098       if (!watch_client_socket)
3099       {
3100          /*
3101           * Ignore incoming data, but still watch out
3102           * for disconnects etc. These flags are always
3103           * implied anyway but explicitly setting them
3104           * doesn't hurt.
3105           */
3106          poll_fds[0].events = POLLERR|POLLHUP;
3107       }
3108       else
3109 #endif
3110       {
3111          poll_fds[0].events = POLLIN;
3112       }
3113       poll_fds[1].fd = csp->server_connection.sfd;
3114       poll_fds[1].events = POLLIN;
3115       n = poll(poll_fds, 2, csp->config->socket_timeout * 1000);
3116 #else
3117       timeout.tv_sec = csp->config->socket_timeout;
3118       timeout.tv_usec = 0;
3119       n = select((int)maxfd + 1, &rfds, NULL, NULL, &timeout);
3120 #endif /* def HAVE_POLL */
3121
3122       /*server or client not responding in timeout */
3123       if (n == 0)
3124       {
3125          log_error(LOG_LEVEL_CONNECT, "Socket timeout %d reached: %s",
3126             csp->config->socket_timeout, http->url);
3127          if ((byte_count == 0) && (http->ssl == 0))
3128          {
3129             send_crunch_response(csp, error_response(csp, "connection-timeout"));
3130          }
3131          mark_server_socket_tainted(csp);
3132 #ifdef FEATURE_HTTPS_INSPECTION
3133          close_client_and_server_ssl_connections(csp);
3134 #endif
3135          return;
3136       }
3137       else if (n < 0)
3138       {
3139 #ifdef HAVE_POLL
3140          log_error(LOG_LEVEL_ERROR, "poll() failed!: %E");
3141 #else
3142          log_error(LOG_LEVEL_ERROR, "select() failed!: %E");
3143 #endif
3144          mark_server_socket_tainted(csp);
3145 #ifdef FEATURE_HTTPS_INSPECTION
3146          close_client_and_server_ssl_connections(csp);
3147 #endif
3148          return;
3149       }
3150
3151       /*
3152        * This is the body of the browser's request,
3153        * just read and write it.
3154        *
3155        * Receives data from browser and sends it to server
3156        *
3157        * XXX: Make sure the client doesn't use pipelining
3158        * behind Privoxy's back.
3159        */
3160 #ifdef HAVE_POLL
3161       if ((poll_fds[0].revents & (POLLERR|POLLHUP|POLLNVAL)) != 0)
3162       {
3163          log_error(LOG_LEVEL_CONNECT,
3164             "The client socket %d has become unusable while "
3165             "the server socket %d is still open.",
3166             csp->cfd, csp->server_connection.sfd);
3167          mark_server_socket_tainted(csp);
3168          break;
3169       }
3170
3171       if (poll_fds[0].revents != 0)
3172 #else
3173       if (FD_ISSET(csp->cfd, &rfds))
3174 #endif /* def HAVE_POLL*/
3175       {
3176          int max_bytes_to_read = (int)csp->receive_buffer_size;
3177
3178 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3179          if ((csp->flags & CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ))
3180          {
3181             if (data_is_available(csp->cfd, 0))
3182             {
3183                /*
3184                 * If the next request is already waiting, we have
3185                 * to stop select()ing the client socket. Otherwise
3186                 * we would always return right away and get nothing
3187                 * else done.
3188                 */
3189                watch_client_socket = 0;
3190                log_error(LOG_LEVEL_CONNECT,
3191                   "Stop watching client socket %d. "
3192                   "There's already another request waiting.",
3193                   csp->cfd);
3194                continue;
3195             }
3196             /*
3197              * If the client socket is set, but there's no data
3198              * available on the socket, the client went fishing
3199              * and continuing talking to the server makes no sense.
3200              */
3201             log_error(LOG_LEVEL_CONNECT,
3202                "The client closed socket %d while "
3203                "the server socket %d is still open.",
3204                csp->cfd, csp->server_connection.sfd);
3205             mark_server_socket_tainted(csp);
3206             break;
3207          }
3208          if (csp->expected_client_content_length != 0)
3209          {
3210             if (csp->expected_client_content_length < csp->receive_buffer_size)
3211             {
3212                max_bytes_to_read = (int)csp->expected_client_content_length;
3213             }
3214             log_error(LOG_LEVEL_CONNECT,
3215                "Waiting for up to %d bytes from the client.",
3216                max_bytes_to_read);
3217          }
3218          assert(max_bytes_to_read <= csp->receive_buffer_size);
3219 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3220
3221 #ifdef FEATURE_HTTPS_INSPECTION
3222          if (client_use_ssl(csp))
3223          {
3224             if (csp->http->status == 101)
3225             {
3226                len = ssl_recv_data(&(csp->ssl_client_attr),
3227                   (unsigned char *)csp->receive_buffer,
3228                   (size_t)max_bytes_to_read);
3229                if (len == -1)
3230                {
3231                   log_error(LOG_LEVEL_ERROR, "Failed to receive data "
3232                      "on client socket %d for an upgraded connection",
3233                      csp->cfd);
3234                   break;
3235                }
3236                if (len == 0)
3237                {
3238                   log_error(LOG_LEVEL_CONNECT, "Done receiving data "
3239                      "on client socket %d for an upgraded connection",
3240                      csp->cfd);
3241                   break;
3242                }
3243                byte_count += (unsigned long long)len;
3244                len = ssl_send_data(&(csp->ssl_server_attr),
3245                   (unsigned char *)csp->receive_buffer, (size_t)len);
3246                if (len == -1)
3247                {
3248                   log_error(LOG_LEVEL_ERROR, "Failed to send data "
3249                      "on server socket %d for an upgraded connection",
3250                      csp->server_connection.sfd);
3251                   break;
3252                }
3253                continue;
3254             }
3255             log_error(LOG_LEVEL_CONNECT, "Breaking with TLS/SSL.");
3256             break;
3257          }
3258          else
3259 #endif /* def FEATURE_HTTPS_INSPECTION */
3260          {
3261             len = read_socket(csp->cfd, csp->receive_buffer, max_bytes_to_read);
3262
3263             if (len <= 0)
3264             {
3265                /* XXX: not sure if this is necessary. */
3266                mark_server_socket_tainted(csp);
3267                break; /* "game over, man" */
3268             }
3269
3270 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3271             if (csp->expected_client_content_length != 0)
3272             {
3273                assert(len <= max_bytes_to_read);
3274                csp->expected_client_content_length -= (unsigned)len;
3275                log_error(LOG_LEVEL_CONNECT,
3276                   "Expected client content length set to %llu "
3277                   "after reading %ld bytes.",
3278                   csp->expected_client_content_length, len);
3279                if (csp->expected_client_content_length == 0)
3280                {
3281                   log_error(LOG_LEVEL_CONNECT,
3282                      "Done reading from the client.");
3283                   csp->flags |= CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ;
3284                }
3285             }
3286 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3287
3288             if (write_socket(csp->server_connection.sfd, csp->receive_buffer, (size_t)len))
3289             {
3290                log_error(LOG_LEVEL_ERROR, "write to: %s failed: %E", http->host);
3291                mark_server_socket_tainted(csp);
3292                return;
3293             }
3294          }
3295          continue;
3296       }
3297
3298       /*
3299        * The server wants to talk. It could be the header or the body.
3300        * If `hdr' is null, then it's the header otherwise it's the body.
3301        * FIXME: Does `hdr' really mean `host'? No.
3302        */
3303 #ifdef HAVE_POLL
3304       if (poll_fds[1].revents != 0)
3305 #else
3306       if (FD_ISSET(csp->server_connection.sfd, &rfds))
3307 #endif /* HAVE_POLL */
3308       {
3309 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3310          /*
3311           * If we are buffering content, we don't want to eat up to
3312           * buffer-limit bytes if the client no longer cares about them.
3313           * If we aren't buffering, however, a dead client socket will be
3314           * noticed pretty much right away anyway, so we can reduce the
3315           * overhead by skipping the check.
3316           */
3317          if (buffer_and_filter_content && !socket_is_still_alive(csp->cfd))
3318          {
3319 #ifdef _WIN32
3320             log_error(LOG_LEVEL_CONNECT,
3321                "The server still wants to talk, but the client may already have hung up on us.");
3322 #else
3323             log_error(LOG_LEVEL_CONNECT,
3324                "The server still wants to talk, but the client hung up on us.");
3325             mark_server_socket_tainted(csp);
3326 #ifdef FEATURE_HTTPS_INSPECTION
3327             close_client_and_server_ssl_connections(csp);
3328 #endif
3329             return;
3330 #endif /* def _WIN32 */
3331          }
3332 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3333
3334 #ifdef FEATURE_HTTPS_INSPECTION
3335          /*
3336           * Reading data from standard or secured connection (HTTP/HTTPS)
3337           */
3338          if (server_use_ssl(csp))
3339          {
3340             len = ssl_recv_data(&(csp->ssl_server_attr),
3341                (unsigned char *)csp->receive_buffer, csp->receive_buffer_size);
3342          }
3343          else
3344 #endif
3345          {
3346             len = read_socket(csp->server_connection.sfd, csp->receive_buffer,
3347                (int)csp->receive_buffer_size);
3348          }
3349
3350          if (len < 0)
3351          {
3352             log_error(LOG_LEVEL_ERROR, "read from: %s failed: %E", http->host);
3353
3354             if ((http->ssl && (csp->fwd == NULL))
3355 #ifdef FEATURE_HTTPS_INSPECTION
3356                && use_ssl_tunnel
3357 #endif
3358                 )
3359             {
3360                /*
3361                 * Just hang up. We already confirmed the client's CONNECT
3362                 * request with status code 200 and unencrypted content is
3363                 * no longer welcome.
3364                 */
3365                log_error(LOG_LEVEL_ERROR,
3366                   "CONNECT already confirmed. Unable to tell the client about the problem.");
3367                return;
3368             }
3369             else if (byte_count)
3370             {
3371                /*
3372                 * Just hang up. We already transmitted the original headers
3373                 * and parts of the original content and therefore missed the
3374                 * chance to send an error message (without risking data corruption).
3375                 *
3376                 * XXX: we could retry with a fancy range request here.
3377                 */
3378                log_error(LOG_LEVEL_ERROR, "Already forwarded the original headers. "
3379                   "Unable to tell the client about the problem.");
3380                mark_server_socket_tainted(csp);
3381 #ifdef FEATURE_HTTPS_INSPECTION
3382                close_client_and_server_ssl_connections(csp);
3383 #endif
3384                return;
3385             }
3386             /*
3387              * XXX: Consider handling the cases above the same.
3388              */
3389             mark_server_socket_tainted(csp);
3390             len = 0;
3391          }
3392
3393 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3394          if (csp->flags & CSP_FLAG_CHUNKED)
3395          {
3396             if ((len >= 5) && !memcmp(csp->receive_buffer+len-5, "0\r\n\r\n", 5))
3397             {
3398                /* XXX: this is a temporary hack */
3399                log_error(LOG_LEVEL_CONNECT,
3400                   "Looks like we reached the end of the last chunk. "
3401                   "We better stop reading.");
3402                csp->expected_content_length = byte_count + (unsigned long long)len;
3403                csp->flags |= CSP_FLAG_CONTENT_LENGTH_SET;
3404             }
3405          }
3406          reading_done:
3407 #endif  /* FEATURE_CONNECTION_KEEP_ALIVE */
3408
3409          /*
3410           * This is guaranteed by allocating with zalloc_or_die()
3411           * and never (intentionally) writing to the last byte.
3412           *
3413           * csp->receive_buffer_size is the size of the part of the
3414           * buffer we intentionally write to, but we actually
3415           * allocated csp->receive_buffer_size+1 bytes so the assertion
3416           * stays within the allocated range.
3417           */
3418          assert(csp->receive_buffer[csp->receive_buffer_size] == '\0');
3419
3420          /*
3421           * Add a trailing zero to let be able to use string operations.
3422           * XXX: do we still need this with filter_popups gone?
3423           */
3424          assert(len <= csp->receive_buffer_size);
3425          csp->receive_buffer[len] = '\0';
3426
3427          /*
3428           * Normally, this would indicate that we've read
3429           * as much as the server has sent us and we can
3430           * close the client connection.  However, Microsoft
3431           * in its wisdom has released IIS/5 with a bug that
3432           * prevents it from sending the trailing \r\n in
3433           * a 302 redirect header (and possibly other headers).
3434           * To work around this if we've haven't parsed
3435           * a full header we'll append a trailing \r\n
3436           * and see if this now generates a valid one.
3437           *
3438           * This hack shouldn't have any impacts.  If we've
3439           * already transmitted the header or if this is a
3440           * SSL connection, then we won't bother with this
3441           * hack.  So we only work on partially received
3442           * headers.  If we append a \r\n and this still
3443           * doesn't generate a valid header, then we won't
3444           * transmit anything to the client.
3445           */
3446          if (len == 0)
3447          {
3448
3449             if (server_body || (http->ssl
3450 #ifdef FEATURE_HTTPS_INSPECTION
3451                   && use_ssl_tunnel
3452 #endif
3453                ))
3454             {
3455                /*
3456                 * If we have been buffering up the document,
3457                 * now is the time to apply content modification
3458                 * and send the result to the client.
3459                 */
3460                if (buffer_and_filter_content)
3461                {
3462                   p = execute_content_filters(csp);
3463                   /*
3464                    * If content filtering fails, use the original
3465                    * buffer and length.
3466                    * (see p != NULL ? p : csp->iob->cur below)
3467                    */
3468                   if (NULL == p)
3469                   {
3470                      csp->content_length = (size_t)(csp->iob->eod - csp->iob->cur);
3471                   }
3472 #ifdef FEATURE_COMPRESSION
3473                   else if ((csp->flags & CSP_FLAG_CLIENT_SUPPORTS_DEFLATE)
3474                      && (csp->content_length > LOWER_LENGTH_LIMIT_FOR_COMPRESSION))
3475                   {
3476                      char *compressed_content = compress_buffer(p,
3477                         (size_t *)&csp->content_length, csp->config->compression_level);
3478                      if (compressed_content != NULL)
3479                      {
3480                         freez(p);
3481                         p = compressed_content;
3482                         csp->flags |= CSP_FLAG_BUFFERED_CONTENT_DEFLATED;
3483                      }
3484                   }
3485 #endif
3486
3487                   if (JB_ERR_OK != update_server_headers(csp))
3488                   {
3489                      log_error(LOG_LEVEL_FATAL,
3490                         "Failed to update server headers. after filtering.");
3491                   }
3492
3493                   hdr = list_to_text(csp->headers);
3494                   if (hdr == NULL)
3495                   {
3496                      /* FIXME Should handle error properly */
3497                      log_error(LOG_LEVEL_FATAL, "Out of memory parsing server header");
3498                   }
3499
3500 #ifdef FEATURE_HTTPS_INSPECTION
3501                   /*
3502                    * Sending data with standard or secured connection (HTTP/HTTPS)
3503                    */
3504                   if (client_use_ssl(csp))
3505                   {
3506                      if ((ssl_send_data_delayed(&(csp->ssl_client_attr),
3507                               (const unsigned char *)hdr, strlen(hdr),
3508                               get_write_delay(csp)) < 0)
3509                         || (ssl_send_data_delayed(&(csp->ssl_client_attr),
3510                               (const unsigned char *) ((p != NULL) ? p : csp->iob->cur),
3511                               csp->content_length, get_write_delay(csp)) < 0))
3512                      {
3513                         log_error(LOG_LEVEL_ERROR, "write modified content to "
3514                            "client over TLS/SSL failed");
3515                         freez(hdr);
3516                         freez(p);
3517                         mark_server_socket_tainted(csp);
3518                         close_client_and_server_ssl_connections(csp);
3519                         return;
3520                      }
3521                   }
3522                   else
3523 #endif /* def FEATURE_HTTPS_INSPECTION */
3524                   {
3525                      if (write_socket_delayed(csp->cfd, hdr, strlen(hdr), write_delay)
3526                       || write_socket_delayed(csp->cfd, ((p != NULL) ? p : csp->iob->cur),
3527                          (size_t)csp->content_length, write_delay))
3528                      {
3529                         log_error(LOG_LEVEL_ERROR, "write modified content to client failed: %E");
3530                         freez(hdr);
3531                         freez(p);
3532                         mark_server_socket_tainted(csp);
3533                         return;
3534                      }
3535                   }
3536
3537                   freez(hdr);
3538                   freez(p);
3539                }
3540
3541                break; /* "game over, man" */
3542             }
3543
3544             /*
3545              * This is NOT the body, so
3546              * Let's pretend the server just sent us a blank line.
3547              */
3548             snprintf(csp->receive_buffer, csp->receive_buffer_size, "\r\n");
3549             len = (int)strlen(csp->receive_buffer);
3550
3551             /*
3552              * Now, let the normal header parsing algorithm below do its
3553              * job.  If it fails, we'll exit instead of continuing.
3554              */
3555
3556             ms_iis5_hack = 1;
3557          }
3558
3559          /*
3560           * If we're in the body of the server document, just write it to
3561           * the client, unless we need to buffer the body for later
3562           * content-filtering.
3563           */
3564          if (server_body || (http->ssl
3565 #ifdef FEATURE_HTTPS_INSPECTION
3566                && use_ssl_tunnel
3567 #endif
3568             ))
3569          {
3570             if (buffer_and_filter_content)
3571             {
3572                /*
3573                 * If there is no memory left for buffering the content, or the buffer limit
3574                 * has been reached, switch to non-filtering mode, i.e. make & write the
3575                 * header, flush the iob and buf, and get out of the way.
3576                 */
3577                if (add_to_iob(csp->iob, csp->config->buffer_limit, csp->receive_buffer, len))
3578                {
3579                   size_t hdrlen;
3580                   long flushed;
3581
3582                   log_error(LOG_LEVEL_INFO,
3583                      "Flushing header and buffers. Stepping back from filtering.");
3584
3585                   hdr = list_to_text(csp->headers);
3586                   if (hdr == NULL)
3587                   {
3588                      /*
3589                       * Memory is too tight to even generate the header.
3590                       * Send our static "Out-of-memory" page.
3591                       */
3592                      log_error(LOG_LEVEL_ERROR, "Out of memory while trying to flush.");
3593                      rsp = cgi_error_memory();
3594                      send_crunch_response(csp, rsp);
3595                      mark_server_socket_tainted(csp);
3596 #ifdef FEATURE_HTTPS_INSPECTION
3597                      close_client_and_server_ssl_connections(csp);
3598 #endif
3599                      return;
3600                   }
3601                   hdrlen = strlen(hdr);
3602
3603 #ifdef FEATURE_HTTPS_INSPECTION
3604                   /*
3605                    * Sending data with standard or secured connection (HTTP/HTTPS)
3606                    */
3607                   if (client_use_ssl(csp))
3608                   {
3609                      if ((ssl_send_data_delayed(&(csp->ssl_client_attr),
3610                              (const unsigned char *)hdr, hdrlen, get_write_delay(csp)) < 0)
3611                         || ((flushed = ssl_flush_socket(&(csp->ssl_client_attr),
3612                                 csp->iob)) < 0)
3613                         || (ssl_send_data_delayed(&(csp->ssl_client_attr),
3614                               (const unsigned char *)csp->receive_buffer, (size_t)len,
3615                               get_write_delay(csp)) < 0))
3616                      {
3617                         log_error(LOG_LEVEL_CONNECT,
3618                            "Flush header and buffers to client failed");
3619                         freez(hdr);
3620                         mark_server_socket_tainted(csp);
3621                         close_client_and_server_ssl_connections(csp);
3622                         return;
3623                      }
3624                   }
3625                   else
3626 #endif /* def FEATURE_HTTPS_INSPECTION */
3627                   {
3628                      if (write_socket_delayed(csp->cfd, hdr, hdrlen, write_delay)
3629                       || ((flushed = flush_iob(csp->cfd, csp->iob, write_delay)) < 0)
3630                       || write_socket_delayed(csp->cfd, csp->receive_buffer, (size_t)len,
3631                             write_delay))
3632                      {
3633                         log_error(LOG_LEVEL_CONNECT,
3634                            "Flush header and buffers to client failed: %E");
3635                         freez(hdr);
3636                         mark_server_socket_tainted(csp);
3637                         return;
3638                      }
3639                   }
3640
3641                   /*
3642                    * Reset the byte_count to the amount of bytes
3643                    * we just flushed. len will be added a few lines below,
3644                    * hdrlen doesn't matter for LOG_LEVEL_CLF.
3645                    */
3646                   byte_count = (unsigned long long)flushed;
3647                   freez(hdr);
3648                   buffer_and_filter_content = 0;
3649                   server_body = 1;
3650                }
3651             }
3652             else
3653             {
3654 #ifdef FEATURE_HTTPS_INSPECTION
3655                /*
3656                 * Sending data with standard or secured connection (HTTP/HTTPS)
3657                 */
3658                if (client_use_ssl(csp))
3659                {
3660                   ret = ssl_send_data_delayed(&(csp->ssl_client_attr),
3661                      (const unsigned char *)csp->receive_buffer, (size_t)len,
3662                      get_write_delay(csp));
3663                   if (ret < 0)
3664                   {
3665                      log_error(LOG_LEVEL_ERROR,
3666                         "Sending data to client failed");
3667                      mark_server_socket_tainted(csp);
3668                      close_client_and_server_ssl_connections(csp);
3669                      return;
3670                   }
3671                }
3672                else
3673 #endif /* def FEATURE_HTTPS_INSPECTION */
3674                {
3675                   if (write_socket_delayed(csp->cfd, csp->receive_buffer,
3676                         (size_t)len, write_delay))
3677                   {
3678                      log_error(LOG_LEVEL_ERROR, "write to client failed: %E");
3679                      mark_server_socket_tainted(csp);
3680                      return;
3681                   }
3682                }
3683             }
3684             byte_count += (unsigned long long)len;
3685             continue;
3686          }
3687          else
3688          {
3689             /*
3690              * We're still looking for the end of the server's header.
3691              * Buffer up the data we just read.  If that fails, there's
3692              * little we can do but send our static out-of-memory page.
3693              */
3694             if (add_to_iob(csp->iob, csp->config->buffer_limit, csp->receive_buffer, len))
3695             {
3696                log_error(LOG_LEVEL_ERROR, "Out of memory while looking for end of server headers.");
3697                rsp = cgi_error_memory();
3698                send_crunch_response(csp, rsp);
3699                mark_server_socket_tainted(csp);
3700 #ifdef FEATURE_HTTPS_INSPECTION
3701                close_client_and_server_ssl_connections(csp);
3702 #endif
3703                return;
3704             }
3705
3706             /* Convert iob into something sed() can digest */
3707             if (JB_ERR_PARSE == get_server_headers(csp))
3708             {
3709                if (ms_iis5_hack)
3710                {
3711                   /*
3712                    * Well, we tried our MS IIS/5 hack and it didn't work.
3713                    * The header is incomplete and there isn't anything
3714                    * we can do about it.
3715                    */
3716                   log_error(LOG_LEVEL_ERROR, "Invalid server headers. "
3717                      "Applying the MS IIS5 hack didn't help.");
3718                   log_error(LOG_LEVEL_CLF,
3719                      "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3720 #ifdef FEATURE_HTTPS_INSPECTION
3721                   /*
3722                    * Sending data with standard or secured connection (HTTP/HTTPS)
3723                    */
3724                   if (client_use_ssl(csp))
3725                   {
3726                      ssl_send_data_delayed(&(csp->ssl_client_attr),
3727                         (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3728                         strlen(INVALID_SERVER_HEADERS_RESPONSE), get_write_delay(csp));
3729                   }
3730                   else
3731 #endif /* def FEATURE_HTTPS_INSPECTION */
3732                   {
3733                      write_socket_delayed(csp->cfd,
3734                         INVALID_SERVER_HEADERS_RESPONSE,
3735                         strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3736                   }
3737                   mark_server_socket_tainted(csp);
3738 #ifdef FEATURE_HTTPS_INSPECTION
3739                   close_client_and_server_ssl_connections(csp);
3740 #endif
3741                   return;
3742                }
3743                else
3744                {
3745                   /*
3746                    * Since we have to wait for more from the server before
3747                    * we can parse the headers we just continue here.
3748                    */
3749                   log_error(LOG_LEVEL_CONNECT,
3750                      "Continuing buffering server headers from socket %d. "
3751                      "Bytes most recently read: %ld.", csp->cfd, len);
3752                   continue;
3753                }
3754             }
3755             else
3756             {
3757                /*
3758                 * Account for the content bytes we
3759                 * might have gotten with the headers.
3760                 */
3761                assert(csp->iob->eod >= csp->iob->cur);
3762                byte_count = (unsigned long long)(csp->iob->eod - csp->iob->cur);
3763             }
3764
3765             /* Did we actually get anything? */
3766             if (NULL == csp->headers->first)
3767             {
3768                if ((csp->flags & CSP_FLAG_REUSED_CLIENT_CONNECTION))
3769                {
3770                   log_error(LOG_LEVEL_ERROR,
3771                      "No server or forwarder response received on socket %d. "
3772                      "Closing client socket %d without sending data.",
3773                      csp->server_connection.sfd, csp->cfd);
3774                   log_error(LOG_LEVEL_CLF,
3775                      "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3776                }
3777                else
3778                {
3779                   log_error(LOG_LEVEL_ERROR,
3780                      "No server or forwarder response received on socket %d.",
3781                      csp->server_connection.sfd);
3782                   send_crunch_response(csp, error_response(csp, "no-server-data"));
3783                }
3784                free_http_request(http);
3785                mark_server_socket_tainted(csp);
3786 #ifdef FEATURE_HTTPS_INSPECTION
3787                close_client_and_server_ssl_connections(csp);
3788 #endif
3789                return;
3790             }
3791
3792             if (!csp->headers->first->str)
3793             {
3794                log_error(LOG_LEVEL_ERROR, "header search: csp->headers->first->str == NULL, assert will be called");
3795             }
3796             assert(csp->headers->first->str);
3797
3798             if (strncmpic(csp->headers->first->str, "HTTP", 4) &&
3799                 strncmpic(csp->headers->first->str, "ICY", 3))
3800             {
3801                /*
3802                 * It doesn't look like a HTTP (or Shoutcast) response:
3803                 * tell the client and log the problem.
3804                 */
3805                if (strlen(csp->headers->first->str) > 30)
3806                {
3807                   csp->headers->first->str[30] = '\0';
3808                }
3809                log_error(LOG_LEVEL_ERROR,
3810                   "Invalid server or forwarder response. Starts with: %s",
3811                   csp->headers->first->str);
3812                log_error(LOG_LEVEL_CLF,
3813                   "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3814 #ifdef FEATURE_HTTPS_INSPECTION
3815                /*
3816                 * Sending data with standard or secured connection (HTTP/HTTPS)
3817                 */
3818                if (client_use_ssl(csp))
3819                {
3820                   ssl_send_data_delayed(&(csp->ssl_client_attr),
3821                      (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3822                      strlen(INVALID_SERVER_HEADERS_RESPONSE),
3823                      get_write_delay(csp));
3824                }
3825                else
3826 #endif /* def FEATURE_HTTPS_INSPECTION */
3827                {
3828                   write_socket_delayed(csp->cfd, INVALID_SERVER_HEADERS_RESPONSE,
3829                      strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3830                }
3831                free_http_request(http);
3832                mark_server_socket_tainted(csp);
3833 #ifdef FEATURE_HTTPS_INSPECTION
3834                close_client_and_server_ssl_connections(csp);
3835 #endif
3836                return;
3837             }
3838
3839             /*
3840              * We have now received the entire server header,
3841              * filter it and send the result to the client
3842              */
3843             if (JB_ERR_OK != sed(csp, FILTER_SERVER_HEADERS))
3844             {
3845                log_error(LOG_LEVEL_CLF,
3846                   "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3847 #ifdef FEATURE_HTTPS_INSPECTION
3848                /*
3849                 * Sending data with standard or secured connection (HTTP/HTTPS)
3850                 */
3851                if (client_use_ssl(csp))
3852                {
3853                   ssl_send_data_delayed(&(csp->ssl_client_attr),
3854                      (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3855                      strlen(INVALID_SERVER_HEADERS_RESPONSE),
3856                      get_write_delay(csp));
3857                }
3858                else
3859 #endif
3860                {
3861                   write_socket_delayed(csp->cfd, INVALID_SERVER_HEADERS_RESPONSE,
3862                      strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3863                }
3864                free_http_request(http);
3865                mark_server_socket_tainted(csp);
3866 #ifdef FEATURE_HTTPS_INSPECTION
3867                close_client_and_server_ssl_connections(csp);
3868 #endif
3869                return;
3870             }
3871             hdr = list_to_text(csp->headers);
3872             if (hdr == NULL)
3873             {
3874                /* FIXME Should handle error properly */
3875                log_error(LOG_LEVEL_FATAL, "Out of memory parsing server header");
3876             }
3877
3878             if ((csp->flags & CSP_FLAG_CHUNKED)
3879                && !(csp->flags & CSP_FLAG_CONTENT_LENGTH_SET)
3880                && ((csp->iob->eod - csp->iob->cur) >= 5)
3881                && !memcmp(csp->iob->eod-5, "0\r\n\r\n", 5))
3882             {
3883                log_error(LOG_LEVEL_CONNECT,
3884                   "Looks like we got the last chunk together with "
3885                   "the server headers. We better stop reading.");
3886                byte_count = (unsigned long long)(csp->iob->eod - csp->iob->cur);
3887                csp->expected_content_length = byte_count;
3888                csp->flags |= CSP_FLAG_CONTENT_LENGTH_SET;
3889             }
3890
3891             csp->server_connection.response_received = time(NULL);
3892
3893             if (crunch_response_triggered(csp, crunchers_light))
3894             {
3895                /*
3896                 * One of the tags created by a server-header
3897                 * tagger triggered a crunch. We already
3898                 * delivered the crunch response to the client
3899                 * and are done here after cleaning up.
3900                 */
3901                freez(hdr);
3902                mark_server_socket_tainted(csp);
3903 #ifdef FEATURE_HTTPS_INSPECTION
3904                close_client_and_server_ssl_connections(csp);
3905 #endif
3906                return;
3907             }
3908
3909             /* Buffer and pcrs filter this if appropriate. */
3910             buffer_and_filter_content = content_requires_filtering(csp);
3911
3912             if (!buffer_and_filter_content)
3913             {
3914                /*
3915                 * Write the server's (modified) header to
3916                 * the client (along with anything else that
3917                 * may be in the buffer). Use standard or secured
3918                 * connection.
3919                 */
3920 #ifdef FEATURE_HTTPS_INSPECTION
3921                if (client_use_ssl(csp))
3922                {
3923                   if ((ssl_send_data_delayed(&(csp->ssl_client_attr),
3924                           (const unsigned char *)hdr, strlen(hdr),
3925                           get_write_delay(csp)) < 0)
3926                      || (len = ssl_flush_socket(&(csp->ssl_client_attr),
3927                             csp->iob) < 0))
3928                   {
3929                      log_error(LOG_LEVEL_CONNECT, "Write header to client failed");
3930
3931                      /*
3932                       * The write failed, so don't bother mentioning it
3933                       * to the client... it probably can't hear us anyway.
3934                       */
3935                      freez(hdr);
3936                      mark_server_socket_tainted(csp);
3937 #ifdef FEATURE_HTTPS_INSPECTION
3938                      close_client_and_server_ssl_connections(csp);
3939 #endif
3940                      return;
3941                   }
3942                }
3943                else
3944 #endif /* def FEATURE_HTTPS_INSPECTION */
3945                {
3946                   if (write_socket_delayed(csp->cfd, hdr, strlen(hdr), write_delay)
3947                      || ((len = flush_iob(csp->cfd, csp->iob, write_delay)) < 0))
3948                   {
3949                      log_error(LOG_LEVEL_ERROR,
3950                         "write header to client failed");
3951                      /*
3952                       * The write failed, so don't bother mentioning it
3953                       * to the client... it probably can't hear us anyway.
3954                       */
3955                      freez(hdr);
3956                      mark_server_socket_tainted(csp);
3957                      return;
3958                   }
3959                }
3960                                 }
3961
3962             /* we're finished with the server's header */
3963
3964             freez(hdr);
3965             server_body = 1;
3966
3967             /*
3968              * If this was a MS IIS/5 hack then it means the server
3969              * has already closed the connection. Nothing more to read.
3970              * Time to bail.
3971              */
3972             if (ms_iis5_hack)
3973             {
3974                log_error(LOG_LEVEL_ERROR,
3975                   "Closed server connection detected. "
3976                   "Applying the MS IIS5 hack didn't help.");
3977                log_error(LOG_LEVEL_CLF,
3978                   "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3979 #ifdef FEATURE_HTTPS_INSPECTION
3980                /*
3981                 * Sending data with standard or secured connection (HTTP/HTTPS)
3982                 */
3983                if (client_use_ssl(csp))
3984                {
3985                   ssl_send_data_delayed(&(csp->ssl_client_attr),
3986                      (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3987                      strlen(INVALID_SERVER_HEADERS_RESPONSE),
3988                      get_write_delay(csp));
3989                }
3990                else
3991 #endif /* def FEATURE_HTTPS_INSPECTION */
3992                {
3993                   write_socket_delayed(csp->cfd, INVALID_SERVER_HEADERS_RESPONSE,
3994                      strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3995                }
3996                mark_server_socket_tainted(csp);
3997 #ifdef FEATURE_HTTPS_INSPECTION
3998                close_client_and_server_ssl_connections(csp);
3999 #endif
4000                return;
4001             }
4002          }
4003          continue;
4004       }
4005       mark_server_socket_tainted(csp);
4006 #ifdef FEATURE_HTTPS_INSPECTION
4007       close_client_and_server_ssl_connections(csp);
4008 #endif
4009       return; /* huh? we should never get here */
4010    }
4011
4012    if (csp->content_length == 0)
4013    {
4014       /*
4015        * If Privoxy didn't recalculate the Content-Length,
4016        * byte_count is still correct.
4017        */
4018       csp->content_length = byte_count;
4019    }
4020
4021 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4022    if ((csp->flags & CSP_FLAG_CONTENT_LENGTH_SET)
4023       && (csp->expected_content_length != byte_count))
4024    {
4025       log_error(LOG_LEVEL_CONNECT,
4026          "Received %llu bytes while expecting %llu.",
4027          byte_count, csp->expected_content_length);
4028       mark_server_socket_tainted(csp);
4029    }
4030 #endif
4031
4032 #ifdef FEATURE_HTTPS_INSPECTION
4033    if (client_use_ssl(csp))
4034    {
4035       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s https://%s%s %s\" 200 %llu",
4036          csp->ip_addr_str, http->gpc, http->hostport, http->path,
4037          http->version, csp->content_length);
4038    }
4039    else
4040 #endif
4041    {
4042       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s\" 200 %llu",
4043          csp->ip_addr_str, http->ocmd, csp->content_length);
4044    }
4045    csp->server_connection.timestamp = time(NULL);
4046 }
4047
4048
4049 /*********************************************************************
4050  *
4051  * Function    :  chat
4052  *
4053  * Description :  Once a connection from the client has been accepted,
4054  *                this function is called (via serve()) to handle the
4055  *                main business of the communication.  This function
4056  *                returns after dealing with a single request. It can
4057  *                be called multiple times with the same client socket
4058  *                if the client is keeping the connection alive.
4059  *
4060  *                The decision whether or not a client connection will
4061  *                be kept alive is up to the caller which also must
4062  *                close the client socket when done.
4063  *
4064  *                FIXME: chat is nearly thousand lines long.
4065  *                Ridiculous.
4066  *
4067  * Parameters  :
4068  *          1  :  csp = Current client state (buffers, headers, etc...)
4069  *
4070  * Returns     :  Nothing.
4071  *
4072  *********************************************************************/
4073 static void chat(struct client_state *csp)
4074 {
4075    const struct forward_spec *fwd;
4076    struct http_request *http;
4077    /* Skeleton for HTTP response, if we should intercept the request */
4078    struct http_response *rsp;
4079 #ifdef FEATURE_HTTPS_INSPECTION
4080    int use_ssl_tunnel = 0;
4081 #endif
4082
4083    http = csp->http;
4084
4085    if (receive_client_request(csp) != JB_ERR_OK)
4086    {
4087       return;
4088    }
4089    if (parse_client_request(csp) != JB_ERR_OK)
4090    {
4091       return;
4092    }
4093
4094    /* decide how to route the HTTP request */
4095    fwd = forward_url(csp, http);
4096
4097 #ifdef FEATURE_HTTPS_INSPECTION
4098    /*
4099     * Setting flags to use old solution with SSL tunnel and to disable
4100     * certificate verification.
4101     */
4102    if (csp->http->ssl && !(csp->action->flags & ACTION_HTTPS_INSPECTION)
4103       && !cgi_page_requested(csp->http->host))
4104    {
4105       use_ssl_tunnel = 1;
4106    }
4107
4108    if (http->ssl && (csp->action->flags & ACTION_IGNORE_CERTIFICATE_ERRORS))
4109    {
4110       csp->dont_verify_certificate = 1;
4111    }
4112 #endif
4113
4114    /*
4115     * build the http request to send to the server
4116     * we have to do one of the following:
4117     *
4118     * create =    use the original HTTP request to create a new
4119     *             HTTP request that has either the path component
4120     *             without the http://domainspec (w/path) or the
4121     *             full orininal URL (w/url)
4122     *             Note that the path and/or the HTTP version may
4123     *             have been altered by now.
4124     *
4125     * SSL proxy = Open a socket to the host:port of the server
4126     *             and create TLS/SSL connection with server and
4127     *             with client. Then behave like mediator between
4128     *             client and server over TLS/SSL.
4129     *
4130     * SSL proxy = Pass the request unchanged if forwarding a CONNECT
4131     *    with     request to a parent proxy. Note that we'll be sending
4132     * forwarding  the CFAIL message ourselves if connecting to the parent
4133     *             fails, but we won't send a CSUCCEED message if it works,
4134     *             since that would result in a double message (ours and the
4135     *             parent's). After sending the request to the parent, we
4136     *             must parse answer and send it to client. If connection
4137     *             with server is established, we do TLS/SSL proxy. Otherwise
4138     *             we send parent response to client and close connections.
4139     *
4140     * here's the matrix:
4141     *                        SSL
4142     *                    0        1
4143     *                +--------+--------+
4144     *                |        |        |
4145     *             0  | create |   SSL  |
4146     *                | w/path |  proxy |
4147     *  Forwarding    +--------+--------+
4148     *                |        |   SSL  |
4149     *             1  | create |  proxy |
4150     *                | w/url  |+forward|
4151     *                +--------+--------+
4152     *
4153     */
4154
4155 #ifdef FEATURE_HTTPS_INSPECTION
4156    /*
4157     * Presetting SSL client and server flags
4158     */
4159    if (http->ssl && !use_ssl_tunnel)
4160    {
4161       http->client_ssl = 1;
4162       http->server_ssl = 1;
4163    }
4164    else
4165    {
4166       http->client_ssl = 0;
4167       http->server_ssl = 0;
4168    }
4169 #endif
4170
4171 #ifdef FEATURE_HTTPS_INSPECTION
4172    /*
4173     * Log the request unless we're https inspecting
4174     * in which case we don't have the path yet and
4175     * will log the request later.
4176     */
4177    if (!client_use_ssl(csp))
4178 #endif
4179    {
4180       log_error(LOG_LEVEL_REQUEST, "%s%s", http->hostport, http->path);
4181    }
4182
4183    if (http->ssl && connect_port_is_forbidden(csp))
4184    {
4185       const char *acceptable_connect_ports =
4186          csp->action->string[ACTION_STRING_LIMIT_CONNECT];
4187       assert(NULL != acceptable_connect_ports);
4188       log_error(LOG_LEVEL_INFO, "Request from %s marked for blocking. "
4189          "limit-connect{%s} doesn't allow CONNECT requests to %s",
4190          csp->ip_addr_str, acceptable_connect_ports, csp->http->hostport);
4191       csp->action->flags |= ACTION_BLOCK;
4192       http->ssl = 0;
4193 #ifdef FEATURE_HTTPS_INSPECTION
4194       http->client_ssl = 0;
4195       http->server_ssl = 0;
4196 #endif
4197    }
4198
4199
4200    freez(csp->headers->first->str);
4201    build_request_line(csp, fwd, &csp->headers->first->str);
4202
4203    /*
4204     * We have a request. Check if one of the crunchers wants it
4205     * unless the client wants to use TLS/SSL in which case we
4206     * haven't setup the TLS context yet and will send the crunch
4207     * response later.
4208     */
4209    if (
4210 #ifdef FEATURE_HTTPS_INSPECTION
4211        !client_use_ssl(csp) &&
4212 #endif
4213        crunch_response_triggered(csp, crunchers_all))
4214    {
4215       /*
4216        * Yes. The client got the crunch response and we're done here.
4217        */
4218       return;
4219    }
4220
4221    log_applied_actions(csp->action);
4222    if (fwd->forward_host)
4223    {
4224       log_error(LOG_LEVEL_CONNECT, "via [%s]:%d to: %s",
4225          fwd->forward_host, fwd->forward_port, http->hostport);
4226    }
4227    else
4228    {
4229       log_error(LOG_LEVEL_CONNECT, "to %s", http->hostport);
4230    }
4231
4232    /* here we connect to the server, gateway, or the forwarder */
4233
4234 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4235    if ((csp->server_connection.sfd != JB_INVALID_SOCKET)
4236       && socket_is_still_alive(csp->server_connection.sfd)
4237       && connection_destination_matches(&csp->server_connection, http, fwd))
4238    {
4239       log_error(LOG_LEVEL_CONNECT,
4240          "Reusing server socket %d connected to %s. Total requests: %u.",
4241          csp->server_connection.sfd, csp->server_connection.host,
4242          csp->server_connection.requests_sent_total);
4243    }
4244    else
4245    {
4246       if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4247       {
4248 #ifdef FEATURE_CONNECTION_SHARING
4249          if (csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING
4250 #ifdef FEATURE_HTTPS_INSPECTION
4251             && !server_use_ssl(csp)
4252 #endif
4253             )
4254          {
4255             remember_connection(&csp->server_connection);
4256          }
4257          else
4258 #endif /* def FEATURE_CONNECTION_SHARING */
4259          {
4260             log_error(LOG_LEVEL_CONNECT,
4261                "Closing server socket %d connected to %s. Total requests: %u.",
4262                csp->server_connection.sfd, csp->server_connection.host,
4263                csp->server_connection.requests_sent_total);
4264             close_socket(csp->server_connection.sfd);
4265          }
4266          mark_connection_closed(&csp->server_connection);
4267       }
4268 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4269 #ifdef FEATURE_HTTPS_INSPECTION
4270       if (client_use_ssl(csp) && !use_ssl_tunnel)
4271       {
4272          int ret;
4273          /*
4274           * Creating a SSL proxy.
4275           *
4276           * By sending the CSUCCEED message we're lying to the client as
4277           * the connection hasn't actually been established yet. We don't
4278           * establish the connection until we have seen and parsed the
4279           * encrypted client headers.
4280           */
4281          if (write_socket_delayed(csp->cfd, CSUCCEED,
4282                strlen(CSUCCEED), get_write_delay(csp)) != 0)
4283          {
4284             log_error(LOG_LEVEL_ERROR, "Sending SUCCEED to client failed");
4285             return;
4286          }
4287
4288          ret = create_client_ssl_connection(csp);
4289          if (ret != 0)
4290          {
4291             log_error(LOG_LEVEL_ERROR,
4292                "Failed to open a secure connection with the client");
4293             return;
4294          }
4295          if (JB_ERR_OK != process_encrypted_request(csp))
4296          {
4297             close_client_ssl_connection(csp);
4298             return;
4299          }
4300          /*
4301           * We have an encrypted request. Check if one of the crunchers now
4302           * wants it (for example because the previously invisible path was
4303           * required to match).
4304           */
4305          if (crunch_response_triggered(csp, crunchers_all))
4306          {
4307             /*
4308              * Yes. The client got the crunch response and we're done here.
4309              */
4310             return;
4311          }
4312       }
4313 #endif
4314       /*
4315        * Connecting to destination server
4316        */
4317       csp->server_connection.sfd = forwarded_connect(fwd, http, csp);
4318
4319       if (csp->server_connection.sfd == JB_INVALID_SOCKET)
4320       {
4321          if (fwd->type != SOCKS_NONE)
4322          {
4323             /* Socks error. */
4324             rsp = error_response(csp, "forwarding-failed");
4325          }
4326          else if (errno == EINVAL)
4327          {
4328             rsp = error_response(csp, "no-such-domain");
4329          }
4330          else
4331          {
4332             rsp = error_response(csp, "connect-failed");
4333          }
4334
4335          /* Write the answer to the client */
4336          if (rsp != NULL)
4337          {
4338             send_crunch_response(csp, rsp);
4339          }
4340
4341          /*
4342           * Temporary workaround to prevent already-read client
4343           * bodies from being parsed as new requests. For now we
4344           * err on the safe side and throw all the following
4345           * requests under the bus, even if no client body has been
4346           * buffered. A compliant client will repeat the dropped
4347           * requests on an untainted connection.
4348           *
4349           * The proper fix is to discard the no longer needed
4350           * client body in the buffer (if there is one) and to
4351           * continue parsing the bytes that follow.
4352           */
4353 #ifdef FEATURE_HTTPS_INSPECTION
4354          close_client_ssl_connection(csp);
4355 #endif
4356          drain_and_close_socket(csp->cfd);
4357          csp->cfd = JB_INVALID_SOCKET;
4358
4359          return;
4360       }
4361
4362 #ifdef FEATURE_HTTPS_INSPECTION
4363       /*
4364        * Creating TLS/SSL connections with destination server or parent
4365        * proxy. If forwarding is enabled, we must send client request to
4366        * parent proxy and receive, parse and resend parent proxy answer.
4367        */
4368       if (http->ssl && !use_ssl_tunnel)
4369       {
4370          if (fwd->forward_host != NULL)
4371          {
4372             char server_response[BUFFER_SIZE];
4373             int ret = 0;
4374             int len = 0;
4375             char *hdr = list_to_text(csp->headers);
4376             memset(server_response, 0, sizeof(server_response));
4377
4378             if (hdr == NULL)
4379             {
4380                log_error(LOG_LEVEL_FATAL,
4381                   "Out of memory parsing client header");
4382             }
4383             list_remove_all(csp->headers);
4384
4385             /*
4386              * Sending client's CONNECT request to the parent proxy
4387              */
4388             ret = write_socket(csp->server_connection.sfd, hdr, strlen(hdr));
4389
4390             freez(hdr);
4391
4392             if (ret != 0)
4393             {
4394                log_error(LOG_LEVEL_CONNECT,
4395                   "Sending request headers to: %s failed", http->hostport);
4396                mark_server_socket_tainted(csp);
4397                close_client_ssl_connection(csp);
4398                return;
4399             }
4400
4401             /* Waiting for parent proxy server response */
4402             len = read_socket(csp->server_connection.sfd, server_response,
4403                sizeof(server_response)-1);
4404
4405             if (len <= 0)
4406             {
4407                log_error(LOG_LEVEL_ERROR, "No response from parent proxy "
4408                   "server on socket %d.", csp->server_connection.sfd);
4409
4410                rsp = error_response(csp, "no-server-data");
4411                if (rsp)
4412                {
4413                   send_crunch_response(csp, rsp);
4414                }
4415                mark_server_socket_tainted(csp);
4416                close_client_ssl_connection(csp);
4417                return;
4418             }
4419
4420             /*
4421              * Test if the connection to the destination server was
4422              * established successfully by the parent proxy.
4423              */
4424             if (!tunnel_established_successfully(server_response, (unsigned int)len))
4425             {
4426                log_error(LOG_LEVEL_ERROR,
4427                   "The forwarder %s failed to establish a connection with %s",
4428                   fwd->forward_host, http->host);
4429                rsp = error_response(csp, "connect-failed");
4430                if (rsp)
4431                {
4432                   send_crunch_response(csp, rsp);
4433                }
4434                mark_server_socket_tainted(csp);
4435                close_client_ssl_connection(csp);
4436                return;
4437             }
4438          } /* -END- if (fwd->forward_host != NULL) */
4439
4440          /*
4441           * We can now create the TLS/SSL connection with the destination server.
4442           */
4443          int ret = create_server_ssl_connection(csp);
4444          if (ret != 0)
4445          {
4446             if (csp->server_cert_verification_result != SSL_CERT_VALID &&
4447                 csp->server_cert_verification_result != SSL_CERT_NOT_VERIFIED)
4448             {
4449                /*
4450                 * If the server certificate is invalid, we must inform
4451                 * the client and then close connection to the client.
4452                 */
4453                ssl_send_certificate_error(csp);
4454                close_client_and_server_ssl_connections(csp);
4455                return;
4456             }
4457             if (csp->server_cert_verification_result == SSL_CERT_NOT_VERIFIED
4458              || csp->server_cert_verification_result == SSL_CERT_VALID)
4459             {
4460                /*
4461                 * The TLS/SSL connection wasn't created but an invalid
4462                 * certificate wasn't detected. Report it as connection
4463                 * failure.
4464                 */
4465                rsp = error_response(csp, "connect-failed");
4466                if (rsp)
4467                {
4468                   send_crunch_response(csp, rsp);
4469                }
4470                close_client_and_server_ssl_connections(csp);
4471                return;
4472             }
4473          }
4474       }/* -END- if (http->ssl) */
4475 #endif /* def FEATURE_HTTPS_INSPECTION */
4476
4477 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4478       save_connection_destination(csp->server_connection.sfd,
4479          http, fwd, &csp->server_connection);
4480       csp->server_connection.keep_alive_timeout =
4481          (unsigned)csp->config->keep_alive_timeout;
4482    }
4483 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4484
4485    csp->server_connection.requests_sent_total++;
4486
4487    if ((fwd->type == SOCKS_5T) && (NULL == csp->headers->first))
4488    {
4489       /* Client headers have been sent optimistically */
4490       assert(csp->headers->last == NULL);
4491    }
4492    else if (http->ssl == 0 || (fwd->forward_host
4493 #ifdef FEATURE_HTTPS_INSPECTION
4494          && use_ssl_tunnel
4495 #endif
4496            ))
4497    {
4498       if (send_http_request(csp))
4499       {
4500          rsp = error_response(csp, "connect-failed");
4501          if (rsp)
4502          {
4503             send_crunch_response(csp, rsp);
4504          }
4505          return;
4506       }
4507    }
4508    else
4509    {
4510       /*
4511        * Using old solution with SSL tunnel or new solution with SSL proxy
4512        */
4513       list_remove_all(csp->headers);
4514 #ifdef FEATURE_HTTPS_INSPECTION
4515       if (use_ssl_tunnel)
4516 #endif
4517       {
4518          /*
4519          * We're running an SSL tunnel and we're not forwarding,
4520          * so just ditch the client headers, send the "connect succeeded"
4521          * message to the client, flush the rest, and get out of the way.
4522          */
4523          if (write_socket_delayed(csp->cfd, CSUCCEED,
4524                strlen(CSUCCEED), get_write_delay(csp)))
4525          {
4526             return;
4527          }
4528       }
4529 #ifdef FEATURE_HTTPS_INSPECTION
4530       else
4531       {
4532          /*
4533           * If server certificate has been verified and is invalid,
4534           * we must inform the client and then close the connection
4535           * with client and server.
4536           */
4537          if (csp->server_cert_verification_result != SSL_CERT_VALID &&
4538              csp->server_cert_verification_result != SSL_CERT_NOT_VERIFIED)
4539          {
4540             ssl_send_certificate_error(csp);
4541             close_client_and_server_ssl_connections(csp);
4542             return;
4543          }
4544          if (send_https_request(csp))
4545          {
4546             rsp = error_response(csp, "connect-failed");
4547             if (rsp)
4548             {
4549                send_crunch_response(csp, rsp);
4550             }
4551             close_client_and_server_ssl_connections(csp);
4552             return;
4553          }
4554       }
4555 #endif /* def FEATURE_HTTPS_INSPECTION */
4556       clear_iob(csp->client_iob);
4557    }/* -END- else ... if (http->ssl == 1) */
4558
4559    log_error(LOG_LEVEL_CONNECT, "to %s successful", http->hostport);
4560
4561    /* XXX: should the time start earlier for optimistically sent data? */
4562    csp->server_connection.request_sent = time(NULL);
4563
4564    handle_established_connection(csp);
4565    freez(csp->receive_buffer);
4566 }
4567
4568
4569 #ifdef FUZZ
4570 /*********************************************************************
4571  *
4572  * Function    :  fuzz_server_response
4573  *
4574  * Description :  Treat the input as a whole server response.
4575  *
4576  * Parameters  :
4577  *          1  :  csp = Current client state (buffers, headers, etc...)
4578  *          2  :  fuzz_input_file = File to read the input from.
4579  *
4580  * Returns     :  0
4581  *
4582  *********************************************************************/
4583 extern int fuzz_server_response(struct client_state *csp, char *fuzz_input_file)
4584 {
4585    static struct forward_spec fwd; /* Zero'd due to being static */
4586    csp->cfd = 0;
4587
4588    if (strcmp(fuzz_input_file, "-") == 0)
4589    {
4590       /* XXX: Doesn't work yet. */
4591       csp->server_connection.sfd = 0;
4592    }
4593    else
4594    {
4595       csp->server_connection.sfd = open(fuzz_input_file, O_RDONLY);
4596       if (csp->server_connection.sfd == -1)
4597       {
4598          log_error(LOG_LEVEL_FATAL, "Failed to open %s: %E",
4599             fuzz_input_file);
4600       }
4601    }
4602    csp->fwd = &fwd;
4603    csp->content_type |= CT_GIF;
4604    csp->action->flags |= ACTION_DEANIMATE;
4605    csp->action->string[ACTION_STRING_DEANIMATE] = "last";
4606
4607    csp->http->path = strdup_or_die("/");
4608    csp->http->host = strdup_or_die("fuzz.example.org");
4609    csp->http->hostport = strdup_or_die("fuzz.example.org:80");
4610    /* Prevent client socket monitoring */
4611    csp->flags |= CSP_FLAG_PIPELINED_REQUEST_WAITING;
4612    csp->flags |= CSP_FLAG_CHUNKED;
4613
4614    csp->config->feature_flags |= RUNTIME_FEATURE_CONNECTION_KEEP_ALIVE;
4615    csp->flags |= CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
4616
4617    csp->content_type |= CT_DECLARED|CT_GIF;
4618
4619    csp->config->socket_timeout = 0;
4620
4621    cgi_init_error_messages();
4622
4623    handle_established_connection(csp);
4624    freez(csp->receive_buffer);
4625
4626    return 0;
4627 }
4628 #endif
4629
4630
4631 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4632 /*********************************************************************
4633  *
4634  * Function    :  prepare_csp_for_next_request
4635  *
4636  * Description :  Put the csp in a mostly vergin state.
4637  *
4638  * Parameters  :
4639  *          1  :  csp = Current client state (buffers, headers, etc...)
4640  *
4641  * Returns     :  N/A
4642  *
4643  *********************************************************************/
4644 static void prepare_csp_for_next_request(struct client_state *csp)
4645 {
4646    csp->content_type = 0;
4647    csp->content_length = 0;
4648    csp->expected_content_length = 0;
4649    csp->expected_client_content_length = 0;
4650    list_remove_all(csp->headers);
4651    clear_iob(csp->iob);
4652    freez(csp->error_message);
4653    free_http_request(csp->http);
4654    destroy_list(csp->headers);
4655 #ifdef FEATURE_HTTPS_INSPECTION
4656    destroy_list(csp->https_headers);
4657 #endif
4658    destroy_list(csp->tags);
4659 #ifdef FEATURE_CLIENT_TAGS
4660    destroy_list(csp->client_tags);
4661    freez(csp->client_address);
4662 #endif
4663    free_current_action(csp->action);
4664    if (NULL != csp->fwd)
4665    {
4666       unload_forward_spec(csp->fwd);
4667       csp->fwd = NULL;
4668    }
4669    /* XXX: Store per-connection flags someplace else. */
4670    csp->flags = (CSP_FLAG_ACTIVE | CSP_FLAG_REUSED_CLIENT_CONNECTION);
4671 #ifdef FEATURE_TOGGLE
4672    if (global_toggle_state)
4673 #endif /* def FEATURE_TOGGLE */
4674    {
4675       csp->flags |= CSP_FLAG_TOGGLED_ON;
4676    }
4677
4678    if (csp->client_iob->eod > csp->client_iob->cur)
4679    {
4680       long bytes_to_shift = csp->client_iob->cur - csp->client_iob->buf;
4681       size_t data_length  = (size_t)(csp->client_iob->eod - csp->client_iob->cur);
4682
4683       assert(bytes_to_shift > 0);
4684       assert(data_length > 0);
4685
4686       log_error(LOG_LEVEL_CONNECT, "Shifting %lu pipelined bytes by %ld bytes",
4687          data_length, bytes_to_shift);
4688       memmove(csp->client_iob->buf, csp->client_iob->cur, data_length);
4689       csp->client_iob->cur = csp->client_iob->buf;
4690       assert(csp->client_iob->eod == csp->client_iob->buf + bytes_to_shift + data_length);
4691       csp->client_iob->eod = csp->client_iob->buf + data_length;
4692       memset(csp->client_iob->eod, '\0', (size_t)bytes_to_shift);
4693
4694       csp->flags |= CSP_FLAG_PIPELINED_REQUEST_WAITING;
4695    }
4696    else
4697    {
4698       /*
4699        * We mainly care about resetting client_iob->cur so we don't
4700        * waste buffer space at the beginning and don't mess up the
4701        * request restoration done by cgi_show_request().
4702        *
4703        * Freeing the buffer itself isn't technically necessary,
4704        * but makes debugging more convenient.
4705        */
4706       clear_iob(csp->client_iob);
4707    }
4708 }
4709 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4710
4711
4712 /*********************************************************************
4713  *
4714  * Function    :  serve
4715  *
4716  * Description :  This is little more than chat.  We only "serve" to
4717  *                to close (or remember) any socket that chat may have
4718  *                opened.
4719  *
4720  * Parameters  :
4721  *          1  :  csp = Current client state (buffers, headers, etc...)
4722  *
4723  * Returns     :  N/A
4724  *
4725  *********************************************************************/
4726 static void serve(struct client_state *csp)
4727 {
4728    int config_file_change_detected = 0; /* Only used for debugging */
4729 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4730 #ifdef FEATURE_CONNECTION_SHARING
4731    static int monitor_thread_running = 0;
4732 #endif /* def FEATURE_CONNECTION_SHARING */
4733    int continue_chatting = 0;
4734
4735    log_error(LOG_LEVEL_CONNECT, "Accepted connection from %s on socket %d",
4736       csp->ip_addr_str, csp->cfd);
4737
4738    do
4739    {
4740       unsigned int latency;
4741
4742 #ifdef FEATURE_HTTPS_INSPECTION
4743       if (continue_chatting && client_use_ssl(csp))
4744       {
4745          continue_https_chat(csp);
4746       }
4747       else
4748 #endif
4749       {
4750          chat(csp);
4751       }
4752
4753       /*
4754        * If the request has been crunched,
4755        * the calculated latency is zero.
4756        */
4757       latency = (unsigned)(csp->server_connection.response_received -
4758          csp->server_connection.request_sent) / 2;
4759
4760       if ((csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE)
4761          && (csp->flags & CSP_FLAG_CRUNCHED)
4762          && (csp->expected_client_content_length != 0))
4763       {
4764          csp->flags |= CSP_FLAG_SERVER_SOCKET_TAINTED;
4765          log_error(LOG_LEVEL_CONNECT,
4766             "Tainting client socket %d due to unread data.", csp->cfd);
4767       }
4768
4769       continue_chatting = (csp->config->feature_flags
4770          & RUNTIME_FEATURE_CONNECTION_KEEP_ALIVE)
4771          && !(csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED)
4772          && (csp->cfd != JB_INVALID_SOCKET)
4773          && (csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE)
4774          && ((csp->flags & CSP_FLAG_SERVER_CONTENT_LENGTH_SET)
4775             || (csp->flags & CSP_FLAG_CHUNKED));
4776
4777       if (!(csp->flags & CSP_FLAG_CRUNCHED)
4778          && (csp->server_connection.sfd != JB_INVALID_SOCKET))
4779       {
4780          if (!(csp->flags & CSP_FLAG_SERVER_KEEP_ALIVE_TIMEOUT_SET))
4781          {
4782             csp->server_connection.keep_alive_timeout = csp->config->default_server_timeout;
4783          }
4784          if (!(csp->flags & CSP_FLAG_SERVER_CONNECTION_KEEP_ALIVE)
4785             || (csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED)
4786             || !socket_is_still_alive(csp->server_connection.sfd)
4787             || !(latency < csp->server_connection.keep_alive_timeout))
4788          {
4789             log_error(LOG_LEVEL_CONNECT,
4790                "Closing server socket %d connected to %s. "
4791                "Keep-alive: %u. Tainted: %u. Socket alive: %u. Timeout: %u.",
4792                csp->server_connection.sfd, csp->server_connection.host,
4793                0 != (csp->flags & CSP_FLAG_SERVER_CONNECTION_KEEP_ALIVE),
4794                0 != (csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED),
4795                socket_is_still_alive(csp->server_connection.sfd),
4796                csp->server_connection.keep_alive_timeout);
4797 #ifdef FEATURE_CONNECTION_SHARING
4798             if (csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING)
4799             {
4800                forget_connection(csp->server_connection.sfd);
4801             }
4802 #endif /* def FEATURE_CONNECTION_SHARING */
4803 #ifdef FEATURE_HTTPS_INSPECTION
4804             close_server_ssl_connection(csp);
4805 #endif
4806             close_socket(csp->server_connection.sfd);
4807             mark_connection_closed(&csp->server_connection);
4808          }
4809       }
4810
4811       if (continue_chatting && any_loaded_file_changed(csp))
4812       {
4813          continue_chatting = 0;
4814          config_file_change_detected = 1;
4815       }
4816 #ifdef FEATURE_HTTPS_INSPECTION
4817       if (continue_chatting && client_use_ssl(csp) &&
4818          csp->ssl_with_client_is_opened == 0)
4819       {
4820          continue_chatting = 0;
4821          log_error(LOG_LEVEL_CONNECT, "Client socket %d is no longer usable. "
4822             "The TLS session has been terminated.", csp->cfd);
4823       }
4824 #endif
4825
4826       if (continue_chatting)
4827       {
4828          if (((csp->flags & CSP_FLAG_PIPELINED_REQUEST_WAITING) != 0)
4829             && socket_is_still_alive(csp->cfd))
4830          {
4831             log_error(LOG_LEVEL_CONNECT, "Client request %d has been "
4832                "pipelined on socket %d and the socket is still alive.",
4833                csp->requests_received_total+1, csp->cfd);
4834             prepare_csp_for_next_request(csp);
4835             continue;
4836          }
4837
4838          if (0 != (csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE))
4839          {
4840             if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4841             {
4842                log_error(LOG_LEVEL_CONNECT,
4843                   "Waiting for the next client request on socket %d. "
4844                   "Keeping the server socket %d to %s open.",
4845                   csp->cfd, csp->server_connection.sfd, csp->server_connection.host);
4846             }
4847             else
4848             {
4849                log_error(LOG_LEVEL_CONNECT,
4850                   "Waiting for the next client request on socket %d. "
4851                   "No server socket to keep open.", csp->cfd);
4852             }
4853          }
4854
4855          if ((csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE)
4856             && data_is_available(csp->cfd, (int)csp->config->keep_alive_timeout)
4857             && socket_is_still_alive(csp->cfd))
4858          {
4859             log_error(LOG_LEVEL_CONNECT,
4860                "Data arrived in time on client socket %d. Requests so far: %u",
4861                csp->cfd, csp->requests_received_total);
4862             prepare_csp_for_next_request(csp);
4863          }
4864          else
4865          {
4866 #ifdef FEATURE_CONNECTION_SHARING
4867             if ((csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING)
4868                && (csp->server_connection.sfd != JB_INVALID_SOCKET)
4869                && (socket_is_still_alive(csp->server_connection.sfd))
4870 #ifdef FEATURE_HTTPS_INSPECTION
4871                && !server_use_ssl(csp)
4872 #endif
4873                 )
4874             {
4875                time_t time_open = time(NULL) - csp->server_connection.timestamp;
4876
4877                if (csp->server_connection.keep_alive_timeout < time_open - (time_t)latency)
4878                {
4879                   break;
4880                }
4881
4882                remember_connection(&csp->server_connection);
4883                csp->server_connection.sfd = JB_INVALID_SOCKET;
4884                drain_and_close_socket(csp->cfd);
4885                csp->cfd = JB_INVALID_SOCKET;
4886                privoxy_mutex_lock(&connection_reuse_mutex);
4887                if (!monitor_thread_running)
4888                {
4889                   monitor_thread_running = 1;
4890                   privoxy_mutex_unlock(&connection_reuse_mutex);
4891                   wait_for_alive_connections();
4892                   privoxy_mutex_lock(&connection_reuse_mutex);
4893                   monitor_thread_running = 0;
4894                }
4895                privoxy_mutex_unlock(&connection_reuse_mutex);
4896             }
4897 #endif /* def FEATURE_CONNECTION_SHARING */
4898             break;
4899          }
4900       }
4901       else if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4902       {
4903          log_error(LOG_LEVEL_CONNECT,
4904             "Closing server socket %d connected to %s. Keep-alive: %u. "
4905             "Tainted: %u. Socket alive: %u. Timeout: %u. "
4906             "Configuration file change detected: %u",
4907             csp->server_connection.sfd, csp->server_connection.host,
4908             0 != (csp->flags & CSP_FLAG_SERVER_CONNECTION_KEEP_ALIVE),
4909             0 != (csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED),
4910             socket_is_still_alive(csp->server_connection.sfd),
4911             csp->server_connection.keep_alive_timeout,
4912             config_file_change_detected);
4913       }
4914    } while (continue_chatting);
4915
4916 #else
4917    chat(csp);
4918 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4919
4920    if (csp->cfd != JB_INVALID_SOCKET)
4921    {
4922       log_error(LOG_LEVEL_CONNECT, "Closing client socket %d. "
4923          "Keep-alive: %u. Socket alive: %u. Data available: %u. "
4924          "Configuration file change detected: %u. Requests received: %u.",
4925          csp->cfd, 0 != (csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE),
4926          socket_is_still_alive(csp->cfd), data_is_available(csp->cfd, 0),
4927          config_file_change_detected, csp->requests_received_total);
4928 #ifdef FEATURE_HTTPS_INSPECTION
4929       close_client_ssl_connection(csp);
4930 #endif
4931       drain_and_close_socket(csp->cfd);
4932    }
4933
4934    if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4935    {
4936 #ifdef FEATURE_CONNECTION_SHARING
4937       if (csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING)
4938       {
4939          forget_connection(csp->server_connection.sfd);
4940       }
4941 #endif /* def FEATURE_CONNECTION_SHARING */
4942
4943 #ifdef FEATURE_HTTPS_INSPECTION
4944       close_server_ssl_connection(csp);
4945 #endif /* def FEATURE_HTTPS_INSPECTION */
4946
4947       close_socket(csp->server_connection.sfd);
4948    }
4949
4950 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4951    mark_connection_closed(&csp->server_connection);
4952 #endif
4953
4954    free_csp_resources(csp);
4955
4956    csp->flags &= ~CSP_FLAG_ACTIVE;
4957
4958 }
4959
4960
4961 #ifdef __BEOS__
4962 /*********************************************************************
4963  *
4964  * Function    :  server_thread
4965  *
4966  * Description :  We only exist to call `serve' in a threaded environment.
4967  *
4968  * Parameters  :
4969  *          1  :  data = Current client state (buffers, headers, etc...)
4970  *
4971  * Returns     :  Always 0.
4972  *
4973  *********************************************************************/
4974 static int32 server_thread(void *data)
4975 {
4976    serve((struct client_state *) data);
4977    return 0;
4978
4979 }
4980 #endif
4981
4982
4983 #if !defined(_WIN32) || defined(_WIN_CONSOLE)
4984 /*********************************************************************
4985  *
4986  * Function    :  usage
4987  *
4988  * Description :  Print usage info & exit.
4989  *
4990  * Parameters  :  Pointer to argv[0] for identifying ourselves
4991  *
4992  * Returns     :  No. ,-)
4993  *
4994  *********************************************************************/
4995 static void usage(const char *name)
4996 {
4997    printf("Privoxy version " VERSION " (" HOME_PAGE_URL ")\n"
4998           "Usage: %s [--config-test] "
4999 #if defined(unix)
5000           "[--chroot] "
5001 #endif /* defined(unix) */
5002           "[--help] "
5003 #if defined(unix)
5004           "[--no-daemon] [--pidfile pidfile] [--pre-chroot-nslookup hostname] [--user user[.group]] "
5005 #endif /* defined(unix) */
5006          "[--version] [configfile]\n",
5007           name);
5008
5009 #ifdef FUZZ
5010    show_fuzz_usage(name);
5011 #endif
5012
5013    printf("Aborting\n");
5014
5015    exit(2);
5016
5017 }
5018 #endif /* #if !defined(_WIN32) || defined(_WIN_CONSOLE) */
5019
5020
5021 #ifdef MUTEX_LOCKS_AVAILABLE
5022 /*********************************************************************
5023  *
5024  * Function    :  privoxy_mutex_lock
5025  *
5026  * Description :  Locks a mutex.
5027  *
5028  * Parameters  :
5029  *          1  :  mutex = The mutex to lock.
5030  *
5031  * Returns     :  Void. May exit in case of errors.
5032  *
5033  *********************************************************************/
5034 void privoxy_mutex_lock(privoxy_mutex_t *mutex)
5035 {
5036 #ifdef FEATURE_PTHREAD
5037    int err = pthread_mutex_lock(mutex);
5038    if (err)
5039    {
5040       if (mutex != &log_mutex)
5041       {
5042          log_error(LOG_LEVEL_FATAL,
5043             "Mutex locking failed: %s.\n", strerror(err));
5044       }
5045       exit(1);
5046    }
5047 #else
5048    EnterCriticalSection(mutex);
5049 #endif /* def FEATURE_PTHREAD */
5050 }
5051
5052
5053 /*********************************************************************
5054  *
5055  * Function    :  privoxy_mutex_unlock
5056  *
5057  * Description :  Unlocks a mutex.
5058  *
5059  * Parameters  :
5060  *          1  :  mutex = The mutex to unlock.
5061  *
5062  * Returns     :  Void. May exit in case of errors.
5063  *
5064  *********************************************************************/
5065 void privoxy_mutex_unlock(privoxy_mutex_t *mutex)
5066 {
5067 #ifdef FEATURE_PTHREAD
5068    int err = pthread_mutex_unlock(mutex);
5069    if (err)
5070    {
5071       if (mutex != &log_mutex)
5072       {
5073          log_error(LOG_LEVEL_FATAL,
5074             "Mutex unlocking failed: %s.\n", strerror(err));
5075       }
5076       exit(1);
5077    }
5078 #else
5079    LeaveCriticalSection(mutex);
5080 #endif /* def FEATURE_PTHREAD */
5081 }
5082
5083
5084 /*********************************************************************
5085  *
5086  * Function    :  privoxy_mutex_init
5087  *
5088  * Description :  Prepares a mutex.
5089  *
5090  * Parameters  :
5091  *          1  :  mutex = The mutex to initialize.
5092  *
5093  * Returns     :  Void. May exit in case of errors.
5094  *
5095  *********************************************************************/
5096 static void privoxy_mutex_init(privoxy_mutex_t *mutex)
5097 {
5098 #ifdef FEATURE_PTHREAD
5099    int err = pthread_mutex_init(mutex, 0);
5100    if (err)
5101    {
5102       printf("Fatal error. Mutex initialization failed: %s.\n",
5103          strerror(err));
5104       exit(1);
5105    }
5106 #else
5107    InitializeCriticalSection(mutex);
5108 #endif /* def FEATURE_PTHREAD */
5109 }
5110 #endif /* def MUTEX_LOCKS_AVAILABLE */
5111
5112 /*********************************************************************
5113  *
5114  * Function    :  initialize_mutexes
5115  *
5116  * Description :  Prepares mutexes if mutex support is available.
5117  *
5118  * Parameters  :  None
5119  *
5120  * Returns     :  Void, exits in case of errors.
5121  *
5122  *********************************************************************/
5123 static void initialize_mutexes(void)
5124 {
5125 #ifdef MUTEX_LOCKS_AVAILABLE
5126    /*
5127     * Prepare global mutex semaphores
5128     */
5129
5130 #ifdef FEATURE_HTTPS_INSPECTION
5131    privoxy_mutex_init(&certificate_mutex);
5132    privoxy_mutex_init(&ssl_init_mutex);
5133 #endif
5134
5135    privoxy_mutex_init(&log_mutex);
5136    privoxy_mutex_init(&log_init_mutex);
5137    privoxy_mutex_init(&connection_reuse_mutex);
5138 #ifdef FEATURE_EXTERNAL_FILTERS
5139    privoxy_mutex_init(&external_filter_mutex);
5140 #endif
5141 #ifdef FEATURE_CLIENT_TAGS
5142    privoxy_mutex_init(&client_tags_mutex);
5143 #endif
5144 #ifdef FEATURE_EXTENDED_STATISTICS
5145    privoxy_mutex_init(&filter_statistics_mutex);
5146    privoxy_mutex_init(&block_statistics_mutex);
5147 #endif
5148
5149    /*
5150     * XXX: The assumptions below are a bit naive
5151     * and can cause locks that aren't necessary.
5152     *
5153     * For example older FreeBSD versions (< 6.x?)
5154     * have no gethostbyname_r, but gethostbyname is
5155     * thread safe.
5156     */
5157 #if !defined(HAVE_GETHOSTBYADDR_R) || !defined(HAVE_GETHOSTBYNAME_R)
5158    privoxy_mutex_init(&resolver_mutex);
5159 #endif /* !defined(HAVE_GETHOSTBYADDR_R) || !defined(HAVE_GETHOSTBYNAME_R) */
5160    /*
5161     * XXX: should we use a single mutex for
5162     * localtime() and gmtime() as well?
5163     */
5164 #ifndef HAVE_GMTIME_R
5165    privoxy_mutex_init(&gmtime_mutex);
5166 #endif /* ndef HAVE_GMTIME_R */
5167
5168 #ifndef HAVE_LOCALTIME_R
5169    privoxy_mutex_init(&localtime_mutex);
5170 #endif /* ndef HAVE_GMTIME_R */
5171
5172 #if !defined(HAVE_ARC4RANDOM) && !defined(HAVE_RANDOM)
5173    privoxy_mutex_init(&rand_mutex);
5174 #endif /* !defined(HAVE_ARC4RANDOM) && !defined(HAVE_RANDOM) */
5175
5176 #endif /* def MUTEX_LOCKS_AVAILABLE */
5177 }
5178
5179 /*********************************************************************
5180  *
5181  * Function    :  main
5182  *
5183  * Description :  Load the config file and start the listen loop.
5184  *                This function is a lot more *sane* with the `load_config'
5185  *                and `listen_loop' functions; although it stills does
5186  *                a *little* too much for my taste.
5187  *
5188  * Parameters  :
5189  *          1  :  argc = Number of parameters (including $0).
5190  *          2  :  argv = Array of (char *)'s to the parameters.
5191  *
5192  * Returns     :  1 if : can't open config file, unrecognized directive,
5193  *                stats requested in multi-thread mode, can't open the
5194  *                log file, can't open the jar file, listen port is invalid,
5195  *                any load fails, and can't bind port.
5196  *
5197  *                Else main never returns, the process must be signaled
5198  *                to terminate execution.  Or, on Windows, use the
5199  *                "File", "Exit" menu option.
5200  *
5201  *********************************************************************/
5202 #ifdef __MINGW32__
5203 int real_main(int argc, char **argv)
5204 #else
5205 int main(int argc, char **argv)
5206 #endif
5207 {
5208    int argc_pos = 0;
5209    int do_config_test = 0;
5210 #ifndef HAVE_ARC4RANDOM
5211    unsigned int random_seed;
5212 #endif
5213 #ifdef unix
5214    struct passwd *pw = NULL;
5215    struct group *grp = NULL;
5216    int do_chroot = 0;
5217    char *pre_chroot_nslookup_to_load_resolver = NULL;
5218 #endif
5219 #ifdef FUZZ
5220    char *fuzz_input_type = NULL;
5221    char *fuzz_input_file = NULL;
5222 #endif
5223
5224    Argc = argc;
5225    Argv = argv;
5226
5227    configfile =
5228 #if !defined(_WIN32)
5229    "config"
5230 #else
5231    "config.txt"
5232 #endif
5233       ;
5234
5235    /* Prepare mutexes if supported and necessary. */
5236    initialize_mutexes();
5237
5238    /* Enable logging until further notice. */
5239    init_log_module();
5240
5241    /*
5242     * Parse the command line arguments
5243     *
5244     * XXX: simply printing usage information in case of
5245     * invalid arguments isn't particularly user friendly.
5246     */
5247    while (++argc_pos < argc)
5248    {
5249 #ifdef _WIN32
5250       /* Check to see if the service must be installed or uninstalled */
5251       if (strncmp(argv[argc_pos], "--install", 9) == 0)
5252       {
5253          const char *pName = argv[argc_pos] + 9;
5254          if (*pName == ':')
5255             pName++;
5256          exit((install_service(pName)) ? 0 : 1);
5257       }
5258       else if (strncmp(argv[argc_pos], "--uninstall", 11) == 0)
5259       {
5260          const char *pName = argv[argc_pos] + 11;
5261          if (*pName == ':')
5262             pName++;
5263          exit((uninstall_service(pName)) ? 0 : 1);
5264       }
5265       else if (strcmp(argv[argc_pos], "--service") == 0)
5266       {
5267          bRunAsService = TRUE;
5268          w32_set_service_cwd();
5269          atexit(w32_service_exit_notify);
5270       }
5271       else
5272 #endif /* defined(_WIN32) */
5273
5274
5275 #if !defined(_WIN32) || defined(_WIN_CONSOLE)
5276
5277       if (strcmp(argv[argc_pos], "--help") == 0)
5278       {
5279          usage(argv[0]);
5280       }
5281
5282       else if (strcmp(argv[argc_pos], "--version") == 0)
5283       {
5284          printf("Privoxy version " VERSION " (" HOME_PAGE_URL ")\n");
5285          exit(0);
5286       }
5287
5288 #if defined(unix)
5289
5290       else if (strcmp(argv[argc_pos], "--no-daemon") == 0)
5291       {
5292          set_debug_level(LOG_LEVEL_FATAL | LOG_LEVEL_ERROR | LOG_LEVEL_INFO);
5293          daemon_mode = 0;
5294       }
5295
5296       else if (strcmp(argv[argc_pos], "--pidfile") == 0)
5297       {
5298          if (++argc_pos == argc) usage(argv[0]);
5299          pidfile = strdup_or_die(argv[argc_pos]);
5300       }
5301
5302       else if (strcmp(argv[argc_pos], "--user") == 0)
5303       {
5304          char *user_arg;
5305          char *group_name;
5306
5307          if (++argc_pos == argc) usage(argv[argc_pos]);
5308
5309          user_arg = strdup_or_die(argv[argc_pos]);
5310          group_name = strchr(user_arg, '.');
5311          if (NULL != group_name)
5312          {
5313             /* Nul-terminate the user name */
5314             *group_name = '\0';
5315
5316             /* Skip the former delimiter to actually reach the group name */
5317             group_name++;
5318
5319             grp = getgrnam(group_name);
5320             if (NULL == grp)
5321             {
5322                log_error(LOG_LEVEL_FATAL, "Group '%s' not found.", group_name);
5323             }
5324          }
5325          pw = getpwnam(user_arg);
5326          if (NULL == pw)
5327          {
5328             log_error(LOG_LEVEL_FATAL, "User '%s' not found.", user_arg);
5329          }
5330
5331          freez(user_arg);
5332       }
5333
5334       else if (strcmp(argv[argc_pos], "--pre-chroot-nslookup") == 0)
5335       {
5336          if (++argc_pos == argc) usage(argv[0]);
5337          pre_chroot_nslookup_to_load_resolver = strdup_or_die(argv[argc_pos]);
5338       }
5339
5340       else if (strcmp(argv[argc_pos], "--chroot") == 0)
5341       {
5342          do_chroot = 1;
5343       }
5344 #endif /* defined(unix) */
5345
5346       else if (strcmp(argv[argc_pos], "--config-test") == 0)
5347       {
5348          do_config_test = 1;
5349       }
5350 #ifdef FUZZ
5351       else if (strcmp(argv[argc_pos], "--fuzz") == 0)
5352       {
5353          argc_pos++;
5354          if (argc < argc_pos + 2) usage(argv[0]);
5355          fuzz_input_type = argv[argc_pos];
5356          argc_pos++;
5357          fuzz_input_file = argv[argc_pos];
5358       }
5359       else if (strcmp(argv[argc_pos], "--stfu") == 0)
5360       {
5361          set_debug_level(LOG_LEVEL_STFU);
5362       }
5363 #endif
5364       else if (argc_pos + 1 != argc)
5365       {
5366          /*
5367           * This is neither the last command line
5368           * option, nor was it recognized before,
5369           * therefore it must be invalid.
5370           */
5371          usage(argv[0]);
5372       }
5373       else
5374
5375 #endif /* defined(_WIN32) && !defined(_WIN_CONSOLE) */
5376       {
5377          configfile = argv[argc_pos];
5378       }
5379
5380    } /* -END- while (more arguments) */
5381
5382    show_version(Argv[0]);
5383
5384 #if defined(unix)
5385    if (*configfile != '/')
5386    {
5387       char cwd[BUFFER_SIZE];
5388       char *abs_file;
5389       size_t abs_file_size;
5390
5391       /* make config-filename absolute here */
5392       if (NULL == getcwd(cwd, sizeof(cwd)))
5393       {
5394          perror("failed to get current working directory");
5395          exit(1);
5396       }
5397
5398       basedir = strdup_or_die(cwd);
5399       /* XXX: why + 5? */
5400       abs_file_size = strlen(cwd) + strlen(configfile) + 5;
5401       abs_file = malloc_or_die(abs_file_size);
5402       strlcpy(abs_file, basedir, abs_file_size);
5403       strlcat(abs_file, "/", abs_file_size);
5404       strlcat(abs_file, configfile, abs_file_size);
5405       configfile = abs_file;
5406    }
5407 #endif /* defined unix */
5408
5409
5410    files->next = NULL;
5411    clients->next = NULL;
5412
5413    /* XXX: factor out initialising after the next stable release. */
5414 #ifdef _WIN32
5415    InitWin32();
5416 #endif
5417
5418 #ifndef HAVE_ARC4RANDOM
5419    random_seed = (unsigned int)time(NULL);
5420 #ifdef HAVE_RANDOM
5421    srandom(random_seed);
5422 #else
5423    srand(random_seed);
5424 #endif /* ifdef HAVE_RANDOM */
5425 #endif /* ifndef HAVE_ARC4RANDOM */
5426
5427    /*
5428     * Unix signal handling
5429     *
5430     * Catch the abort, interrupt and terminate signals for a graceful exit
5431     * Catch the hangup signal so the errlog can be reopened.
5432     *
5433     * Ignore the broken pipe signal as connection failures
5434     * are handled when and where they occur without relying
5435     * on a signal.
5436     */
5437 #if !defined(_WIN32)
5438 {
5439    int idx;
5440    const int catched_signals[] = { SIGTERM, SIGINT, SIGHUP };
5441
5442    for (idx = 0; idx < SZ(catched_signals); idx++)
5443    {
5444 #ifdef sun /* FIXME: Is it safe to check for HAVE_SIGSET instead? */
5445       if (sigset(catched_signals[idx], sig_handler) == SIG_ERR)
5446 #else
5447       if (signal(catched_signals[idx], sig_handler) == SIG_ERR)
5448 #endif /* ifdef sun */
5449       {
5450          log_error(LOG_LEVEL_FATAL, "Can't set signal-handler for signal %d: %E", catched_signals[idx]);
5451       }
5452    }
5453
5454    if (signal(SIGPIPE, SIG_IGN) == SIG_ERR)
5455    {
5456       log_error(LOG_LEVEL_FATAL, "Can't set ignore-handler for SIGPIPE: %E");
5457    }
5458
5459 }
5460 #else /* ifdef _WIN32 */
5461 # ifdef _WIN_CONSOLE
5462    /*
5463     * We *are* in a windows console app.
5464     * Print a verbose messages about FAQ's and such
5465     */
5466    printf("%s", win32_blurb);
5467 # endif /* def _WIN_CONSOLE */
5468 #endif /* def _WIN32 */
5469
5470 #ifdef FUZZ
5471    if (fuzz_input_type != NULL)
5472    {
5473       exit(process_fuzzed_input(fuzz_input_type, fuzz_input_file));
5474    }
5475    log_error(LOG_LEVEL_FATAL,
5476       "When compiled with fuzzing support, Privoxy should only be used for fuzzing. "
5477       "Various data structures are static which is unsafe when using threads.");
5478 #endif
5479
5480    if (do_config_test)
5481    {
5482       exit(NULL == load_config());
5483    }
5484
5485    /* Initialize the CGI subsystem */
5486    cgi_init_error_messages();
5487
5488    /*
5489     * If running on unix and without the --no-daemon
5490     * option, become a daemon. I.e. fork, detach
5491     * from tty and get process group leadership
5492     */
5493 #if defined(unix)
5494 {
5495    if (daemon_mode)
5496    {
5497       int fd;
5498       pid_t pid = fork();
5499
5500       if (pid < 0) /* error */
5501       {
5502          perror("fork");
5503          exit(3);
5504       }
5505       else if (pid != 0) /* parent */
5506       {
5507          int status;
5508          pid_t wpid;
5509          /*
5510           * must check for errors
5511           * child died due to missing files aso
5512           */
5513          sleep(1);
5514          wpid = waitpid(pid, &status, WNOHANG);
5515          if (wpid != 0)
5516          {
5517             exit(1);
5518          }
5519          exit(0);
5520       }
5521       /* child */
5522
5523       setsid();
5524
5525       /*
5526        * stderr (fd 2) will be closed later on,
5527        * when the config file has been parsed.
5528        */
5529       close(0);
5530       close(1);
5531
5532       /*
5533        * Reserve fd 0 and 1 to prevent abort() and friends
5534        * from sending stuff to the clients or servers.
5535        */
5536       fd = open("/dev/null", O_RDONLY);
5537       if (fd == -1)
5538       {
5539          log_error(LOG_LEVEL_FATAL, "Failed to open /dev/null: %E");
5540       }
5541       else if (fd != 0)
5542       {
5543          if (dup2(fd, 0) == -1)
5544          {
5545             log_error(LOG_LEVEL_FATAL, "Failed to reserve fd 0: %E");
5546          }
5547          close(fd);
5548       }
5549       fd = open("/dev/null", O_WRONLY);
5550       if (fd == -1)
5551       {
5552          log_error(LOG_LEVEL_FATAL, "Failed to open /dev/null: %E");
5553       }
5554       else if (fd != 1)
5555       {
5556          if (dup2(fd, 1) == -1)
5557          {
5558             log_error(LOG_LEVEL_FATAL, "Failed to reserve fd 1: %E");
5559          }
5560          close(fd);
5561       }
5562
5563 #ifdef FEATURE_EXTERNAL_FILTERS
5564       for (fd = 0; fd < 3; fd++)
5565       {
5566          mark_socket_for_close_on_execute(fd);
5567       }
5568 #endif
5569
5570       if (chdir("/") != 0)
5571       {
5572          log_error(LOG_LEVEL_FATAL, "Failed to cd into '/': %E");
5573       }
5574
5575    } /* -END- if (daemon_mode) */
5576
5577    /*
5578     * As soon as we have written the PID file, we can switch
5579     * to the user and group ID indicated by the --user option
5580     */
5581    if (pidfile != NULL)
5582    {
5583       write_pid_file(pidfile);
5584    }
5585    if (NULL != pw)
5586    {
5587       if (setgid((NULL != grp) ? grp->gr_gid : pw->pw_gid))
5588       {
5589          log_error(LOG_LEVEL_FATAL, "Cannot setgid(): Insufficient permissions.");
5590       }
5591       if (NULL != grp)
5592       {
5593          if (setgroups(1, &grp->gr_gid))
5594          {
5595             log_error(LOG_LEVEL_FATAL, "setgroups() failed: %E");
5596          }
5597       }
5598       else if (initgroups(pw->pw_name, pw->pw_gid))
5599       {
5600          log_error(LOG_LEVEL_FATAL, "initgroups() failed: %E");
5601       }
5602       if (do_chroot)
5603       {
5604          if (!pw->pw_dir)
5605          {
5606             log_error(LOG_LEVEL_FATAL, "Home directory for %s undefined", pw->pw_name);
5607          }
5608          /* Read the time zone file from /etc before doing chroot. */
5609          tzset();
5610          if (NULL != pre_chroot_nslookup_to_load_resolver
5611              && '\0' != pre_chroot_nslookup_to_load_resolver[0])
5612          {
5613             /* Initialize resolver library. */
5614             (void) resolve_hostname_to_ip(pre_chroot_nslookup_to_load_resolver);
5615          }
5616          if (chroot(pw->pw_dir) < 0)
5617          {
5618             log_error(LOG_LEVEL_FATAL, "Cannot chroot to %s", pw->pw_dir);
5619          }
5620          if (chdir ("/"))
5621          {
5622             log_error(LOG_LEVEL_FATAL, "Cannot chdir /");
5623          }
5624       }
5625       if (setuid(pw->pw_uid))
5626       {
5627          log_error(LOG_LEVEL_FATAL, "Cannot setuid(): Insufficient permissions.");
5628       }
5629       if (do_chroot)
5630       {
5631          char putenv_dummy[64];
5632
5633          strlcpy(putenv_dummy, "HOME=/", sizeof(putenv_dummy));
5634          if (putenv(putenv_dummy) != 0)
5635          {
5636             log_error(LOG_LEVEL_FATAL, "Cannot putenv(): HOME");
5637          }
5638
5639          snprintf(putenv_dummy, sizeof(putenv_dummy), "USER=%s", pw->pw_name);
5640          if (putenv(putenv_dummy) != 0)
5641          {
5642             log_error(LOG_LEVEL_FATAL, "Cannot putenv(): USER");
5643          }
5644       }
5645    }
5646    else if (do_chroot)
5647    {
5648       log_error(LOG_LEVEL_FATAL, "Cannot chroot without --user argument.");
5649    }
5650 }
5651 #endif /* defined unix */
5652
5653 #ifdef _WIN32
5654    /* This will be FALSE unless the command line specified --service
5655     */
5656    if (bRunAsService)
5657    {
5658       /* Yup, so now we must attempt to establish a connection
5659        * with the service dispatcher. This will only work if this
5660        * process was launched by the service control manager to
5661        * actually run as a service. If this isn't the case, i've
5662        * known it take around 30 seconds or so for the call to return.
5663        */
5664
5665       /* The StartServiceCtrlDispatcher won't return until the service is stopping */
5666       if (w32_start_service_ctrl_dispatcher(w32ServiceDispatchTable))
5667       {
5668          /* Service has run, and at this point is now being stopped, so just return */
5669          return 0;
5670       }
5671
5672 #ifdef _WIN_CONSOLE
5673       printf("Warning: Failed to connect to Service Control Dispatcher\nwhen starting as a service!\n");
5674 #endif
5675       /* An error occurred. Usually it's because --service was wrongly specified
5676        * and we were unable to connect to the Service Control Dispatcher because
5677        * it wasn't expecting us and is therefore not listening.
5678        *
5679        * For now, just continue below to call the listen_loop function.
5680        */
5681    }
5682 #endif /* def _WIN32 */
5683
5684    listen_loop();
5685
5686    /* NOTREACHED */
5687    return(-1);
5688
5689 }
5690
5691
5692 /*********************************************************************
5693  *
5694  * Function    :  bind_port_helper
5695  *
5696  * Description :  Bind the listen port.  Handles logging, and aborts
5697  *                on failure.
5698  *
5699  * Parameters  :
5700  *          1  :  haddr = Host address to bind to. Use NULL to bind to
5701  *                        INADDR_ANY.
5702  *          2  :  hport = Specifies port to bind to.
5703  *          3  :  backlog = Listen backlog.
5704  *
5705  * Returns     :  Port that was opened.
5706  *
5707  *********************************************************************/
5708 static jb_socket bind_port_helper(const char *haddr, int hport, int backlog)
5709 {
5710    int result;
5711    jb_socket bfd;
5712
5713    result = bind_port(haddr, hport, backlog, &bfd);
5714
5715    if (result < 0)
5716    {
5717       const char *bind_address = (NULL != haddr) ? haddr : "INADDR_ANY";
5718       switch(result)
5719       {
5720          case -3:
5721             log_error(LOG_LEVEL_FATAL,
5722                "can't bind to %s:%d: There may be another Privoxy "
5723                "or some other proxy running on port %d",
5724                bind_address, hport, hport);
5725
5726          case -2:
5727             log_error(LOG_LEVEL_FATAL,
5728                "can't bind to %s:%d: The hostname is not resolvable",
5729                bind_address, hport);
5730
5731          default:
5732             log_error(LOG_LEVEL_FATAL, "can't bind to %s:%d: %E",
5733                bind_address, hport);
5734       }
5735
5736       /* shouldn't get here */
5737       return JB_INVALID_SOCKET;
5738    }
5739
5740 #ifndef HAVE_POLL
5741 #ifndef _WIN32
5742    if (bfd >= FD_SETSIZE)
5743    {
5744       log_error(LOG_LEVEL_FATAL,
5745          "Bind socket number too high to use select(): %d >= %d",
5746          bfd, FD_SETSIZE);
5747    }
5748 #endif
5749 #endif
5750
5751    if (haddr == NULL)
5752    {
5753       log_error(LOG_LEVEL_INFO, "Listening on port %d on all IP addresses",
5754          hport);
5755    }
5756    else
5757    {
5758       log_error(LOG_LEVEL_INFO, "Listening on port %d on IP address %s",
5759          hport, haddr);
5760    }
5761
5762    return bfd;
5763 }
5764
5765
5766 /*********************************************************************
5767  *
5768  * Function    :  bind_ports_helper
5769  *
5770  * Description :  Bind the listen ports.  Handles logging, and aborts
5771  *                on failure.
5772  *
5773  * Parameters  :
5774  *          1  :  config = Privoxy configuration.  Specifies ports
5775  *                         to bind to.
5776  *          2  :  sockets = Preallocated array of opened sockets
5777  *                          corresponding to specification in config.
5778  *                          All non-opened sockets will be set to
5779  *                          JB_INVALID_SOCKET.
5780  *
5781  * Returns     :  Nothing. Inspect sockets argument.
5782  *
5783  *********************************************************************/
5784 static void bind_ports_helper(struct configuration_spec * config,
5785                               jb_socket sockets[])
5786 {
5787    int i;
5788
5789    for (i = 0; i < MAX_LISTENING_SOCKETS; i++)
5790    {
5791       if (config->hport[i])
5792       {
5793          sockets[i] = bind_port_helper(config->haddr[i],
5794             config->hport[i], config->listen_backlog);
5795 #if defined(FEATURE_ACCEPT_FILTER) && defined(SO_ACCEPTFILTER)
5796          if (config->enable_accept_filter && sockets[i] != JB_INVALID_SOCKET)
5797          {
5798             struct accept_filter_arg af_options;
5799             bzero(&af_options, sizeof(af_options));
5800             strlcpy(af_options.af_name, "httpready", sizeof(af_options.af_name));
5801             if (setsockopt(sockets[i], SOL_SOCKET, SO_ACCEPTFILTER, &af_options,
5802                   sizeof(af_options)))
5803             {
5804                log_error(LOG_LEVEL_ERROR,
5805                   "Enabling accept filter for socket %d failed: %E", sockets[i]);
5806             }
5807          }
5808 #endif
5809       }
5810       else
5811       {
5812          sockets[i] = JB_INVALID_SOCKET;
5813       }
5814    }
5815    config->need_bind = 0;
5816 }
5817
5818
5819 /*********************************************************************
5820  *
5821  * Function    :  close_ports_helper
5822  *
5823  * Description :  Close listenings ports.
5824  *
5825  * Parameters  :
5826  *          1  :  sockets = Array of opened and non-opened sockets to
5827  *                          close. All sockets will be set to
5828  *                          JB_INVALID_SOCKET.
5829  *
5830  * Returns     :  Nothing.
5831  *
5832  *********************************************************************/
5833 static void close_ports_helper(jb_socket sockets[])
5834 {
5835    int i;
5836
5837    for (i = 0; i < MAX_LISTENING_SOCKETS; i++)
5838    {
5839       if (JB_INVALID_SOCKET != sockets[i])
5840       {
5841          close_socket(sockets[i]);
5842       }
5843       sockets[i] = JB_INVALID_SOCKET;
5844    }
5845 }
5846
5847
5848 #ifdef _WIN32
5849 /* Without this simple workaround we get this compiler warning from _beginthread
5850  *     warning C4028: formal parameter 1 different from declaration
5851  */
5852 void w32_service_listen_loop(void *p)
5853 {
5854    listen_loop();
5855 }
5856 #endif /* def _WIN32 */
5857
5858
5859 /*********************************************************************
5860  *
5861  * Function    :  listen_loop
5862  *
5863  * Description :  bind the listen port and enter a "FOREVER" listening loop.
5864  *
5865  * Parameters  :  N/A
5866  *
5867  * Returns     :  Never.
5868  *
5869  *********************************************************************/
5870 static void listen_loop(void)
5871 {
5872    struct client_states *csp_list = NULL;
5873    struct client_state *csp = NULL;
5874    jb_socket bfds[MAX_LISTENING_SOCKETS];
5875    struct configuration_spec *config;
5876    unsigned int active_threads = 0;
5877 #if defined(FEATURE_PTHREAD)
5878    pthread_attr_t attrs;
5879
5880    pthread_attr_init(&attrs);
5881    pthread_attr_setdetachstate(&attrs, PTHREAD_CREATE_DETACHED);
5882 #endif
5883
5884    config = load_config();
5885
5886 #ifdef FEATURE_CONNECTION_SHARING
5887    /*
5888     * XXX: Should be relocated once it no
5889     * longer needs to emit log messages.
5890     */
5891    initialize_reusable_connections();
5892 #endif /* def FEATURE_CONNECTION_SHARING */
5893
5894    bind_ports_helper(config, bfds);
5895
5896 #ifdef FEATURE_GRACEFUL_TERMINATION
5897    while (!g_terminate)
5898 #else
5899    for (;;)
5900 #endif
5901    {
5902 #if !defined(FEATURE_PTHREAD) && !defined(_WIN32) && !defined(__BEOS__)
5903       while (waitpid(-1, NULL, WNOHANG) > 0)
5904       {
5905          /* zombie children */
5906       }
5907 #endif /* !defined(FEATURE_PTHREAD) && !defined(_WIN32) && !defined(__BEOS__) */
5908
5909       /*
5910        * Free data that was used by died threads
5911        */
5912       active_threads = sweep();
5913
5914 #if defined(unix)
5915       /*
5916        * Re-open the errlog after HUP signal
5917        */
5918       if (received_hup_signal)
5919       {
5920          if (NULL != config->logfile)
5921          {
5922             init_error_log(Argv[0], config->logfile);
5923          }
5924          received_hup_signal = 0;
5925       }
5926 #endif
5927
5928       csp_list = zalloc_or_die(sizeof(*csp_list));
5929       csp = &csp_list->csp;
5930
5931       log_error(LOG_LEVEL_CONNECT,
5932          "Waiting for the next client connection. Currently active threads: %u",
5933          active_threads);
5934
5935       /*
5936        * This config may be outdated, but for accept_connection()
5937        * it's fresh enough.
5938        */
5939       csp->config = config;
5940
5941       if (!accept_connection(csp, bfds))
5942       {
5943          log_error(LOG_LEVEL_CONNECT, "accept failed: %E");
5944          freez(csp_list);
5945          continue;
5946       }
5947
5948       csp->flags |= CSP_FLAG_ACTIVE;
5949       csp->server_connection.sfd = JB_INVALID_SOCKET;
5950
5951       csp->config = config = load_config();
5952
5953       if (config->need_bind)
5954       {
5955          /*
5956           * Since we were listening to the "old port", we will not see
5957           * a "listen" param change until the next request.  So, at
5958           * least 1 more request must be made for us to find the new
5959           * setting.  I am simply closing the old socket and binding the
5960           * new one.
5961           *
5962           * Which-ever is correct, we will serve 1 more page via the
5963           * old settings.  This should probably be a "show-status"
5964           * request.  This should not be a so common of an operation
5965           * that this will hurt people's feelings.
5966           */
5967
5968          close_ports_helper(bfds);
5969
5970          bind_ports_helper(config, bfds);
5971       }
5972
5973 #ifdef FEATURE_TOGGLE
5974       if (global_toggle_state)
5975 #endif /* def FEATURE_TOGGLE */
5976       {
5977          csp->flags |= CSP_FLAG_TOGGLED_ON;
5978       }
5979
5980       if (run_loader(csp))
5981       {
5982          log_error(LOG_LEVEL_FATAL, "a loader failed - must exit");
5983          /* Never get here - LOG_LEVEL_FATAL causes program exit */
5984       }
5985
5986 #ifdef FEATURE_ACL
5987       if (block_acl(NULL,csp))
5988       {
5989          log_error(LOG_LEVEL_CONNECT,
5990             "Connection from %s on %s (socket %d) dropped due to ACL",
5991             csp->ip_addr_str, csp->listen_addr_str, csp->cfd);
5992          close_socket(csp->cfd);
5993          freez(csp->ip_addr_str);
5994          freez(csp->listen_addr_str);
5995          freez(csp_list);
5996          continue;
5997       }
5998 #endif /* def FEATURE_ACL */
5999
6000       if ((0 != config->max_client_connections)
6001          && (active_threads >= config->max_client_connections))
6002       {
6003          log_error(LOG_LEVEL_CONNECT,
6004             "Rejecting connection from %s. Maximum number of connections reached.",
6005             csp->ip_addr_str);
6006          write_socket_delayed(csp->cfd, TOO_MANY_CONNECTIONS_RESPONSE,
6007             strlen(TOO_MANY_CONNECTIONS_RESPONSE), get_write_delay(csp));
6008          close_socket(csp->cfd);
6009          freez(csp->ip_addr_str);
6010          freez(csp->listen_addr_str);
6011          freez(csp_list);
6012          continue;
6013       }
6014
6015       /* add it to the list of clients */
6016       csp_list->next = clients->next;
6017       clients->next = csp_list;
6018
6019       if (config->multi_threaded)
6020       {
6021          int child_id;
6022
6023 /* this is a switch () statement in the C preprocessor - ugh */
6024 #undef SELECTED_ONE_OPTION
6025
6026 /* Use Pthreads in preference to native code */
6027 #if defined(FEATURE_PTHREAD) && !defined(SELECTED_ONE_OPTION)
6028 #define SELECTED_ONE_OPTION
6029          {
6030             pthread_t the_thread;
6031             int ret;
6032
6033             ret = pthread_create(&the_thread, &attrs,
6034                (void * (*)(void *))serve, csp);
6035             child_id = ret ? -1 : 0;
6036          }
6037 #endif
6038
6039 #if defined(_WIN32) && !defined(_CYGWIN) && !defined(SELECTED_ONE_OPTION)
6040 #define SELECTED_ONE_OPTION
6041          child_id = _beginthread(
6042             (void (*)(void *))serve,
6043             64 * 1024,
6044             csp);
6045 #endif
6046
6047 #if defined(__BEOS__) && !defined(SELECTED_ONE_OPTION)
6048 #define SELECTED_ONE_OPTION
6049          {
6050             thread_id tid = spawn_thread
6051                (server_thread, "server", B_NORMAL_PRIORITY, csp);
6052
6053             if ((tid >= 0) && (resume_thread(tid) == B_OK))
6054             {
6055                child_id = (int) tid;
6056             }
6057             else
6058             {
6059                child_id = -1;
6060             }
6061          }
6062 #endif
6063
6064 #if !defined(SELECTED_ONE_OPTION)
6065          child_id = fork();
6066
6067          /* This block is only needed when using fork().
6068           * When using threads, the server thread was
6069           * created and run by the call to _beginthread().
6070           */
6071          if (child_id == 0)   /* child */
6072          {
6073             int rc = 0;
6074 #ifdef FEATURE_TOGGLE
6075             int inherited_toggle_state = global_toggle_state;
6076 #endif /* def FEATURE_TOGGLE */
6077
6078             serve(csp);
6079
6080             /*
6081              * If we've been toggled or we've blocked the request, tell Mom
6082              */
6083
6084 #ifdef FEATURE_TOGGLE
6085             if (inherited_toggle_state != global_toggle_state)
6086             {
6087                rc |= RC_FLAG_TOGGLED;
6088             }
6089 #endif /* def FEATURE_TOGGLE */
6090
6091 #ifdef FEATURE_STATISTICS
6092             if (csp->flags & CSP_FLAG_REJECTED)
6093             {
6094                rc |= RC_FLAG_BLOCKED;
6095             }
6096 #endif /* ndef FEATURE_STATISTICS */
6097
6098             _exit(rc);
6099          }
6100          else if (child_id > 0) /* parent */
6101          {
6102             /* in a fork()'d environment, the parent's
6103              * copy of the client socket and the CSP
6104              * are not used.
6105              */
6106             int child_status;
6107 #if !defined(_WIN32) && !defined(__CYGWIN__)
6108
6109             wait(&child_status);
6110
6111             /*
6112              * Evaluate child's return code: If the child has
6113              *  - been toggled, toggle ourselves
6114              *  - blocked its request, bump up the stats counter
6115              */
6116
6117 #ifdef FEATURE_TOGGLE
6118             if (WIFEXITED(child_status) && (WEXITSTATUS(child_status) & RC_FLAG_TOGGLED))
6119             {
6120                global_toggle_state = !global_toggle_state;
6121             }
6122 #endif /* def FEATURE_TOGGLE */
6123
6124 #ifdef FEATURE_STATISTICS
6125             urls_read++;
6126             if (WIFEXITED(child_status) && (WEXITSTATUS(child_status) & RC_FLAG_BLOCKED))
6127             {
6128                urls_rejected++;
6129             }
6130 #endif /* def FEATURE_STATISTICS */
6131
6132 #endif /* !defined(_WIN32) && defined(__CYGWIN__) */
6133             close_socket(csp->cfd);
6134             csp->flags &= ~CSP_FLAG_ACTIVE;
6135          }
6136 #endif
6137
6138 #undef SELECTED_ONE_OPTION
6139 /* end of cpp switch () */
6140
6141          if (child_id < 0)
6142          {
6143             /*
6144              * Spawning the child failed, assume it's because
6145              * there are too many children running already.
6146              * XXX: If you assume ...
6147              */
6148             log_error(LOG_LEVEL_ERROR,
6149                "Unable to take any additional connections: %E. Active threads: %u",
6150                active_threads);
6151             write_socket_delayed(csp->cfd, TOO_MANY_CONNECTIONS_RESPONSE,
6152                strlen(TOO_MANY_CONNECTIONS_RESPONSE), get_write_delay(csp));
6153             close_socket(csp->cfd);
6154             csp->flags &= ~CSP_FLAG_ACTIVE;
6155          }
6156       }
6157       else
6158       {
6159          serve(csp);
6160       }
6161    }
6162
6163 #if defined(FEATURE_PTHREAD)
6164    pthread_attr_destroy(&attrs);
6165 #endif
6166
6167    /* NOTREACHED unless FEATURE_GRACEFUL_TERMINATION is defined */
6168
6169 #ifdef FEATURE_HTTPS_INSPECTION
6170    /* Clean up.  Aim: free all memory (no leaks) */
6171    ssl_release();
6172 #endif
6173
6174 #ifdef FEATURE_GRACEFUL_TERMINATION
6175
6176    log_error(LOG_LEVEL_INFO, "Graceful termination requested");
6177
6178    unload_current_config_file();
6179    unload_current_actions_file();
6180    unload_current_re_filterfile();
6181 #ifdef FEATURE_TRUST
6182    unload_current_trust_file();
6183 #endif
6184
6185    if (config->multi_threaded)
6186    {
6187       int i = 60;
6188       do
6189       {
6190          sleep(1);
6191          sweep();
6192       } while ((clients->next != NULL) && (--i > 0));
6193
6194       if (i <= 0)
6195       {
6196          log_error(LOG_LEVEL_ERROR, "Graceful termination failed - still some live clients after 1 minute wait.");
6197       }
6198    }
6199    sweep();
6200    sweep();
6201
6202 #if defined(unix)
6203    freez(basedir);
6204 #endif
6205
6206 #if defined(_WIN32) && !defined(_WIN_CONSOLE)
6207    /* Cleanup - remove taskbar icon etc. */
6208    TermLogWindow();
6209 #endif
6210
6211    exit(0);
6212 #endif /* FEATURE_GRACEFUL_TERMINATION */
6213
6214 }
6215
6216
6217 /*
6218   Local Variables:
6219   tab-width: 3
6220   end:
6221 */