process_encrypted_request(): Improve error message
[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       ssl_send_data_delayed(&(csp->ssl_client_attr),
2816          (const unsigned char *)MESSED_UP_REQUEST_RESPONSE,
2817          strlen(MESSED_UP_REQUEST_RESPONSE), get_write_delay(csp));
2818       log_error(LOG_LEVEL_ERROR,
2819          "Invalid request line after applying header filters.");
2820       /* XXX: Use correct size */
2821       log_error(LOG_LEVEL_CLF,
2822          "%s - - [%T] \"Invalid request generated\" 400 0", csp->ip_addr_str);
2823
2824       return JB_ERR_PARSE;
2825    }
2826
2827    log_error(LOG_LEVEL_HEADER, "Encrypted request processed");
2828    log_applied_actions(csp->action);
2829    log_error(LOG_LEVEL_REQUEST, "https://%s%s", csp->http->hostport,
2830       csp->http->path);
2831
2832    return err;
2833
2834 }
2835
2836 /*********************************************************************
2837  *
2838  * Function    :  cgi_page_requested
2839  *
2840  * Description :  Checks if a request is for an internal CGI page.
2841  *
2842  * Parameters  :
2843  *          1  :  host = The host requested by the client.
2844  *
2845  * Returns     :  1 if a CGI page has been requested, 0 otherwise
2846  *
2847  *********************************************************************/
2848 static int cgi_page_requested(const char *host)
2849 {
2850    if ((0 == strcmpic(host, CGI_SITE_1_HOST))
2851     || (0 == strcmpic(host, CGI_SITE_1_HOST "."))
2852     || (0 == strcmpic(host, CGI_SITE_2_HOST))
2853     || (0 == strcmpic(host, CGI_SITE_2_HOST ".")))
2854    {
2855       return 1;
2856    }
2857
2858    return 0;
2859
2860 }
2861
2862
2863 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
2864 /*********************************************************************
2865  *
2866  * Function    :  continue_https_chat
2867  *
2868  * Description :  Behaves similar to chat() but only deals with
2869  *                https-inspected requests that arrive on an already
2870  *                established connection. The first request is always
2871  *                served by chat() which is a lot more complex as it
2872  *                has to deal with forwarding settings and connection
2873  *                failures etc.
2874  *
2875  *                If a connection to the server has already been
2876  *                opened it is reused unless the request is blocked
2877  *                or the forwarder changed.
2878  *
2879  *                If a connection to the server has not yet been
2880  *                opened (because the previous request was crunched),
2881  *                or the forwarder changed, the connection is dropped
2882  *                so that the client retries on a fresh one.
2883  *
2884  * Parameters  :
2885  *          1  :  csp = Current client state (buffers, headers, etc...)
2886  *
2887  * Returns     :  Nothing.
2888  *
2889  *********************************************************************/
2890 static void continue_https_chat(struct client_state *csp)
2891 {
2892    const struct forward_spec *fwd;
2893
2894    if (JB_ERR_OK != process_encrypted_request(csp))
2895    {
2896       return;
2897    }
2898
2899    csp->requests_received_total++;
2900
2901    /*
2902     * We have an encrypted request. Check if one of the crunchers wants it.
2903     */
2904    if (crunch_response_triggered(csp, crunchers_all))
2905    {
2906       /*
2907        * Yes. The client got the crunch response and we're done here.
2908        */
2909       return;
2910    }
2911    if (csp->ssl_with_server_is_opened == 0)
2912    {
2913       log_error(LOG_LEVEL_CONNECT,
2914          "Dropping the client connection on socket %d. "
2915          "The server connection has not been established yet.",
2916          csp->cfd);
2917       csp->flags &= ~CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
2918       return;
2919    }
2920    assert(csp->server_connection.sfd != JB_INVALID_SOCKET);
2921
2922    fwd = forward_url(csp, csp->http);
2923    if (!connection_destination_matches(&csp->server_connection, csp->http, fwd))
2924    {
2925       log_error(LOG_LEVEL_CONNECT,
2926          "Dropping the client connection on socket %d with "
2927          "server socket %d connected to %s. The forwarder has changed.",
2928          csp->cfd, csp->server_connection.sfd, csp->server_connection.host);
2929       csp->flags &= ~CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
2930       return;
2931    }
2932
2933    log_error(LOG_LEVEL_CONNECT,
2934       "Reusing server socket %d connected to %s. Requests already sent: %u.",
2935       csp->server_connection.sfd, csp->server_connection.host,
2936       csp->server_connection.requests_sent_total);
2937
2938    if (send_https_request(csp))
2939    {
2940       /*
2941        * Most likely the server connection timed out. We can't easily
2942        * create a new one so simply drop the client connection without a
2943        * error response to let the client retry.
2944        */
2945       log_error(LOG_LEVEL_CONNECT,
2946          "Dropping client connection on socket %d. "
2947          "Forwarding the encrypted client request failed.",
2948          csp->cfd);
2949       return;
2950    }
2951    csp->server_connection.requests_sent_total++;
2952    handle_established_connection(csp);
2953    freez(csp->receive_buffer);
2954 }
2955 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
2956 #endif
2957
2958
2959 /*********************************************************************
2960  *
2961  * Function    :  handle_established_connection
2962  *
2963  * Description :  Shuffle data between client and server once the
2964  *                connection has been established.
2965  *
2966  * Parameters  :
2967  *          1  :  csp = Current client state (buffers, headers, etc...)
2968  *
2969  * Returns     :  Nothing.
2970  *
2971  *********************************************************************/
2972 static void handle_established_connection(struct client_state *csp)
2973 {
2974    char *hdr;
2975    char *p;
2976    int n;
2977 #ifdef HAVE_POLL
2978    struct pollfd poll_fds[2];
2979 #else
2980    fd_set rfds;
2981    jb_socket maxfd;
2982    struct timeval timeout;
2983 #endif
2984    int server_body;
2985    int ms_iis5_hack = 0;
2986    unsigned long long byte_count = 0;
2987    struct http_request *http;
2988    long len = 0; /* for buffer sizes (and negative error codes) */
2989    int buffer_and_filter_content = 0;
2990    unsigned int write_delay;
2991 #ifdef FEATURE_HTTPS_INSPECTION
2992    int ret = 0;
2993    int use_ssl_tunnel = 0;
2994    csp->dont_verify_certificate = 0;
2995
2996    if (csp->http->ssl && !(csp->action->flags & ACTION_HTTPS_INSPECTION))
2997    {
2998       /* Pass encrypted content without filtering. */
2999       use_ssl_tunnel = 1;
3000    }
3001 #endif
3002
3003    /* Skeleton for HTTP response, if we should intercept the request */
3004    struct http_response *rsp;
3005 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3006    int watch_client_socket;
3007 #endif
3008
3009    csp->receive_buffer_size = csp->config->receive_buffer_size;
3010    csp->receive_buffer = zalloc(csp->receive_buffer_size + 1);
3011    if (csp->receive_buffer == NULL)
3012    {
3013       log_error(LOG_LEVEL_ERROR,
3014          "Out of memory. Failed to allocate the receive buffer.");
3015       rsp = cgi_error_memory();
3016       send_crunch_response(csp, rsp);
3017       return;
3018    }
3019
3020    http = csp->http;
3021
3022 #ifndef HAVE_POLL
3023    maxfd = (csp->cfd > csp->server_connection.sfd) ?
3024       csp->cfd : csp->server_connection.sfd;
3025 #endif
3026
3027    /* pass data between the client and server
3028     * until one or the other shuts down the connection.
3029     */
3030
3031    server_body = 0;
3032
3033 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3034    watch_client_socket = 0 == (csp->flags & CSP_FLAG_PIPELINED_REQUEST_WAITING);
3035 #endif
3036    write_delay = get_write_delay(csp);
3037
3038    for (;;)
3039    {
3040 #ifndef HAVE_POLL
3041       FD_ZERO(&rfds);
3042 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3043       if (!watch_client_socket)
3044       {
3045          maxfd = csp->server_connection.sfd;
3046       }
3047       else
3048 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3049       {
3050          FD_SET(csp->cfd, &rfds);
3051       }
3052
3053       FD_SET(csp->server_connection.sfd, &rfds);
3054 #endif /* ndef HAVE_POLL */
3055
3056 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3057       if ((csp->flags & CSP_FLAG_CHUNKED)
3058          && !(csp->flags & CSP_FLAG_CONTENT_LENGTH_SET)
3059          && ((csp->iob->eod - csp->iob->cur) >= 5)
3060          && !memcmp(csp->iob->eod-5, "0\r\n\r\n", 5))
3061       {
3062          /*
3063           * XXX: This check should be obsolete now,
3064           *      but let's wait a while to be sure.
3065           */
3066          log_error(LOG_LEVEL_CONNECT,
3067             "Looks like we got the last chunk together with "
3068             "the server headers but didn't detect it earlier. "
3069             "We better stop reading.");
3070          byte_count = (unsigned long long)(csp->iob->eod - csp->iob->cur);
3071          csp->expected_content_length = byte_count;
3072          csp->flags |= CSP_FLAG_CONTENT_LENGTH_SET;
3073       }
3074       if (server_body && server_response_is_complete(csp, byte_count))
3075       {
3076          if (csp->expected_content_length == byte_count)
3077          {
3078             log_error(LOG_LEVEL_CONNECT,
3079                "Done reading from server. Content length: %llu as expected. "
3080                "Bytes most recently read: %ld.",
3081                byte_count, len);
3082          }
3083          else
3084          {
3085             log_error(LOG_LEVEL_CONNECT,
3086                "Done reading from server. Expected content length: %llu. "
3087                "Actual content length: %llu. Bytes most recently read: %ld.",
3088                csp->expected_content_length, byte_count, len);
3089          }
3090          len = 0;
3091          /*
3092           * XXX: Should not jump around, handle_established_connection()
3093           * is complicated enough already.
3094           */
3095          goto reading_done;
3096       }
3097 #endif  /* FEATURE_CONNECTION_KEEP_ALIVE */
3098
3099 #ifdef HAVE_POLL
3100       poll_fds[0].fd = csp->cfd;
3101 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3102       if (!watch_client_socket)
3103       {
3104          /*
3105           * Ignore incoming data, but still watch out
3106           * for disconnects etc. These flags are always
3107           * implied anyway but explicitly setting them
3108           * doesn't hurt.
3109           */
3110          poll_fds[0].events = POLLERR|POLLHUP;
3111       }
3112       else
3113 #endif
3114       {
3115          poll_fds[0].events = POLLIN;
3116       }
3117       poll_fds[1].fd = csp->server_connection.sfd;
3118       poll_fds[1].events = POLLIN;
3119       n = poll(poll_fds, 2, csp->config->socket_timeout * 1000);
3120 #else
3121       timeout.tv_sec = csp->config->socket_timeout;
3122       timeout.tv_usec = 0;
3123       n = select((int)maxfd + 1, &rfds, NULL, NULL, &timeout);
3124 #endif /* def HAVE_POLL */
3125
3126       /*server or client not responding in timeout */
3127       if (n == 0)
3128       {
3129          log_error(LOG_LEVEL_CONNECT, "Socket timeout %d reached: %s",
3130             csp->config->socket_timeout, http->url);
3131          if ((byte_count == 0) && (http->ssl == 0))
3132          {
3133             send_crunch_response(csp, error_response(csp, "connection-timeout"));
3134          }
3135          mark_server_socket_tainted(csp);
3136 #ifdef FEATURE_HTTPS_INSPECTION
3137          close_client_and_server_ssl_connections(csp);
3138 #endif
3139          return;
3140       }
3141       else if (n < 0)
3142       {
3143 #ifdef HAVE_POLL
3144          log_error(LOG_LEVEL_ERROR, "poll() failed!: %E");
3145 #else
3146          log_error(LOG_LEVEL_ERROR, "select() failed!: %E");
3147 #endif
3148          mark_server_socket_tainted(csp);
3149 #ifdef FEATURE_HTTPS_INSPECTION
3150          close_client_and_server_ssl_connections(csp);
3151 #endif
3152          return;
3153       }
3154
3155       /*
3156        * This is the body of the browser's request,
3157        * just read and write it.
3158        *
3159        * Receives data from browser and sends it to server
3160        *
3161        * XXX: Make sure the client doesn't use pipelining
3162        * behind Privoxy's back.
3163        */
3164 #ifdef HAVE_POLL
3165       if ((poll_fds[0].revents & (POLLERR|POLLHUP|POLLNVAL)) != 0)
3166       {
3167          log_error(LOG_LEVEL_CONNECT,
3168             "The client socket %d has become unusable while "
3169             "the server socket %d is still open.",
3170             csp->cfd, csp->server_connection.sfd);
3171          mark_server_socket_tainted(csp);
3172          break;
3173       }
3174
3175       if (poll_fds[0].revents != 0)
3176 #else
3177       if (FD_ISSET(csp->cfd, &rfds))
3178 #endif /* def HAVE_POLL*/
3179       {
3180          int max_bytes_to_read = (int)csp->receive_buffer_size;
3181
3182 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3183          if ((csp->flags & CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ))
3184          {
3185             if (data_is_available(csp->cfd, 0))
3186             {
3187                /*
3188                 * If the next request is already waiting, we have
3189                 * to stop select()ing the client socket. Otherwise
3190                 * we would always return right away and get nothing
3191                 * else done.
3192                 */
3193                watch_client_socket = 0;
3194                log_error(LOG_LEVEL_CONNECT,
3195                   "Stop watching client socket %d. "
3196                   "There's already another request waiting.",
3197                   csp->cfd);
3198                continue;
3199             }
3200             /*
3201              * If the client socket is set, but there's no data
3202              * available on the socket, the client went fishing
3203              * and continuing talking to the server makes no sense.
3204              */
3205             log_error(LOG_LEVEL_CONNECT,
3206                "The client closed socket %d while "
3207                "the server socket %d is still open.",
3208                csp->cfd, csp->server_connection.sfd);
3209             mark_server_socket_tainted(csp);
3210             break;
3211          }
3212          if (csp->expected_client_content_length != 0)
3213          {
3214             if (csp->expected_client_content_length < csp->receive_buffer_size)
3215             {
3216                max_bytes_to_read = (int)csp->expected_client_content_length;
3217             }
3218             log_error(LOG_LEVEL_CONNECT,
3219                "Waiting for up to %d bytes from the client.",
3220                max_bytes_to_read);
3221          }
3222          assert(max_bytes_to_read <= csp->receive_buffer_size);
3223 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3224
3225 #ifdef FEATURE_HTTPS_INSPECTION
3226          if (client_use_ssl(csp))
3227          {
3228             if (csp->http->status == 101)
3229             {
3230                len = ssl_recv_data(&(csp->ssl_client_attr),
3231                   (unsigned char *)csp->receive_buffer,
3232                   (size_t)max_bytes_to_read);
3233                if (len == -1)
3234                {
3235                   log_error(LOG_LEVEL_ERROR, "Failed to receive data "
3236                      "on client socket %d for an upgraded connection",
3237                      csp->cfd);
3238                   break;
3239                }
3240                if (len == 0)
3241                {
3242                   log_error(LOG_LEVEL_CONNECT, "Done receiving data "
3243                      "on client socket %d for an upgraded connection",
3244                      csp->cfd);
3245                   break;
3246                }
3247                byte_count += (unsigned long long)len;
3248                len = ssl_send_data(&(csp->ssl_server_attr),
3249                   (unsigned char *)csp->receive_buffer, (size_t)len);
3250                if (len == -1)
3251                {
3252                   log_error(LOG_LEVEL_ERROR, "Failed to send data "
3253                      "on server socket %d for an upgraded connection",
3254                      csp->server_connection.sfd);
3255                   break;
3256                }
3257                continue;
3258             }
3259             log_error(LOG_LEVEL_CONNECT, "Breaking with TLS/SSL.");
3260             break;
3261          }
3262          else
3263 #endif /* def FEATURE_HTTPS_INSPECTION */
3264          {
3265             len = read_socket(csp->cfd, csp->receive_buffer, max_bytes_to_read);
3266
3267             if (len <= 0)
3268             {
3269                /* XXX: not sure if this is necessary. */
3270                mark_server_socket_tainted(csp);
3271                break; /* "game over, man" */
3272             }
3273
3274 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3275             if (csp->expected_client_content_length != 0)
3276             {
3277                assert(len <= max_bytes_to_read);
3278                csp->expected_client_content_length -= (unsigned)len;
3279                log_error(LOG_LEVEL_CONNECT,
3280                   "Expected client content length set to %llu "
3281                   "after reading %ld bytes.",
3282                   csp->expected_client_content_length, len);
3283                if (csp->expected_client_content_length == 0)
3284                {
3285                   log_error(LOG_LEVEL_CONNECT,
3286                      "Done reading from the client.");
3287                   csp->flags |= CSP_FLAG_CLIENT_REQUEST_COMPLETELY_READ;
3288                }
3289             }
3290 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3291
3292             if (write_socket(csp->server_connection.sfd, csp->receive_buffer, (size_t)len))
3293             {
3294                log_error(LOG_LEVEL_ERROR, "write to: %s failed: %E", http->host);
3295                mark_server_socket_tainted(csp);
3296                return;
3297             }
3298          }
3299          continue;
3300       }
3301
3302       /*
3303        * The server wants to talk. It could be the header or the body.
3304        * If `hdr' is null, then it's the header otherwise it's the body.
3305        * FIXME: Does `hdr' really mean `host'? No.
3306        */
3307 #ifdef HAVE_POLL
3308       if (poll_fds[1].revents != 0)
3309 #else
3310       if (FD_ISSET(csp->server_connection.sfd, &rfds))
3311 #endif /* HAVE_POLL */
3312       {
3313 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3314          /*
3315           * If we are buffering content, we don't want to eat up to
3316           * buffer-limit bytes if the client no longer cares about them.
3317           * If we aren't buffering, however, a dead client socket will be
3318           * noticed pretty much right away anyway, so we can reduce the
3319           * overhead by skipping the check.
3320           */
3321          if (buffer_and_filter_content && !socket_is_still_alive(csp->cfd))
3322          {
3323 #ifdef _WIN32
3324             log_error(LOG_LEVEL_CONNECT,
3325                "The server still wants to talk, but the client may already have hung up on us.");
3326 #else
3327             log_error(LOG_LEVEL_CONNECT,
3328                "The server still wants to talk, but the client hung up on us.");
3329             mark_server_socket_tainted(csp);
3330 #ifdef FEATURE_HTTPS_INSPECTION
3331             close_client_and_server_ssl_connections(csp);
3332 #endif
3333             return;
3334 #endif /* def _WIN32 */
3335          }
3336 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
3337
3338 #ifdef FEATURE_HTTPS_INSPECTION
3339          /*
3340           * Reading data from standard or secured connection (HTTP/HTTPS)
3341           */
3342          if (server_use_ssl(csp))
3343          {
3344             len = ssl_recv_data(&(csp->ssl_server_attr),
3345                (unsigned char *)csp->receive_buffer, csp->receive_buffer_size);
3346          }
3347          else
3348 #endif
3349          {
3350             len = read_socket(csp->server_connection.sfd, csp->receive_buffer,
3351                (int)csp->receive_buffer_size);
3352          }
3353
3354          if (len < 0)
3355          {
3356             log_error(LOG_LEVEL_ERROR, "read from: %s failed: %E", http->host);
3357
3358             if ((http->ssl && (csp->fwd == NULL))
3359 #ifdef FEATURE_HTTPS_INSPECTION
3360                && use_ssl_tunnel
3361 #endif
3362                 )
3363             {
3364                /*
3365                 * Just hang up. We already confirmed the client's CONNECT
3366                 * request with status code 200 and unencrypted content is
3367                 * no longer welcome.
3368                 */
3369                log_error(LOG_LEVEL_ERROR,
3370                   "CONNECT already confirmed. Unable to tell the client about the problem.");
3371                return;
3372             }
3373             else if (byte_count)
3374             {
3375                /*
3376                 * Just hang up. We already transmitted the original headers
3377                 * and parts of the original content and therefore missed the
3378                 * chance to send an error message (without risking data corruption).
3379                 *
3380                 * XXX: we could retry with a fancy range request here.
3381                 */
3382                log_error(LOG_LEVEL_ERROR, "Already forwarded the original headers. "
3383                   "Unable to tell the client about the problem.");
3384                mark_server_socket_tainted(csp);
3385 #ifdef FEATURE_HTTPS_INSPECTION
3386                close_client_and_server_ssl_connections(csp);
3387 #endif
3388                return;
3389             }
3390             /*
3391              * XXX: Consider handling the cases above the same.
3392              */
3393             mark_server_socket_tainted(csp);
3394             len = 0;
3395          }
3396
3397 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
3398          if (csp->flags & CSP_FLAG_CHUNKED)
3399          {
3400             if ((len >= 5) && !memcmp(csp->receive_buffer+len-5, "0\r\n\r\n", 5))
3401             {
3402                /* XXX: this is a temporary hack */
3403                log_error(LOG_LEVEL_CONNECT,
3404                   "Looks like we reached the end of the last chunk. "
3405                   "We better stop reading.");
3406                csp->expected_content_length = byte_count + (unsigned long long)len;
3407                csp->flags |= CSP_FLAG_CONTENT_LENGTH_SET;
3408             }
3409          }
3410          reading_done:
3411 #endif  /* FEATURE_CONNECTION_KEEP_ALIVE */
3412
3413          /*
3414           * This is guaranteed by allocating with zalloc_or_die()
3415           * and never (intentionally) writing to the last byte.
3416           *
3417           * csp->receive_buffer_size is the size of the part of the
3418           * buffer we intentionally write to, but we actually
3419           * allocated csp->receive_buffer_size+1 bytes so the assertion
3420           * stays within the allocated range.
3421           */
3422          assert(csp->receive_buffer[csp->receive_buffer_size] == '\0');
3423
3424          /*
3425           * Add a trailing zero to let be able to use string operations.
3426           * XXX: do we still need this with filter_popups gone?
3427           */
3428          assert(len <= csp->receive_buffer_size);
3429          csp->receive_buffer[len] = '\0';
3430
3431          /*
3432           * Normally, this would indicate that we've read
3433           * as much as the server has sent us and we can
3434           * close the client connection.  However, Microsoft
3435           * in its wisdom has released IIS/5 with a bug that
3436           * prevents it from sending the trailing \r\n in
3437           * a 302 redirect header (and possibly other headers).
3438           * To work around this if we've haven't parsed
3439           * a full header we'll append a trailing \r\n
3440           * and see if this now generates a valid one.
3441           *
3442           * This hack shouldn't have any impacts.  If we've
3443           * already transmitted the header or if this is a
3444           * SSL connection, then we won't bother with this
3445           * hack.  So we only work on partially received
3446           * headers.  If we append a \r\n and this still
3447           * doesn't generate a valid header, then we won't
3448           * transmit anything to the client.
3449           */
3450          if (len == 0)
3451          {
3452
3453             if (server_body || (http->ssl
3454 #ifdef FEATURE_HTTPS_INSPECTION
3455                   && use_ssl_tunnel
3456 #endif
3457                ))
3458             {
3459                /*
3460                 * If we have been buffering up the document,
3461                 * now is the time to apply content modification
3462                 * and send the result to the client.
3463                 */
3464                if (buffer_and_filter_content)
3465                {
3466                   p = execute_content_filters(csp);
3467                   /*
3468                    * If content filtering fails, use the original
3469                    * buffer and length.
3470                    * (see p != NULL ? p : csp->iob->cur below)
3471                    */
3472                   if (NULL == p)
3473                   {
3474                      csp->content_length = (size_t)(csp->iob->eod - csp->iob->cur);
3475                   }
3476 #ifdef FEATURE_COMPRESSION
3477                   else if ((csp->flags & CSP_FLAG_CLIENT_SUPPORTS_DEFLATE)
3478                      && (csp->content_length > LOWER_LENGTH_LIMIT_FOR_COMPRESSION))
3479                   {
3480                      char *compressed_content = compress_buffer(p,
3481                         (size_t *)&csp->content_length, csp->config->compression_level);
3482                      if (compressed_content != NULL)
3483                      {
3484                         freez(p);
3485                         p = compressed_content;
3486                         csp->flags |= CSP_FLAG_BUFFERED_CONTENT_DEFLATED;
3487                      }
3488                   }
3489 #endif
3490
3491                   if (JB_ERR_OK != update_server_headers(csp))
3492                   {
3493                      log_error(LOG_LEVEL_FATAL,
3494                         "Failed to update server headers. after filtering.");
3495                   }
3496
3497                   hdr = list_to_text(csp->headers);
3498                   if (hdr == NULL)
3499                   {
3500                      /* FIXME Should handle error properly */
3501                      log_error(LOG_LEVEL_FATAL, "Out of memory parsing server header");
3502                   }
3503
3504 #ifdef FEATURE_HTTPS_INSPECTION
3505                   /*
3506                    * Sending data with standard or secured connection (HTTP/HTTPS)
3507                    */
3508                   if (client_use_ssl(csp))
3509                   {
3510                      if ((ssl_send_data_delayed(&(csp->ssl_client_attr),
3511                               (const unsigned char *)hdr, strlen(hdr),
3512                               get_write_delay(csp)) < 0)
3513                         || (ssl_send_data_delayed(&(csp->ssl_client_attr),
3514                               (const unsigned char *) ((p != NULL) ? p : csp->iob->cur),
3515                               csp->content_length, get_write_delay(csp)) < 0))
3516                      {
3517                         log_error(LOG_LEVEL_ERROR, "write modified content to "
3518                            "client over TLS/SSL failed");
3519                         freez(hdr);
3520                         freez(p);
3521                         mark_server_socket_tainted(csp);
3522                         close_client_and_server_ssl_connections(csp);
3523                         return;
3524                      }
3525                   }
3526                   else
3527 #endif /* def FEATURE_HTTPS_INSPECTION */
3528                   {
3529                      if (write_socket_delayed(csp->cfd, hdr, strlen(hdr), write_delay)
3530                       || write_socket_delayed(csp->cfd, ((p != NULL) ? p : csp->iob->cur),
3531                          (size_t)csp->content_length, write_delay))
3532                      {
3533                         log_error(LOG_LEVEL_ERROR, "write modified content to client failed: %E");
3534                         freez(hdr);
3535                         freez(p);
3536                         mark_server_socket_tainted(csp);
3537                         return;
3538                      }
3539                   }
3540
3541                   freez(hdr);
3542                   freez(p);
3543                }
3544
3545                break; /* "game over, man" */
3546             }
3547
3548             /*
3549              * This is NOT the body, so
3550              * Let's pretend the server just sent us a blank line.
3551              */
3552             snprintf(csp->receive_buffer, csp->receive_buffer_size, "\r\n");
3553             len = (int)strlen(csp->receive_buffer);
3554
3555             /*
3556              * Now, let the normal header parsing algorithm below do its
3557              * job.  If it fails, we'll exit instead of continuing.
3558              */
3559
3560             ms_iis5_hack = 1;
3561          }
3562
3563          /*
3564           * If we're in the body of the server document, just write it to
3565           * the client, unless we need to buffer the body for later
3566           * content-filtering.
3567           */
3568          if (server_body || (http->ssl
3569 #ifdef FEATURE_HTTPS_INSPECTION
3570                && use_ssl_tunnel
3571 #endif
3572             ))
3573          {
3574             if (buffer_and_filter_content)
3575             {
3576                /*
3577                 * If there is no memory left for buffering the content, or the buffer limit
3578                 * has been reached, switch to non-filtering mode, i.e. make & write the
3579                 * header, flush the iob and buf, and get out of the way.
3580                 */
3581                if (add_to_iob(csp->iob, csp->config->buffer_limit, csp->receive_buffer, len))
3582                {
3583                   size_t hdrlen;
3584                   long flushed;
3585
3586                   log_error(LOG_LEVEL_INFO,
3587                      "Flushing header and buffers. Stepping back from filtering.");
3588
3589                   hdr = list_to_text(csp->headers);
3590                   if (hdr == NULL)
3591                   {
3592                      /*
3593                       * Memory is too tight to even generate the header.
3594                       * Send our static "Out-of-memory" page.
3595                       */
3596                      log_error(LOG_LEVEL_ERROR, "Out of memory while trying to flush.");
3597                      rsp = cgi_error_memory();
3598                      send_crunch_response(csp, rsp);
3599                      mark_server_socket_tainted(csp);
3600 #ifdef FEATURE_HTTPS_INSPECTION
3601                      close_client_and_server_ssl_connections(csp);
3602 #endif
3603                      return;
3604                   }
3605                   hdrlen = strlen(hdr);
3606
3607 #ifdef FEATURE_HTTPS_INSPECTION
3608                   /*
3609                    * Sending data with standard or secured connection (HTTP/HTTPS)
3610                    */
3611                   if (client_use_ssl(csp))
3612                   {
3613                      if ((ssl_send_data_delayed(&(csp->ssl_client_attr),
3614                              (const unsigned char *)hdr, hdrlen, get_write_delay(csp)) < 0)
3615                         || ((flushed = ssl_flush_socket(&(csp->ssl_client_attr),
3616                                 csp->iob)) < 0)
3617                         || (ssl_send_data_delayed(&(csp->ssl_client_attr),
3618                               (const unsigned char *)csp->receive_buffer, (size_t)len,
3619                               get_write_delay(csp)) < 0))
3620                      {
3621                         log_error(LOG_LEVEL_CONNECT,
3622                            "Flush header and buffers to client failed");
3623                         freez(hdr);
3624                         mark_server_socket_tainted(csp);
3625                         close_client_and_server_ssl_connections(csp);
3626                         return;
3627                      }
3628                   }
3629                   else
3630 #endif /* def FEATURE_HTTPS_INSPECTION */
3631                   {
3632                      if (write_socket_delayed(csp->cfd, hdr, hdrlen, write_delay)
3633                       || ((flushed = flush_iob(csp->cfd, csp->iob, write_delay)) < 0)
3634                       || write_socket_delayed(csp->cfd, csp->receive_buffer, (size_t)len,
3635                             write_delay))
3636                      {
3637                         log_error(LOG_LEVEL_CONNECT,
3638                            "Flush header and buffers to client failed: %E");
3639                         freez(hdr);
3640                         mark_server_socket_tainted(csp);
3641                         return;
3642                      }
3643                   }
3644
3645                   /*
3646                    * Reset the byte_count to the amount of bytes
3647                    * we just flushed. len will be added a few lines below,
3648                    * hdrlen doesn't matter for LOG_LEVEL_CLF.
3649                    */
3650                   byte_count = (unsigned long long)flushed;
3651                   freez(hdr);
3652                   buffer_and_filter_content = 0;
3653                   server_body = 1;
3654                }
3655             }
3656             else
3657             {
3658 #ifdef FEATURE_HTTPS_INSPECTION
3659                /*
3660                 * Sending data with standard or secured connection (HTTP/HTTPS)
3661                 */
3662                if (client_use_ssl(csp))
3663                {
3664                   ret = ssl_send_data_delayed(&(csp->ssl_client_attr),
3665                      (const unsigned char *)csp->receive_buffer, (size_t)len,
3666                      get_write_delay(csp));
3667                   if (ret < 0)
3668                   {
3669                      log_error(LOG_LEVEL_ERROR,
3670                         "Sending data to client failed");
3671                      mark_server_socket_tainted(csp);
3672                      close_client_and_server_ssl_connections(csp);
3673                      return;
3674                   }
3675                }
3676                else
3677 #endif /* def FEATURE_HTTPS_INSPECTION */
3678                {
3679                   if (write_socket_delayed(csp->cfd, csp->receive_buffer,
3680                         (size_t)len, write_delay))
3681                   {
3682                      log_error(LOG_LEVEL_ERROR, "write to client failed: %E");
3683                      mark_server_socket_tainted(csp);
3684                      return;
3685                   }
3686                }
3687             }
3688             byte_count += (unsigned long long)len;
3689             continue;
3690          }
3691          else
3692          {
3693             /*
3694              * We're still looking for the end of the server's header.
3695              * Buffer up the data we just read.  If that fails, there's
3696              * little we can do but send our static out-of-memory page.
3697              */
3698             if (add_to_iob(csp->iob, csp->config->buffer_limit, csp->receive_buffer, len))
3699             {
3700                log_error(LOG_LEVEL_ERROR, "Out of memory while looking for end of server headers.");
3701                rsp = cgi_error_memory();
3702                send_crunch_response(csp, rsp);
3703                mark_server_socket_tainted(csp);
3704 #ifdef FEATURE_HTTPS_INSPECTION
3705                close_client_and_server_ssl_connections(csp);
3706 #endif
3707                return;
3708             }
3709
3710             /* Convert iob into something sed() can digest */
3711             if (JB_ERR_PARSE == get_server_headers(csp))
3712             {
3713                if (ms_iis5_hack)
3714                {
3715                   /*
3716                    * Well, we tried our MS IIS/5 hack and it didn't work.
3717                    * The header is incomplete and there isn't anything
3718                    * we can do about it.
3719                    */
3720                   log_error(LOG_LEVEL_ERROR, "Invalid server headers. "
3721                      "Applying the MS IIS5 hack didn't help.");
3722                   log_error(LOG_LEVEL_CLF,
3723                      "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3724 #ifdef FEATURE_HTTPS_INSPECTION
3725                   /*
3726                    * Sending data with standard or secured connection (HTTP/HTTPS)
3727                    */
3728                   if (client_use_ssl(csp))
3729                   {
3730                      ssl_send_data_delayed(&(csp->ssl_client_attr),
3731                         (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3732                         strlen(INVALID_SERVER_HEADERS_RESPONSE), get_write_delay(csp));
3733                   }
3734                   else
3735 #endif /* def FEATURE_HTTPS_INSPECTION */
3736                   {
3737                      write_socket_delayed(csp->cfd,
3738                         INVALID_SERVER_HEADERS_RESPONSE,
3739                         strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3740                   }
3741                   mark_server_socket_tainted(csp);
3742 #ifdef FEATURE_HTTPS_INSPECTION
3743                   close_client_and_server_ssl_connections(csp);
3744 #endif
3745                   return;
3746                }
3747                else
3748                {
3749                   /*
3750                    * Since we have to wait for more from the server before
3751                    * we can parse the headers we just continue here.
3752                    */
3753                   log_error(LOG_LEVEL_CONNECT,
3754                      "Continuing buffering server headers from socket %d. "
3755                      "Bytes most recently read: %ld.", csp->cfd, len);
3756                   continue;
3757                }
3758             }
3759             else
3760             {
3761                /*
3762                 * Account for the content bytes we
3763                 * might have gotten with the headers.
3764                 */
3765                assert(csp->iob->eod >= csp->iob->cur);
3766                byte_count = (unsigned long long)(csp->iob->eod - csp->iob->cur);
3767             }
3768
3769             /* Did we actually get anything? */
3770             if (NULL == csp->headers->first)
3771             {
3772                if ((csp->flags & CSP_FLAG_REUSED_CLIENT_CONNECTION))
3773                {
3774                   log_error(LOG_LEVEL_ERROR,
3775                      "No server or forwarder response received on socket %d. "
3776                      "Closing client socket %d without sending data.",
3777                      csp->server_connection.sfd, csp->cfd);
3778                   log_error(LOG_LEVEL_CLF,
3779                      "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3780                }
3781                else
3782                {
3783                   log_error(LOG_LEVEL_ERROR,
3784                      "No server or forwarder response received on socket %d.",
3785                      csp->server_connection.sfd);
3786                   send_crunch_response(csp, error_response(csp, "no-server-data"));
3787                }
3788                free_http_request(http);
3789                mark_server_socket_tainted(csp);
3790 #ifdef FEATURE_HTTPS_INSPECTION
3791                close_client_and_server_ssl_connections(csp);
3792 #endif
3793                return;
3794             }
3795
3796             if (!csp->headers->first->str)
3797             {
3798                log_error(LOG_LEVEL_ERROR, "header search: csp->headers->first->str == NULL, assert will be called");
3799             }
3800             assert(csp->headers->first->str);
3801
3802             if (strncmpic(csp->headers->first->str, "HTTP", 4) &&
3803                 strncmpic(csp->headers->first->str, "ICY", 3))
3804             {
3805                /*
3806                 * It doesn't look like a HTTP (or Shoutcast) response:
3807                 * tell the client and log the problem.
3808                 */
3809                if (strlen(csp->headers->first->str) > 30)
3810                {
3811                   csp->headers->first->str[30] = '\0';
3812                }
3813                log_error(LOG_LEVEL_ERROR,
3814                   "Invalid server or forwarder response. Starts with: %s",
3815                   csp->headers->first->str);
3816                log_error(LOG_LEVEL_CLF,
3817                   "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3818 #ifdef FEATURE_HTTPS_INSPECTION
3819                /*
3820                 * Sending data with standard or secured connection (HTTP/HTTPS)
3821                 */
3822                if (client_use_ssl(csp))
3823                {
3824                   ssl_send_data_delayed(&(csp->ssl_client_attr),
3825                      (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3826                      strlen(INVALID_SERVER_HEADERS_RESPONSE),
3827                      get_write_delay(csp));
3828                }
3829                else
3830 #endif /* def FEATURE_HTTPS_INSPECTION */
3831                {
3832                   write_socket_delayed(csp->cfd, INVALID_SERVER_HEADERS_RESPONSE,
3833                      strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3834                }
3835                free_http_request(http);
3836                mark_server_socket_tainted(csp);
3837 #ifdef FEATURE_HTTPS_INSPECTION
3838                close_client_and_server_ssl_connections(csp);
3839 #endif
3840                return;
3841             }
3842
3843             /*
3844              * We have now received the entire server header,
3845              * filter it and send the result to the client
3846              */
3847             if (JB_ERR_OK != sed(csp, FILTER_SERVER_HEADERS))
3848             {
3849                log_error(LOG_LEVEL_CLF,
3850                   "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3851 #ifdef FEATURE_HTTPS_INSPECTION
3852                /*
3853                 * Sending data with standard or secured connection (HTTP/HTTPS)
3854                 */
3855                if (client_use_ssl(csp))
3856                {
3857                   ssl_send_data_delayed(&(csp->ssl_client_attr),
3858                      (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3859                      strlen(INVALID_SERVER_HEADERS_RESPONSE),
3860                      get_write_delay(csp));
3861                }
3862                else
3863 #endif
3864                {
3865                   write_socket_delayed(csp->cfd, INVALID_SERVER_HEADERS_RESPONSE,
3866                      strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3867                }
3868                free_http_request(http);
3869                mark_server_socket_tainted(csp);
3870 #ifdef FEATURE_HTTPS_INSPECTION
3871                close_client_and_server_ssl_connections(csp);
3872 #endif
3873                return;
3874             }
3875             hdr = list_to_text(csp->headers);
3876             if (hdr == NULL)
3877             {
3878                /* FIXME Should handle error properly */
3879                log_error(LOG_LEVEL_FATAL, "Out of memory parsing server header");
3880             }
3881
3882             if ((csp->flags & CSP_FLAG_CHUNKED)
3883                && !(csp->flags & CSP_FLAG_CONTENT_LENGTH_SET)
3884                && ((csp->iob->eod - csp->iob->cur) >= 5)
3885                && !memcmp(csp->iob->eod-5, "0\r\n\r\n", 5))
3886             {
3887                log_error(LOG_LEVEL_CONNECT,
3888                   "Looks like we got the last chunk together with "
3889                   "the server headers. We better stop reading.");
3890                byte_count = (unsigned long long)(csp->iob->eod - csp->iob->cur);
3891                csp->expected_content_length = byte_count;
3892                csp->flags |= CSP_FLAG_CONTENT_LENGTH_SET;
3893             }
3894
3895             csp->server_connection.response_received = time(NULL);
3896
3897             if (crunch_response_triggered(csp, crunchers_light))
3898             {
3899                /*
3900                 * One of the tags created by a server-header
3901                 * tagger triggered a crunch. We already
3902                 * delivered the crunch response to the client
3903                 * and are done here after cleaning up.
3904                 */
3905                freez(hdr);
3906                mark_server_socket_tainted(csp);
3907 #ifdef FEATURE_HTTPS_INSPECTION
3908                close_client_and_server_ssl_connections(csp);
3909 #endif
3910                return;
3911             }
3912
3913             /* Buffer and pcrs filter this if appropriate. */
3914             buffer_and_filter_content = content_requires_filtering(csp);
3915
3916             if (!buffer_and_filter_content)
3917             {
3918                /*
3919                 * Write the server's (modified) header to
3920                 * the client (along with anything else that
3921                 * may be in the buffer). Use standard or secured
3922                 * connection.
3923                 */
3924 #ifdef FEATURE_HTTPS_INSPECTION
3925                if (client_use_ssl(csp))
3926                {
3927                   if ((ssl_send_data_delayed(&(csp->ssl_client_attr),
3928                           (const unsigned char *)hdr, strlen(hdr),
3929                           get_write_delay(csp)) < 0)
3930                      || (len = ssl_flush_socket(&(csp->ssl_client_attr),
3931                             csp->iob) < 0))
3932                   {
3933                      log_error(LOG_LEVEL_CONNECT, "Write header to client failed");
3934
3935                      /*
3936                       * The write failed, so don't bother mentioning it
3937                       * to the client... it probably can't hear us anyway.
3938                       */
3939                      freez(hdr);
3940                      mark_server_socket_tainted(csp);
3941 #ifdef FEATURE_HTTPS_INSPECTION
3942                      close_client_and_server_ssl_connections(csp);
3943 #endif
3944                      return;
3945                   }
3946                }
3947                else
3948 #endif /* def FEATURE_HTTPS_INSPECTION */
3949                {
3950                   if (write_socket_delayed(csp->cfd, hdr, strlen(hdr), write_delay)
3951                      || ((len = flush_iob(csp->cfd, csp->iob, write_delay)) < 0))
3952                   {
3953                      log_error(LOG_LEVEL_ERROR,
3954                         "write header to client failed");
3955                      /*
3956                       * The write failed, so don't bother mentioning it
3957                       * to the client... it probably can't hear us anyway.
3958                       */
3959                      freez(hdr);
3960                      mark_server_socket_tainted(csp);
3961                      return;
3962                   }
3963                }
3964                                 }
3965
3966             /* we're finished with the server's header */
3967
3968             freez(hdr);
3969             server_body = 1;
3970
3971             /*
3972              * If this was a MS IIS/5 hack then it means the server
3973              * has already closed the connection. Nothing more to read.
3974              * Time to bail.
3975              */
3976             if (ms_iis5_hack)
3977             {
3978                log_error(LOG_LEVEL_ERROR,
3979                   "Closed server connection detected. "
3980                   "Applying the MS IIS5 hack didn't help.");
3981                log_error(LOG_LEVEL_CLF,
3982                   "%s - - [%T] \"%s\" 502 0", csp->ip_addr_str, http->cmd);
3983 #ifdef FEATURE_HTTPS_INSPECTION
3984                /*
3985                 * Sending data with standard or secured connection (HTTP/HTTPS)
3986                 */
3987                if (client_use_ssl(csp))
3988                {
3989                   ssl_send_data_delayed(&(csp->ssl_client_attr),
3990                      (const unsigned char *)INVALID_SERVER_HEADERS_RESPONSE,
3991                      strlen(INVALID_SERVER_HEADERS_RESPONSE),
3992                      get_write_delay(csp));
3993                }
3994                else
3995 #endif /* def FEATURE_HTTPS_INSPECTION */
3996                {
3997                   write_socket_delayed(csp->cfd, INVALID_SERVER_HEADERS_RESPONSE,
3998                      strlen(INVALID_SERVER_HEADERS_RESPONSE), write_delay);
3999                }
4000                mark_server_socket_tainted(csp);
4001 #ifdef FEATURE_HTTPS_INSPECTION
4002                close_client_and_server_ssl_connections(csp);
4003 #endif
4004                return;
4005             }
4006          }
4007          continue;
4008       }
4009       mark_server_socket_tainted(csp);
4010 #ifdef FEATURE_HTTPS_INSPECTION
4011       close_client_and_server_ssl_connections(csp);
4012 #endif
4013       return; /* huh? we should never get here */
4014    }
4015
4016    if (csp->content_length == 0)
4017    {
4018       /*
4019        * If Privoxy didn't recalculate the Content-Length,
4020        * byte_count is still correct.
4021        */
4022       csp->content_length = byte_count;
4023    }
4024
4025 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4026    if ((csp->flags & CSP_FLAG_CONTENT_LENGTH_SET)
4027       && (csp->expected_content_length != byte_count))
4028    {
4029       log_error(LOG_LEVEL_CONNECT,
4030          "Received %llu bytes while expecting %llu.",
4031          byte_count, csp->expected_content_length);
4032       mark_server_socket_tainted(csp);
4033    }
4034 #endif
4035
4036 #ifdef FEATURE_HTTPS_INSPECTION
4037    if (client_use_ssl(csp))
4038    {
4039       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s https://%s%s %s\" 200 %llu",
4040          csp->ip_addr_str, http->gpc, http->hostport, http->path,
4041          http->version, csp->content_length);
4042    }
4043    else
4044 #endif
4045    {
4046       log_error(LOG_LEVEL_CLF, "%s - - [%T] \"%s\" 200 %llu",
4047          csp->ip_addr_str, http->ocmd, csp->content_length);
4048    }
4049    csp->server_connection.timestamp = time(NULL);
4050 }
4051
4052
4053 /*********************************************************************
4054  *
4055  * Function    :  chat
4056  *
4057  * Description :  Once a connection from the client has been accepted,
4058  *                this function is called (via serve()) to handle the
4059  *                main business of the communication.  This function
4060  *                returns after dealing with a single request. It can
4061  *                be called multiple times with the same client socket
4062  *                if the client is keeping the connection alive.
4063  *
4064  *                The decision whether or not a client connection will
4065  *                be kept alive is up to the caller which also must
4066  *                close the client socket when done.
4067  *
4068  *                FIXME: chat is nearly thousand lines long.
4069  *                Ridiculous.
4070  *
4071  * Parameters  :
4072  *          1  :  csp = Current client state (buffers, headers, etc...)
4073  *
4074  * Returns     :  Nothing.
4075  *
4076  *********************************************************************/
4077 static void chat(struct client_state *csp)
4078 {
4079    const struct forward_spec *fwd;
4080    struct http_request *http;
4081    /* Skeleton for HTTP response, if we should intercept the request */
4082    struct http_response *rsp;
4083 #ifdef FEATURE_HTTPS_INSPECTION
4084    int use_ssl_tunnel = 0;
4085 #endif
4086
4087    http = csp->http;
4088
4089    if (receive_client_request(csp) != JB_ERR_OK)
4090    {
4091       return;
4092    }
4093    if (parse_client_request(csp) != JB_ERR_OK)
4094    {
4095       return;
4096    }
4097
4098    /* decide how to route the HTTP request */
4099    fwd = forward_url(csp, http);
4100
4101 #ifdef FEATURE_HTTPS_INSPECTION
4102    /*
4103     * Setting flags to use old solution with SSL tunnel and to disable
4104     * certificate verification.
4105     */
4106    if (csp->http->ssl && !(csp->action->flags & ACTION_HTTPS_INSPECTION)
4107       && !cgi_page_requested(csp->http->host))
4108    {
4109       use_ssl_tunnel = 1;
4110    }
4111
4112    if (http->ssl && (csp->action->flags & ACTION_IGNORE_CERTIFICATE_ERRORS))
4113    {
4114       csp->dont_verify_certificate = 1;
4115    }
4116 #endif
4117
4118    /*
4119     * build the http request to send to the server
4120     * we have to do one of the following:
4121     *
4122     * create =    use the original HTTP request to create a new
4123     *             HTTP request that has either the path component
4124     *             without the http://domainspec (w/path) or the
4125     *             full orininal URL (w/url)
4126     *             Note that the path and/or the HTTP version may
4127     *             have been altered by now.
4128     *
4129     * SSL proxy = Open a socket to the host:port of the server
4130     *             and create TLS/SSL connection with server and
4131     *             with client. Then behave like mediator between
4132     *             client and server over TLS/SSL.
4133     *
4134     * SSL proxy = Pass the request unchanged if forwarding a CONNECT
4135     *    with     request to a parent proxy. Note that we'll be sending
4136     * forwarding  the CFAIL message ourselves if connecting to the parent
4137     *             fails, but we won't send a CSUCCEED message if it works,
4138     *             since that would result in a double message (ours and the
4139     *             parent's). After sending the request to the parent, we
4140     *             must parse answer and send it to client. If connection
4141     *             with server is established, we do TLS/SSL proxy. Otherwise
4142     *             we send parent response to client and close connections.
4143     *
4144     * here's the matrix:
4145     *                        SSL
4146     *                    0        1
4147     *                +--------+--------+
4148     *                |        |        |
4149     *             0  | create |   SSL  |
4150     *                | w/path |  proxy |
4151     *  Forwarding    +--------+--------+
4152     *                |        |   SSL  |
4153     *             1  | create |  proxy |
4154     *                | w/url  |+forward|
4155     *                +--------+--------+
4156     *
4157     */
4158
4159 #ifdef FEATURE_HTTPS_INSPECTION
4160    /*
4161     * Presetting SSL client and server flags
4162     */
4163    if (http->ssl && !use_ssl_tunnel)
4164    {
4165       http->client_ssl = 1;
4166       http->server_ssl = 1;
4167    }
4168    else
4169    {
4170       http->client_ssl = 0;
4171       http->server_ssl = 0;
4172    }
4173 #endif
4174
4175 #ifdef FEATURE_HTTPS_INSPECTION
4176    /*
4177     * Log the request unless we're https inspecting
4178     * in which case we don't have the path yet and
4179     * will log the request later.
4180     */
4181    if (!client_use_ssl(csp))
4182 #endif
4183    {
4184       log_error(LOG_LEVEL_REQUEST, "%s%s", http->hostport, http->path);
4185    }
4186
4187    if (http->ssl && connect_port_is_forbidden(csp))
4188    {
4189       const char *acceptable_connect_ports =
4190          csp->action->string[ACTION_STRING_LIMIT_CONNECT];
4191       assert(NULL != acceptable_connect_ports);
4192       log_error(LOG_LEVEL_INFO, "Request from %s marked for blocking. "
4193          "limit-connect{%s} doesn't allow CONNECT requests to %s",
4194          csp->ip_addr_str, acceptable_connect_ports, csp->http->hostport);
4195       csp->action->flags |= ACTION_BLOCK;
4196       http->ssl = 0;
4197 #ifdef FEATURE_HTTPS_INSPECTION
4198       http->client_ssl = 0;
4199       http->server_ssl = 0;
4200 #endif
4201    }
4202
4203
4204    freez(csp->headers->first->str);
4205    build_request_line(csp, fwd, &csp->headers->first->str);
4206
4207    /*
4208     * We have a request. Check if one of the crunchers wants it
4209     * unless the client wants to use TLS/SSL in which case we
4210     * haven't setup the TLS context yet and will send the crunch
4211     * response later.
4212     */
4213    if (
4214 #ifdef FEATURE_HTTPS_INSPECTION
4215        !client_use_ssl(csp) &&
4216 #endif
4217        crunch_response_triggered(csp, crunchers_all))
4218    {
4219       /*
4220        * Yes. The client got the crunch response and we're done here.
4221        */
4222       return;
4223    }
4224
4225    log_applied_actions(csp->action);
4226    if (fwd->forward_host)
4227    {
4228       log_error(LOG_LEVEL_CONNECT, "via [%s]:%d to: %s",
4229          fwd->forward_host, fwd->forward_port, http->hostport);
4230    }
4231    else
4232    {
4233       log_error(LOG_LEVEL_CONNECT, "to %s", http->hostport);
4234    }
4235
4236    /* here we connect to the server, gateway, or the forwarder */
4237
4238 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4239    if ((csp->server_connection.sfd != JB_INVALID_SOCKET)
4240       && socket_is_still_alive(csp->server_connection.sfd)
4241       && connection_destination_matches(&csp->server_connection, http, fwd))
4242    {
4243       log_error(LOG_LEVEL_CONNECT,
4244          "Reusing server socket %d connected to %s. Total requests: %u.",
4245          csp->server_connection.sfd, csp->server_connection.host,
4246          csp->server_connection.requests_sent_total);
4247    }
4248    else
4249    {
4250       if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4251       {
4252 #ifdef FEATURE_CONNECTION_SHARING
4253          if (csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING
4254 #ifdef FEATURE_HTTPS_INSPECTION
4255             && !server_use_ssl(csp)
4256 #endif
4257             )
4258          {
4259             remember_connection(&csp->server_connection);
4260          }
4261          else
4262 #endif /* def FEATURE_CONNECTION_SHARING */
4263          {
4264             log_error(LOG_LEVEL_CONNECT,
4265                "Closing server socket %d connected to %s. Total requests: %u.",
4266                csp->server_connection.sfd, csp->server_connection.host,
4267                csp->server_connection.requests_sent_total);
4268             close_socket(csp->server_connection.sfd);
4269          }
4270          mark_connection_closed(&csp->server_connection);
4271       }
4272 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4273 #ifdef FEATURE_HTTPS_INSPECTION
4274       if (client_use_ssl(csp) && !use_ssl_tunnel)
4275       {
4276          int ret;
4277          /*
4278           * Creating a SSL proxy.
4279           *
4280           * By sending the CSUCCEED message we're lying to the client as
4281           * the connection hasn't actually been established yet. We don't
4282           * establish the connection until we have seen and parsed the
4283           * encrypted client headers.
4284           */
4285          if (write_socket_delayed(csp->cfd, CSUCCEED,
4286                strlen(CSUCCEED), get_write_delay(csp)) != 0)
4287          {
4288             log_error(LOG_LEVEL_ERROR, "Sending SUCCEED to client failed");
4289             return;
4290          }
4291
4292          ret = create_client_ssl_connection(csp);
4293          if (ret != 0)
4294          {
4295             log_error(LOG_LEVEL_ERROR,
4296                "Failed to open a secure connection with the client");
4297             return;
4298          }
4299          if (JB_ERR_OK != process_encrypted_request(csp))
4300          {
4301             close_client_ssl_connection(csp);
4302             return;
4303          }
4304          /*
4305           * We have an encrypted request. Check if one of the crunchers now
4306           * wants it (for example because the previously invisible path was
4307           * required to match).
4308           */
4309          if (crunch_response_triggered(csp, crunchers_all))
4310          {
4311             /*
4312              * Yes. The client got the crunch response and we're done here.
4313              */
4314             return;
4315          }
4316       }
4317 #endif
4318       /*
4319        * Connecting to destination server
4320        */
4321       csp->server_connection.sfd = forwarded_connect(fwd, http, csp);
4322
4323       if (csp->server_connection.sfd == JB_INVALID_SOCKET)
4324       {
4325          if (fwd->type != SOCKS_NONE)
4326          {
4327             /* Socks error. */
4328             rsp = error_response(csp, "forwarding-failed");
4329          }
4330          else if (errno == EINVAL)
4331          {
4332             rsp = error_response(csp, "no-such-domain");
4333          }
4334          else
4335          {
4336             rsp = error_response(csp, "connect-failed");
4337          }
4338
4339          /* Write the answer to the client */
4340          if (rsp != NULL)
4341          {
4342             send_crunch_response(csp, rsp);
4343          }
4344
4345          /*
4346           * Temporary workaround to prevent already-read client
4347           * bodies from being parsed as new requests. For now we
4348           * err on the safe side and throw all the following
4349           * requests under the bus, even if no client body has been
4350           * buffered. A compliant client will repeat the dropped
4351           * requests on an untainted connection.
4352           *
4353           * The proper fix is to discard the no longer needed
4354           * client body in the buffer (if there is one) and to
4355           * continue parsing the bytes that follow.
4356           */
4357 #ifdef FEATURE_HTTPS_INSPECTION
4358          close_client_ssl_connection(csp);
4359 #endif
4360          drain_and_close_socket(csp->cfd);
4361          csp->cfd = JB_INVALID_SOCKET;
4362
4363          return;
4364       }
4365
4366 #ifdef FEATURE_HTTPS_INSPECTION
4367       /*
4368        * Creating TLS/SSL connections with destination server or parent
4369        * proxy. If forwarding is enabled, we must send client request to
4370        * parent proxy and receive, parse and resend parent proxy answer.
4371        */
4372       if (http->ssl && !use_ssl_tunnel)
4373       {
4374          if (fwd->forward_host != NULL)
4375          {
4376             char server_response[BUFFER_SIZE];
4377             int ret = 0;
4378             int len = 0;
4379             char *hdr = list_to_text(csp->headers);
4380             memset(server_response, 0, sizeof(server_response));
4381
4382             if (hdr == NULL)
4383             {
4384                log_error(LOG_LEVEL_FATAL,
4385                   "Out of memory parsing client header");
4386             }
4387             list_remove_all(csp->headers);
4388
4389             /*
4390              * Sending client's CONNECT request to the parent proxy
4391              */
4392             ret = write_socket(csp->server_connection.sfd, hdr, strlen(hdr));
4393
4394             freez(hdr);
4395
4396             if (ret != 0)
4397             {
4398                log_error(LOG_LEVEL_CONNECT,
4399                   "Sending request headers to: %s failed", http->hostport);
4400                mark_server_socket_tainted(csp);
4401                close_client_ssl_connection(csp);
4402                return;
4403             }
4404
4405             /* Waiting for parent proxy server response */
4406             len = read_socket(csp->server_connection.sfd, server_response,
4407                sizeof(server_response)-1);
4408
4409             if (len <= 0)
4410             {
4411                log_error(LOG_LEVEL_ERROR, "No response from parent proxy "
4412                   "server on socket %d.", csp->server_connection.sfd);
4413
4414                rsp = error_response(csp, "no-server-data");
4415                if (rsp)
4416                {
4417                   send_crunch_response(csp, rsp);
4418                }
4419                mark_server_socket_tainted(csp);
4420                close_client_ssl_connection(csp);
4421                return;
4422             }
4423
4424             /*
4425              * Test if the connection to the destination server was
4426              * established successfully by the parent proxy.
4427              */
4428             if (!tunnel_established_successfully(server_response, (unsigned int)len))
4429             {
4430                log_error(LOG_LEVEL_ERROR,
4431                   "The forwarder %s failed to establish a connection with %s",
4432                   fwd->forward_host, http->host);
4433                rsp = error_response(csp, "connect-failed");
4434                if (rsp)
4435                {
4436                   send_crunch_response(csp, rsp);
4437                }
4438                mark_server_socket_tainted(csp);
4439                close_client_ssl_connection(csp);
4440                return;
4441             }
4442          } /* -END- if (fwd->forward_host != NULL) */
4443
4444          /*
4445           * We can now create the TLS/SSL connection with the destination server.
4446           */
4447          int ret = create_server_ssl_connection(csp);
4448          if (ret != 0)
4449          {
4450             if (csp->server_cert_verification_result != SSL_CERT_VALID &&
4451                 csp->server_cert_verification_result != SSL_CERT_NOT_VERIFIED)
4452             {
4453                /*
4454                 * If the server certificate is invalid, we must inform
4455                 * the client and then close connection to the client.
4456                 */
4457                ssl_send_certificate_error(csp);
4458                close_client_and_server_ssl_connections(csp);
4459                return;
4460             }
4461             if (csp->server_cert_verification_result == SSL_CERT_NOT_VERIFIED
4462              || csp->server_cert_verification_result == SSL_CERT_VALID)
4463             {
4464                /*
4465                 * The TLS/SSL connection wasn't created but an invalid
4466                 * certificate wasn't detected. Report it as connection
4467                 * failure.
4468                 */
4469                rsp = error_response(csp, "connect-failed");
4470                if (rsp)
4471                {
4472                   send_crunch_response(csp, rsp);
4473                }
4474                close_client_and_server_ssl_connections(csp);
4475                return;
4476             }
4477          }
4478       }/* -END- if (http->ssl) */
4479 #endif /* def FEATURE_HTTPS_INSPECTION */
4480
4481 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4482       save_connection_destination(csp->server_connection.sfd,
4483          http, fwd, &csp->server_connection);
4484       csp->server_connection.keep_alive_timeout =
4485          (unsigned)csp->config->keep_alive_timeout;
4486    }
4487 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4488
4489    csp->server_connection.requests_sent_total++;
4490
4491    if ((fwd->type == SOCKS_5T) && (NULL == csp->headers->first))
4492    {
4493       /* Client headers have been sent optimistically */
4494       assert(csp->headers->last == NULL);
4495    }
4496    else if (http->ssl == 0 || (fwd->forward_host
4497 #ifdef FEATURE_HTTPS_INSPECTION
4498          && use_ssl_tunnel
4499 #endif
4500            ))
4501    {
4502       if (send_http_request(csp))
4503       {
4504          rsp = error_response(csp, "connect-failed");
4505          if (rsp)
4506          {
4507             send_crunch_response(csp, rsp);
4508          }
4509          return;
4510       }
4511    }
4512    else
4513    {
4514       /*
4515        * Using old solution with SSL tunnel or new solution with SSL proxy
4516        */
4517       list_remove_all(csp->headers);
4518 #ifdef FEATURE_HTTPS_INSPECTION
4519       if (use_ssl_tunnel)
4520 #endif
4521       {
4522          /*
4523          * We're running an SSL tunnel and we're not forwarding,
4524          * so just ditch the client headers, send the "connect succeeded"
4525          * message to the client, flush the rest, and get out of the way.
4526          */
4527          if (write_socket_delayed(csp->cfd, CSUCCEED,
4528                strlen(CSUCCEED), get_write_delay(csp)))
4529          {
4530             return;
4531          }
4532       }
4533 #ifdef FEATURE_HTTPS_INSPECTION
4534       else
4535       {
4536          /*
4537           * If server certificate has been verified and is invalid,
4538           * we must inform the client and then close the connection
4539           * with client and server.
4540           */
4541          if (csp->server_cert_verification_result != SSL_CERT_VALID &&
4542              csp->server_cert_verification_result != SSL_CERT_NOT_VERIFIED)
4543          {
4544             ssl_send_certificate_error(csp);
4545             close_client_and_server_ssl_connections(csp);
4546             return;
4547          }
4548          if (send_https_request(csp))
4549          {
4550             rsp = error_response(csp, "connect-failed");
4551             if (rsp)
4552             {
4553                send_crunch_response(csp, rsp);
4554             }
4555             close_client_and_server_ssl_connections(csp);
4556             return;
4557          }
4558       }
4559 #endif /* def FEATURE_HTTPS_INSPECTION */
4560       clear_iob(csp->client_iob);
4561    }/* -END- else ... if (http->ssl == 1) */
4562
4563    log_error(LOG_LEVEL_CONNECT, "to %s successful", http->hostport);
4564
4565    /* XXX: should the time start earlier for optimistically sent data? */
4566    csp->server_connection.request_sent = time(NULL);
4567
4568    handle_established_connection(csp);
4569    freez(csp->receive_buffer);
4570 }
4571
4572
4573 #ifdef FUZZ
4574 /*********************************************************************
4575  *
4576  * Function    :  fuzz_server_response
4577  *
4578  * Description :  Treat the input as a whole server response.
4579  *
4580  * Parameters  :
4581  *          1  :  csp = Current client state (buffers, headers, etc...)
4582  *          2  :  fuzz_input_file = File to read the input from.
4583  *
4584  * Returns     :  0
4585  *
4586  *********************************************************************/
4587 extern int fuzz_server_response(struct client_state *csp, char *fuzz_input_file)
4588 {
4589    static struct forward_spec fwd; /* Zero'd due to being static */
4590    csp->cfd = 0;
4591
4592    if (strcmp(fuzz_input_file, "-") == 0)
4593    {
4594       /* XXX: Doesn't work yet. */
4595       csp->server_connection.sfd = 0;
4596    }
4597    else
4598    {
4599       csp->server_connection.sfd = open(fuzz_input_file, O_RDONLY);
4600       if (csp->server_connection.sfd == -1)
4601       {
4602          log_error(LOG_LEVEL_FATAL, "Failed to open %s: %E",
4603             fuzz_input_file);
4604       }
4605    }
4606    csp->fwd = &fwd;
4607    csp->content_type |= CT_GIF;
4608    csp->action->flags |= ACTION_DEANIMATE;
4609    csp->action->string[ACTION_STRING_DEANIMATE] = "last";
4610
4611    csp->http->path = strdup_or_die("/");
4612    csp->http->host = strdup_or_die("fuzz.example.org");
4613    csp->http->hostport = strdup_or_die("fuzz.example.org:80");
4614    /* Prevent client socket monitoring */
4615    csp->flags |= CSP_FLAG_PIPELINED_REQUEST_WAITING;
4616    csp->flags |= CSP_FLAG_CHUNKED;
4617
4618    csp->config->feature_flags |= RUNTIME_FEATURE_CONNECTION_KEEP_ALIVE;
4619    csp->flags |= CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE;
4620
4621    csp->content_type |= CT_DECLARED|CT_GIF;
4622
4623    csp->config->socket_timeout = 0;
4624
4625    cgi_init_error_messages();
4626
4627    handle_established_connection(csp);
4628    freez(csp->receive_buffer);
4629
4630    return 0;
4631 }
4632 #endif
4633
4634
4635 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4636 /*********************************************************************
4637  *
4638  * Function    :  prepare_csp_for_next_request
4639  *
4640  * Description :  Put the csp in a mostly vergin state.
4641  *
4642  * Parameters  :
4643  *          1  :  csp = Current client state (buffers, headers, etc...)
4644  *
4645  * Returns     :  N/A
4646  *
4647  *********************************************************************/
4648 static void prepare_csp_for_next_request(struct client_state *csp)
4649 {
4650    csp->content_type = 0;
4651    csp->content_length = 0;
4652    csp->expected_content_length = 0;
4653    csp->expected_client_content_length = 0;
4654    list_remove_all(csp->headers);
4655    clear_iob(csp->iob);
4656    freez(csp->error_message);
4657    free_http_request(csp->http);
4658    destroy_list(csp->headers);
4659 #ifdef FEATURE_HTTPS_INSPECTION
4660    destroy_list(csp->https_headers);
4661 #endif
4662    destroy_list(csp->tags);
4663 #ifdef FEATURE_CLIENT_TAGS
4664    destroy_list(csp->client_tags);
4665    freez(csp->client_address);
4666 #endif
4667    free_current_action(csp->action);
4668    if (NULL != csp->fwd)
4669    {
4670       unload_forward_spec(csp->fwd);
4671       csp->fwd = NULL;
4672    }
4673    /* XXX: Store per-connection flags someplace else. */
4674    csp->flags = (CSP_FLAG_ACTIVE | CSP_FLAG_REUSED_CLIENT_CONNECTION);
4675 #ifdef FEATURE_TOGGLE
4676    if (global_toggle_state)
4677 #endif /* def FEATURE_TOGGLE */
4678    {
4679       csp->flags |= CSP_FLAG_TOGGLED_ON;
4680    }
4681
4682    if (csp->client_iob->eod > csp->client_iob->cur)
4683    {
4684       long bytes_to_shift = csp->client_iob->cur - csp->client_iob->buf;
4685       size_t data_length  = (size_t)(csp->client_iob->eod - csp->client_iob->cur);
4686
4687       assert(bytes_to_shift > 0);
4688       assert(data_length > 0);
4689
4690       log_error(LOG_LEVEL_CONNECT, "Shifting %lu pipelined bytes by %ld bytes",
4691          data_length, bytes_to_shift);
4692       memmove(csp->client_iob->buf, csp->client_iob->cur, data_length);
4693       csp->client_iob->cur = csp->client_iob->buf;
4694       assert(csp->client_iob->eod == csp->client_iob->buf + bytes_to_shift + data_length);
4695       csp->client_iob->eod = csp->client_iob->buf + data_length;
4696       memset(csp->client_iob->eod, '\0', (size_t)bytes_to_shift);
4697
4698       csp->flags |= CSP_FLAG_PIPELINED_REQUEST_WAITING;
4699    }
4700    else
4701    {
4702       /*
4703        * We mainly care about resetting client_iob->cur so we don't
4704        * waste buffer space at the beginning and don't mess up the
4705        * request restoration done by cgi_show_request().
4706        *
4707        * Freeing the buffer itself isn't technically necessary,
4708        * but makes debugging more convenient.
4709        */
4710       clear_iob(csp->client_iob);
4711    }
4712 }
4713 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4714
4715
4716 /*********************************************************************
4717  *
4718  * Function    :  serve
4719  *
4720  * Description :  This is little more than chat.  We only "serve" to
4721  *                to close (or remember) any socket that chat may have
4722  *                opened.
4723  *
4724  * Parameters  :
4725  *          1  :  csp = Current client state (buffers, headers, etc...)
4726  *
4727  * Returns     :  N/A
4728  *
4729  *********************************************************************/
4730 static void serve(struct client_state *csp)
4731 {
4732    int config_file_change_detected = 0; /* Only used for debugging */
4733 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4734 #ifdef FEATURE_CONNECTION_SHARING
4735    static int monitor_thread_running = 0;
4736 #endif /* def FEATURE_CONNECTION_SHARING */
4737    int continue_chatting = 0;
4738
4739    log_error(LOG_LEVEL_CONNECT, "Accepted connection from %s on socket %d",
4740       csp->ip_addr_str, csp->cfd);
4741
4742    do
4743    {
4744       unsigned int latency;
4745
4746 #ifdef FEATURE_HTTPS_INSPECTION
4747       if (continue_chatting && client_use_ssl(csp))
4748       {
4749          continue_https_chat(csp);
4750       }
4751       else
4752 #endif
4753       {
4754          chat(csp);
4755       }
4756
4757       /*
4758        * If the request has been crunched,
4759        * the calculated latency is zero.
4760        */
4761       latency = (unsigned)(csp->server_connection.response_received -
4762          csp->server_connection.request_sent) / 2;
4763
4764       if ((csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE)
4765          && (csp->flags & CSP_FLAG_CRUNCHED)
4766          && (csp->expected_client_content_length != 0))
4767       {
4768          csp->flags |= CSP_FLAG_SERVER_SOCKET_TAINTED;
4769          log_error(LOG_LEVEL_CONNECT,
4770             "Tainting client socket %d due to unread data.", csp->cfd);
4771       }
4772
4773       continue_chatting = (csp->config->feature_flags
4774          & RUNTIME_FEATURE_CONNECTION_KEEP_ALIVE)
4775          && !(csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED)
4776          && (csp->cfd != JB_INVALID_SOCKET)
4777          && (csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE)
4778          && ((csp->flags & CSP_FLAG_SERVER_CONTENT_LENGTH_SET)
4779             || (csp->flags & CSP_FLAG_CHUNKED));
4780
4781       if (!(csp->flags & CSP_FLAG_CRUNCHED)
4782          && (csp->server_connection.sfd != JB_INVALID_SOCKET))
4783       {
4784          if (!(csp->flags & CSP_FLAG_SERVER_KEEP_ALIVE_TIMEOUT_SET))
4785          {
4786             csp->server_connection.keep_alive_timeout = csp->config->default_server_timeout;
4787          }
4788          if (!(csp->flags & CSP_FLAG_SERVER_CONNECTION_KEEP_ALIVE)
4789             || (csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED)
4790             || !socket_is_still_alive(csp->server_connection.sfd)
4791             || !(latency < csp->server_connection.keep_alive_timeout))
4792          {
4793             log_error(LOG_LEVEL_CONNECT,
4794                "Closing server socket %d connected to %s. "
4795                "Keep-alive: %u. Tainted: %u. Socket alive: %u. Timeout: %u.",
4796                csp->server_connection.sfd, csp->server_connection.host,
4797                0 != (csp->flags & CSP_FLAG_SERVER_CONNECTION_KEEP_ALIVE),
4798                0 != (csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED),
4799                socket_is_still_alive(csp->server_connection.sfd),
4800                csp->server_connection.keep_alive_timeout);
4801 #ifdef FEATURE_CONNECTION_SHARING
4802             if (csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING)
4803             {
4804                forget_connection(csp->server_connection.sfd);
4805             }
4806 #endif /* def FEATURE_CONNECTION_SHARING */
4807 #ifdef FEATURE_HTTPS_INSPECTION
4808             close_server_ssl_connection(csp);
4809 #endif
4810             close_socket(csp->server_connection.sfd);
4811             mark_connection_closed(&csp->server_connection);
4812          }
4813       }
4814
4815       if (continue_chatting && any_loaded_file_changed(csp))
4816       {
4817          continue_chatting = 0;
4818          config_file_change_detected = 1;
4819       }
4820 #ifdef FEATURE_HTTPS_INSPECTION
4821       if (continue_chatting && client_use_ssl(csp) &&
4822          csp->ssl_with_client_is_opened == 0)
4823       {
4824          continue_chatting = 0;
4825          log_error(LOG_LEVEL_CONNECT, "Client socket %d is no longer usable. "
4826             "The TLS session has been terminated.", csp->cfd);
4827       }
4828 #endif
4829
4830       if (continue_chatting)
4831       {
4832          if (((csp->flags & CSP_FLAG_PIPELINED_REQUEST_WAITING) != 0)
4833             && socket_is_still_alive(csp->cfd))
4834          {
4835             log_error(LOG_LEVEL_CONNECT, "Client request %d has been "
4836                "pipelined on socket %d and the socket is still alive.",
4837                csp->requests_received_total+1, csp->cfd);
4838             prepare_csp_for_next_request(csp);
4839             continue;
4840          }
4841
4842          if (0 != (csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE))
4843          {
4844             if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4845             {
4846                log_error(LOG_LEVEL_CONNECT,
4847                   "Waiting for the next client request on socket %d. "
4848                   "Keeping the server socket %d to %s open.",
4849                   csp->cfd, csp->server_connection.sfd, csp->server_connection.host);
4850             }
4851             else
4852             {
4853                log_error(LOG_LEVEL_CONNECT,
4854                   "Waiting for the next client request on socket %d. "
4855                   "No server socket to keep open.", csp->cfd);
4856             }
4857          }
4858
4859          if ((csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE)
4860             && data_is_available(csp->cfd, (int)csp->config->keep_alive_timeout)
4861             && socket_is_still_alive(csp->cfd))
4862          {
4863             log_error(LOG_LEVEL_CONNECT,
4864                "Data arrived in time on client socket %d. Requests so far: %u",
4865                csp->cfd, csp->requests_received_total);
4866             prepare_csp_for_next_request(csp);
4867          }
4868          else
4869          {
4870 #ifdef FEATURE_CONNECTION_SHARING
4871             if ((csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING)
4872                && (csp->server_connection.sfd != JB_INVALID_SOCKET)
4873                && (socket_is_still_alive(csp->server_connection.sfd))
4874 #ifdef FEATURE_HTTPS_INSPECTION
4875                && !server_use_ssl(csp)
4876 #endif
4877                 )
4878             {
4879                time_t time_open = time(NULL) - csp->server_connection.timestamp;
4880
4881                if (csp->server_connection.keep_alive_timeout < time_open - (time_t)latency)
4882                {
4883                   break;
4884                }
4885
4886                remember_connection(&csp->server_connection);
4887                csp->server_connection.sfd = JB_INVALID_SOCKET;
4888                drain_and_close_socket(csp->cfd);
4889                csp->cfd = JB_INVALID_SOCKET;
4890                privoxy_mutex_lock(&connection_reuse_mutex);
4891                if (!monitor_thread_running)
4892                {
4893                   monitor_thread_running = 1;
4894                   privoxy_mutex_unlock(&connection_reuse_mutex);
4895                   wait_for_alive_connections();
4896                   privoxy_mutex_lock(&connection_reuse_mutex);
4897                   monitor_thread_running = 0;
4898                }
4899                privoxy_mutex_unlock(&connection_reuse_mutex);
4900             }
4901 #endif /* def FEATURE_CONNECTION_SHARING */
4902             break;
4903          }
4904       }
4905       else if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4906       {
4907          log_error(LOG_LEVEL_CONNECT,
4908             "Closing server socket %d connected to %s. Keep-alive: %u. "
4909             "Tainted: %u. Socket alive: %u. Timeout: %u. "
4910             "Configuration file change detected: %u",
4911             csp->server_connection.sfd, csp->server_connection.host,
4912             0 != (csp->flags & CSP_FLAG_SERVER_CONNECTION_KEEP_ALIVE),
4913             0 != (csp->flags & CSP_FLAG_SERVER_SOCKET_TAINTED),
4914             socket_is_still_alive(csp->server_connection.sfd),
4915             csp->server_connection.keep_alive_timeout,
4916             config_file_change_detected);
4917       }
4918    } while (continue_chatting);
4919
4920 #else
4921    chat(csp);
4922 #endif /* def FEATURE_CONNECTION_KEEP_ALIVE */
4923
4924    if (csp->cfd != JB_INVALID_SOCKET)
4925    {
4926       log_error(LOG_LEVEL_CONNECT, "Closing client socket %d. "
4927          "Keep-alive: %u. Socket alive: %u. Data available: %u. "
4928          "Configuration file change detected: %u. Requests received: %u.",
4929          csp->cfd, 0 != (csp->flags & CSP_FLAG_CLIENT_CONNECTION_KEEP_ALIVE),
4930          socket_is_still_alive(csp->cfd), data_is_available(csp->cfd, 0),
4931          config_file_change_detected, csp->requests_received_total);
4932 #ifdef FEATURE_HTTPS_INSPECTION
4933       close_client_ssl_connection(csp);
4934 #endif
4935       drain_and_close_socket(csp->cfd);
4936    }
4937
4938    if (csp->server_connection.sfd != JB_INVALID_SOCKET)
4939    {
4940 #ifdef FEATURE_CONNECTION_SHARING
4941       if (csp->config->feature_flags & RUNTIME_FEATURE_CONNECTION_SHARING)
4942       {
4943          forget_connection(csp->server_connection.sfd);
4944       }
4945 #endif /* def FEATURE_CONNECTION_SHARING */
4946
4947 #ifdef FEATURE_HTTPS_INSPECTION
4948       close_server_ssl_connection(csp);
4949 #endif /* def FEATURE_HTTPS_INSPECTION */
4950
4951       close_socket(csp->server_connection.sfd);
4952    }
4953
4954 #ifdef FEATURE_CONNECTION_KEEP_ALIVE
4955    mark_connection_closed(&csp->server_connection);
4956 #endif
4957
4958    free_csp_resources(csp);
4959
4960    csp->flags &= ~CSP_FLAG_ACTIVE;
4961
4962 }
4963
4964
4965 #ifdef __BEOS__
4966 /*********************************************************************
4967  *
4968  * Function    :  server_thread
4969  *
4970  * Description :  We only exist to call `serve' in a threaded environment.
4971  *
4972  * Parameters  :
4973  *          1  :  data = Current client state (buffers, headers, etc...)
4974  *
4975  * Returns     :  Always 0.
4976  *
4977  *********************************************************************/
4978 static int32 server_thread(void *data)
4979 {
4980    serve((struct client_state *) data);
4981    return 0;
4982
4983 }
4984 #endif
4985
4986
4987 #if !defined(_WIN32) || defined(_WIN_CONSOLE)
4988 /*********************************************************************
4989  *
4990  * Function    :  usage
4991  *
4992  * Description :  Print usage info & exit.
4993  *
4994  * Parameters  :  Pointer to argv[0] for identifying ourselves
4995  *
4996  * Returns     :  No. ,-)
4997  *
4998  *********************************************************************/
4999 static void usage(const char *name)
5000 {
5001    printf("Privoxy version " VERSION " (" HOME_PAGE_URL ")\n"
5002           "Usage: %s [--config-test] "
5003 #if defined(unix)
5004           "[--chroot] "
5005 #endif /* defined(unix) */
5006           "[--help] "
5007 #if defined(unix)
5008           "[--no-daemon] [--pidfile pidfile] [--pre-chroot-nslookup hostname] [--user user[.group]] "
5009 #endif /* defined(unix) */
5010          "[--version] [configfile]\n",
5011           name);
5012
5013 #ifdef FUZZ
5014    show_fuzz_usage(name);
5015 #endif
5016
5017    printf("Aborting\n");
5018
5019    exit(2);
5020
5021 }
5022 #endif /* #if !defined(_WIN32) || defined(_WIN_CONSOLE) */
5023
5024
5025 #ifdef MUTEX_LOCKS_AVAILABLE
5026 /*********************************************************************
5027  *
5028  * Function    :  privoxy_mutex_lock
5029  *
5030  * Description :  Locks a mutex.
5031  *
5032  * Parameters  :
5033  *          1  :  mutex = The mutex to lock.
5034  *
5035  * Returns     :  Void. May exit in case of errors.
5036  *
5037  *********************************************************************/
5038 void privoxy_mutex_lock(privoxy_mutex_t *mutex)
5039 {
5040 #ifdef FEATURE_PTHREAD
5041    int err = pthread_mutex_lock(mutex);
5042    if (err)
5043    {
5044       if (mutex != &log_mutex)
5045       {
5046          log_error(LOG_LEVEL_FATAL,
5047             "Mutex locking failed: %s.\n", strerror(err));
5048       }
5049       exit(1);
5050    }
5051 #else
5052    EnterCriticalSection(mutex);
5053 #endif /* def FEATURE_PTHREAD */
5054 }
5055
5056
5057 /*********************************************************************
5058  *
5059  * Function    :  privoxy_mutex_unlock
5060  *
5061  * Description :  Unlocks a mutex.
5062  *
5063  * Parameters  :
5064  *          1  :  mutex = The mutex to unlock.
5065  *
5066  * Returns     :  Void. May exit in case of errors.
5067  *
5068  *********************************************************************/
5069 void privoxy_mutex_unlock(privoxy_mutex_t *mutex)
5070 {
5071 #ifdef FEATURE_PTHREAD
5072    int err = pthread_mutex_unlock(mutex);
5073    if (err)
5074    {
5075       if (mutex != &log_mutex)
5076       {
5077          log_error(LOG_LEVEL_FATAL,
5078             "Mutex unlocking failed: %s.\n", strerror(err));
5079       }
5080       exit(1);
5081    }
5082 #else
5083    LeaveCriticalSection(mutex);
5084 #endif /* def FEATURE_PTHREAD */
5085 }
5086
5087
5088 /*********************************************************************
5089  *
5090  * Function    :  privoxy_mutex_init
5091  *
5092  * Description :  Prepares a mutex.
5093  *
5094  * Parameters  :
5095  *          1  :  mutex = The mutex to initialize.
5096  *
5097  * Returns     :  Void. May exit in case of errors.
5098  *
5099  *********************************************************************/
5100 static void privoxy_mutex_init(privoxy_mutex_t *mutex)
5101 {
5102 #ifdef FEATURE_PTHREAD
5103    int err = pthread_mutex_init(mutex, 0);
5104    if (err)
5105    {
5106       printf("Fatal error. Mutex initialization failed: %s.\n",
5107          strerror(err));
5108       exit(1);
5109    }
5110 #else
5111    InitializeCriticalSection(mutex);
5112 #endif /* def FEATURE_PTHREAD */
5113 }
5114 #endif /* def MUTEX_LOCKS_AVAILABLE */
5115
5116 /*********************************************************************
5117  *
5118  * Function    :  initialize_mutexes
5119  *
5120  * Description :  Prepares mutexes if mutex support is available.
5121  *
5122  * Parameters  :  None
5123  *
5124  * Returns     :  Void, exits in case of errors.
5125  *
5126  *********************************************************************/
5127 static void initialize_mutexes(void)
5128 {
5129 #ifdef MUTEX_LOCKS_AVAILABLE
5130    /*
5131     * Prepare global mutex semaphores
5132     */
5133
5134 #ifdef FEATURE_HTTPS_INSPECTION
5135    privoxy_mutex_init(&certificate_mutex);
5136    privoxy_mutex_init(&ssl_init_mutex);
5137 #endif
5138
5139    privoxy_mutex_init(&log_mutex);
5140    privoxy_mutex_init(&log_init_mutex);
5141    privoxy_mutex_init(&connection_reuse_mutex);
5142 #ifdef FEATURE_EXTERNAL_FILTERS
5143    privoxy_mutex_init(&external_filter_mutex);
5144 #endif
5145 #ifdef FEATURE_CLIENT_TAGS
5146    privoxy_mutex_init(&client_tags_mutex);
5147 #endif
5148 #ifdef FEATURE_EXTENDED_STATISTICS
5149    privoxy_mutex_init(&filter_statistics_mutex);
5150    privoxy_mutex_init(&block_statistics_mutex);
5151 #endif
5152
5153    /*
5154     * XXX: The assumptions below are a bit naive
5155     * and can cause locks that aren't necessary.
5156     *
5157     * For example older FreeBSD versions (< 6.x?)
5158     * have no gethostbyname_r, but gethostbyname is
5159     * thread safe.
5160     */
5161 #if !defined(HAVE_GETHOSTBYADDR_R) || !defined(HAVE_GETHOSTBYNAME_R)
5162    privoxy_mutex_init(&resolver_mutex);
5163 #endif /* !defined(HAVE_GETHOSTBYADDR_R) || !defined(HAVE_GETHOSTBYNAME_R) */
5164    /*
5165     * XXX: should we use a single mutex for
5166     * localtime() and gmtime() as well?
5167     */
5168 #ifndef HAVE_GMTIME_R
5169    privoxy_mutex_init(&gmtime_mutex);
5170 #endif /* ndef HAVE_GMTIME_R */
5171
5172 #ifndef HAVE_LOCALTIME_R
5173    privoxy_mutex_init(&localtime_mutex);
5174 #endif /* ndef HAVE_GMTIME_R */
5175
5176 #if !defined(HAVE_ARC4RANDOM) && !defined(HAVE_RANDOM)
5177    privoxy_mutex_init(&rand_mutex);
5178 #endif /* !defined(HAVE_ARC4RANDOM) && !defined(HAVE_RANDOM) */
5179
5180 #endif /* def MUTEX_LOCKS_AVAILABLE */
5181 }
5182
5183 /*********************************************************************
5184  *
5185  * Function    :  main
5186  *
5187  * Description :  Load the config file and start the listen loop.
5188  *                This function is a lot more *sane* with the `load_config'
5189  *                and `listen_loop' functions; although it stills does
5190  *                a *little* too much for my taste.
5191  *
5192  * Parameters  :
5193  *          1  :  argc = Number of parameters (including $0).
5194  *          2  :  argv = Array of (char *)'s to the parameters.
5195  *
5196  * Returns     :  1 if : can't open config file, unrecognized directive,
5197  *                stats requested in multi-thread mode, can't open the
5198  *                log file, can't open the jar file, listen port is invalid,
5199  *                any load fails, and can't bind port.
5200  *
5201  *                Else main never returns, the process must be signaled
5202  *                to terminate execution.  Or, on Windows, use the
5203  *                "File", "Exit" menu option.
5204  *
5205  *********************************************************************/
5206 #ifdef __MINGW32__
5207 int real_main(int argc, char **argv)
5208 #else
5209 int main(int argc, char **argv)
5210 #endif
5211 {
5212    int argc_pos = 0;
5213    int do_config_test = 0;
5214 #ifndef HAVE_ARC4RANDOM
5215    unsigned int random_seed;
5216 #endif
5217 #ifdef unix
5218    struct passwd *pw = NULL;
5219    struct group *grp = NULL;
5220    int do_chroot = 0;
5221    char *pre_chroot_nslookup_to_load_resolver = NULL;
5222 #endif
5223 #ifdef FUZZ
5224    char *fuzz_input_type = NULL;
5225    char *fuzz_input_file = NULL;
5226 #endif
5227
5228    Argc = argc;
5229    Argv = argv;
5230
5231    configfile =
5232 #if !defined(_WIN32)
5233    "config"
5234 #else
5235    "config.txt"
5236 #endif
5237       ;
5238
5239    /* Prepare mutexes if supported and necessary. */
5240    initialize_mutexes();
5241
5242    /* Enable logging until further notice. */
5243    init_log_module();
5244
5245    /*
5246     * Parse the command line arguments
5247     *
5248     * XXX: simply printing usage information in case of
5249     * invalid arguments isn't particularly user friendly.
5250     */
5251    while (++argc_pos < argc)
5252    {
5253 #ifdef _WIN32
5254       /* Check to see if the service must be installed or uninstalled */
5255       if (strncmp(argv[argc_pos], "--install", 9) == 0)
5256       {
5257          const char *pName = argv[argc_pos] + 9;
5258          if (*pName == ':')
5259             pName++;
5260          exit((install_service(pName)) ? 0 : 1);
5261       }
5262       else if (strncmp(argv[argc_pos], "--uninstall", 11) == 0)
5263       {
5264          const char *pName = argv[argc_pos] + 11;
5265          if (*pName == ':')
5266             pName++;
5267          exit((uninstall_service(pName)) ? 0 : 1);
5268       }
5269       else if (strcmp(argv[argc_pos], "--service") == 0)
5270       {
5271          bRunAsService = TRUE;
5272          w32_set_service_cwd();
5273          atexit(w32_service_exit_notify);
5274       }
5275       else
5276 #endif /* defined(_WIN32) */
5277
5278
5279 #if !defined(_WIN32) || defined(_WIN_CONSOLE)
5280
5281       if (strcmp(argv[argc_pos], "--help") == 0)
5282       {
5283          usage(argv[0]);
5284       }
5285
5286       else if (strcmp(argv[argc_pos], "--version") == 0)
5287       {
5288          printf("Privoxy version " VERSION " (" HOME_PAGE_URL ")\n");
5289          exit(0);
5290       }
5291
5292 #if defined(unix)
5293
5294       else if (strcmp(argv[argc_pos], "--no-daemon") == 0)
5295       {
5296          set_debug_level(LOG_LEVEL_FATAL | LOG_LEVEL_ERROR | LOG_LEVEL_INFO);
5297          daemon_mode = 0;
5298       }
5299
5300       else if (strcmp(argv[argc_pos], "--pidfile") == 0)
5301       {
5302          if (++argc_pos == argc) usage(argv[0]);
5303          pidfile = strdup_or_die(argv[argc_pos]);
5304       }
5305
5306       else if (strcmp(argv[argc_pos], "--user") == 0)
5307       {
5308          char *user_arg;
5309          char *group_name;
5310
5311          if (++argc_pos == argc) usage(argv[argc_pos]);
5312
5313          user_arg = strdup_or_die(argv[argc_pos]);
5314          group_name = strchr(user_arg, '.');
5315          if (NULL != group_name)
5316          {
5317             /* Nul-terminate the user name */
5318             *group_name = '\0';
5319
5320             /* Skip the former delimiter to actually reach the group name */
5321             group_name++;
5322
5323             grp = getgrnam(group_name);
5324             if (NULL == grp)
5325             {
5326                log_error(LOG_LEVEL_FATAL, "Group '%s' not found.", group_name);
5327             }
5328          }
5329          pw = getpwnam(user_arg);
5330          if (NULL == pw)
5331          {
5332             log_error(LOG_LEVEL_FATAL, "User '%s' not found.", user_arg);
5333          }
5334
5335          freez(user_arg);
5336       }
5337
5338       else if (strcmp(argv[argc_pos], "--pre-chroot-nslookup") == 0)
5339       {
5340          if (++argc_pos == argc) usage(argv[0]);
5341          pre_chroot_nslookup_to_load_resolver = strdup_or_die(argv[argc_pos]);
5342       }
5343
5344       else if (strcmp(argv[argc_pos], "--chroot") == 0)
5345       {
5346          do_chroot = 1;
5347       }
5348 #endif /* defined(unix) */
5349
5350       else if (strcmp(argv[argc_pos], "--config-test") == 0)
5351       {
5352          do_config_test = 1;
5353       }
5354 #ifdef FUZZ
5355       else if (strcmp(argv[argc_pos], "--fuzz") == 0)
5356       {
5357          argc_pos++;
5358          if (argc < argc_pos + 2) usage(argv[0]);
5359          fuzz_input_type = argv[argc_pos];
5360          argc_pos++;
5361          fuzz_input_file = argv[argc_pos];
5362       }
5363       else if (strcmp(argv[argc_pos], "--stfu") == 0)
5364       {
5365          set_debug_level(LOG_LEVEL_STFU);
5366       }
5367 #endif
5368       else if (argc_pos + 1 != argc)
5369       {
5370          /*
5371           * This is neither the last command line
5372           * option, nor was it recognized before,
5373           * therefore it must be invalid.
5374           */
5375          usage(argv[0]);
5376       }
5377       else
5378
5379 #endif /* defined(_WIN32) && !defined(_WIN_CONSOLE) */
5380       {
5381          configfile = argv[argc_pos];
5382       }
5383
5384    } /* -END- while (more arguments) */
5385
5386    show_version(Argv[0]);
5387
5388 #if defined(unix)
5389    if (*configfile != '/')
5390    {
5391       char cwd[BUFFER_SIZE];
5392       char *abs_file;
5393       size_t abs_file_size;
5394
5395       /* make config-filename absolute here */
5396       if (NULL == getcwd(cwd, sizeof(cwd)))
5397       {
5398          perror("failed to get current working directory");
5399          exit(1);
5400       }
5401
5402       basedir = strdup_or_die(cwd);
5403       /* XXX: why + 5? */
5404       abs_file_size = strlen(cwd) + strlen(configfile) + 5;
5405       abs_file = malloc_or_die(abs_file_size);
5406       strlcpy(abs_file, basedir, abs_file_size);
5407       strlcat(abs_file, "/", abs_file_size);
5408       strlcat(abs_file, configfile, abs_file_size);
5409       configfile = abs_file;
5410    }
5411 #endif /* defined unix */
5412
5413
5414    files->next = NULL;
5415    clients->next = NULL;
5416
5417    /* XXX: factor out initialising after the next stable release. */
5418 #ifdef _WIN32
5419    InitWin32();
5420 #endif
5421
5422 #ifndef HAVE_ARC4RANDOM
5423    random_seed = (unsigned int)time(NULL);
5424 #ifdef HAVE_RANDOM
5425    srandom(random_seed);
5426 #else
5427    srand(random_seed);
5428 #endif /* ifdef HAVE_RANDOM */
5429 #endif /* ifndef HAVE_ARC4RANDOM */
5430
5431    /*
5432     * Unix signal handling
5433     *
5434     * Catch the abort, interrupt and terminate signals for a graceful exit
5435     * Catch the hangup signal so the errlog can be reopened.
5436     *
5437     * Ignore the broken pipe signal as connection failures
5438     * are handled when and where they occur without relying
5439     * on a signal.
5440     */
5441 #if !defined(_WIN32)
5442 {
5443    int idx;
5444    const int catched_signals[] = { SIGTERM, SIGINT, SIGHUP };
5445
5446    for (idx = 0; idx < SZ(catched_signals); idx++)
5447    {
5448 #ifdef sun /* FIXME: Is it safe to check for HAVE_SIGSET instead? */
5449       if (sigset(catched_signals[idx], sig_handler) == SIG_ERR)
5450 #else
5451       if (signal(catched_signals[idx], sig_handler) == SIG_ERR)
5452 #endif /* ifdef sun */
5453       {
5454          log_error(LOG_LEVEL_FATAL, "Can't set signal-handler for signal %d: %E", catched_signals[idx]);
5455       }
5456    }
5457
5458    if (signal(SIGPIPE, SIG_IGN) == SIG_ERR)
5459    {
5460       log_error(LOG_LEVEL_FATAL, "Can't set ignore-handler for SIGPIPE: %E");
5461    }
5462
5463 }
5464 #else /* ifdef _WIN32 */
5465 # ifdef _WIN_CONSOLE
5466    /*
5467     * We *are* in a windows console app.
5468     * Print a verbose messages about FAQ's and such
5469     */
5470    printf("%s", win32_blurb);
5471 # endif /* def _WIN_CONSOLE */
5472 #endif /* def _WIN32 */
5473
5474 #ifdef FUZZ
5475    if (fuzz_input_type != NULL)
5476    {
5477       exit(process_fuzzed_input(fuzz_input_type, fuzz_input_file));
5478    }
5479    log_error(LOG_LEVEL_FATAL,
5480       "When compiled with fuzzing support, Privoxy should only be used for fuzzing. "
5481       "Various data structures are static which is unsafe when using threads.");
5482 #endif
5483
5484    if (do_config_test)
5485    {
5486       exit(NULL == load_config());
5487    }
5488
5489    /* Initialize the CGI subsystem */
5490    cgi_init_error_messages();
5491
5492    /*
5493     * If running on unix and without the --no-daemon
5494     * option, become a daemon. I.e. fork, detach
5495     * from tty and get process group leadership
5496     */
5497 #if defined(unix)
5498 {
5499    if (daemon_mode)
5500    {
5501       int fd;
5502       pid_t pid = fork();
5503
5504       if (pid < 0) /* error */
5505       {
5506          perror("fork");
5507          exit(3);
5508       }
5509       else if (pid != 0) /* parent */
5510       {
5511          int status;
5512          pid_t wpid;
5513          /*
5514           * must check for errors
5515           * child died due to missing files aso
5516           */
5517          sleep(1);
5518          wpid = waitpid(pid, &status, WNOHANG);
5519          if (wpid != 0)
5520          {
5521             exit(1);
5522          }
5523          exit(0);
5524       }
5525       /* child */
5526
5527       setsid();
5528
5529       /*
5530        * stderr (fd 2) will be closed later on,
5531        * when the config file has been parsed.
5532        */
5533       close(0);
5534       close(1);
5535
5536       /*
5537        * Reserve fd 0 and 1 to prevent abort() and friends
5538        * from sending stuff to the clients or servers.
5539        */
5540       fd = open("/dev/null", O_RDONLY);
5541       if (fd == -1)
5542       {
5543          log_error(LOG_LEVEL_FATAL, "Failed to open /dev/null: %E");
5544       }
5545       else if (fd != 0)
5546       {
5547          if (dup2(fd, 0) == -1)
5548          {
5549             log_error(LOG_LEVEL_FATAL, "Failed to reserve fd 0: %E");
5550          }
5551          close(fd);
5552       }
5553       fd = open("/dev/null", O_WRONLY);
5554       if (fd == -1)
5555       {
5556          log_error(LOG_LEVEL_FATAL, "Failed to open /dev/null: %E");
5557       }
5558       else if (fd != 1)
5559       {
5560          if (dup2(fd, 1) == -1)
5561          {
5562             log_error(LOG_LEVEL_FATAL, "Failed to reserve fd 1: %E");
5563          }
5564          close(fd);
5565       }
5566
5567 #ifdef FEATURE_EXTERNAL_FILTERS
5568       for (fd = 0; fd < 3; fd++)
5569       {
5570          mark_socket_for_close_on_execute(fd);
5571       }
5572 #endif
5573
5574       if (chdir("/") != 0)
5575       {
5576          log_error(LOG_LEVEL_FATAL, "Failed to cd into '/': %E");
5577       }
5578
5579    } /* -END- if (daemon_mode) */
5580
5581    /*
5582     * As soon as we have written the PID file, we can switch
5583     * to the user and group ID indicated by the --user option
5584     */
5585    if (pidfile != NULL)
5586    {
5587       write_pid_file(pidfile);
5588    }
5589    if (NULL != pw)
5590    {
5591       if (setgid((NULL != grp) ? grp->gr_gid : pw->pw_gid))
5592       {
5593          log_error(LOG_LEVEL_FATAL, "Cannot setgid(): Insufficient permissions.");
5594       }
5595       if (NULL != grp)
5596       {
5597          if (setgroups(1, &grp->gr_gid))
5598          {
5599             log_error(LOG_LEVEL_FATAL, "setgroups() failed: %E");
5600          }
5601       }
5602       else if (initgroups(pw->pw_name, pw->pw_gid))
5603       {
5604          log_error(LOG_LEVEL_FATAL, "initgroups() failed: %E");
5605       }
5606       if (do_chroot)
5607       {
5608          if (!pw->pw_dir)
5609          {
5610             log_error(LOG_LEVEL_FATAL, "Home directory for %s undefined", pw->pw_name);
5611          }
5612          /* Read the time zone file from /etc before doing chroot. */
5613          tzset();
5614          if (NULL != pre_chroot_nslookup_to_load_resolver
5615              && '\0' != pre_chroot_nslookup_to_load_resolver[0])
5616          {
5617             /* Initialize resolver library. */
5618             (void) resolve_hostname_to_ip(pre_chroot_nslookup_to_load_resolver);
5619          }
5620          if (chroot(pw->pw_dir) < 0)
5621          {
5622             log_error(LOG_LEVEL_FATAL, "Cannot chroot to %s", pw->pw_dir);
5623          }
5624          if (chdir ("/"))
5625          {
5626             log_error(LOG_LEVEL_FATAL, "Cannot chdir /");
5627          }
5628       }
5629       if (setuid(pw->pw_uid))
5630       {
5631          log_error(LOG_LEVEL_FATAL, "Cannot setuid(): Insufficient permissions.");
5632       }
5633       if (do_chroot)
5634       {
5635          char putenv_dummy[64];
5636
5637          strlcpy(putenv_dummy, "HOME=/", sizeof(putenv_dummy));
5638          if (putenv(putenv_dummy) != 0)
5639          {
5640             log_error(LOG_LEVEL_FATAL, "Cannot putenv(): HOME");
5641          }
5642
5643          snprintf(putenv_dummy, sizeof(putenv_dummy), "USER=%s", pw->pw_name);
5644          if (putenv(putenv_dummy) != 0)
5645          {
5646             log_error(LOG_LEVEL_FATAL, "Cannot putenv(): USER");
5647          }
5648       }
5649    }
5650    else if (do_chroot)
5651    {
5652       log_error(LOG_LEVEL_FATAL, "Cannot chroot without --user argument.");
5653    }
5654 }
5655 #endif /* defined unix */
5656
5657 #ifdef _WIN32
5658    /* This will be FALSE unless the command line specified --service
5659     */
5660    if (bRunAsService)
5661    {
5662       /* Yup, so now we must attempt to establish a connection
5663        * with the service dispatcher. This will only work if this
5664        * process was launched by the service control manager to
5665        * actually run as a service. If this isn't the case, i've
5666        * known it take around 30 seconds or so for the call to return.
5667        */
5668
5669       /* The StartServiceCtrlDispatcher won't return until the service is stopping */
5670       if (w32_start_service_ctrl_dispatcher(w32ServiceDispatchTable))
5671       {
5672          /* Service has run, and at this point is now being stopped, so just return */
5673          return 0;
5674       }
5675
5676 #ifdef _WIN_CONSOLE
5677       printf("Warning: Failed to connect to Service Control Dispatcher\nwhen starting as a service!\n");
5678 #endif
5679       /* An error occurred. Usually it's because --service was wrongly specified
5680        * and we were unable to connect to the Service Control Dispatcher because
5681        * it wasn't expecting us and is therefore not listening.
5682        *
5683        * For now, just continue below to call the listen_loop function.
5684        */
5685    }
5686 #endif /* def _WIN32 */
5687
5688    listen_loop();
5689
5690    /* NOTREACHED */
5691    return(-1);
5692
5693 }
5694
5695
5696 /*********************************************************************
5697  *
5698  * Function    :  bind_port_helper
5699  *
5700  * Description :  Bind the listen port.  Handles logging, and aborts
5701  *                on failure.
5702  *
5703  * Parameters  :
5704  *          1  :  haddr = Host address to bind to. Use NULL to bind to
5705  *                        INADDR_ANY.
5706  *          2  :  hport = Specifies port to bind to.
5707  *          3  :  backlog = Listen backlog.
5708  *
5709  * Returns     :  Port that was opened.
5710  *
5711  *********************************************************************/
5712 static jb_socket bind_port_helper(const char *haddr, int hport, int backlog)
5713 {
5714    int result;
5715    jb_socket bfd;
5716
5717    result = bind_port(haddr, hport, backlog, &bfd);
5718
5719    if (result < 0)
5720    {
5721       const char *bind_address = (NULL != haddr) ? haddr : "INADDR_ANY";
5722       switch(result)
5723       {
5724          case -3:
5725             log_error(LOG_LEVEL_FATAL,
5726                "can't bind to %s:%d: There may be another Privoxy "
5727                "or some other proxy running on port %d",
5728                bind_address, hport, hport);
5729
5730          case -2:
5731             log_error(LOG_LEVEL_FATAL,
5732                "can't bind to %s:%d: The hostname is not resolvable",
5733                bind_address, hport);
5734
5735          default:
5736             log_error(LOG_LEVEL_FATAL, "can't bind to %s:%d: %E",
5737                bind_address, hport);
5738       }
5739
5740       /* shouldn't get here */
5741       return JB_INVALID_SOCKET;
5742    }
5743
5744 #ifndef HAVE_POLL
5745 #ifndef _WIN32
5746    if (bfd >= FD_SETSIZE)
5747    {
5748       log_error(LOG_LEVEL_FATAL,
5749          "Bind socket number too high to use select(): %d >= %d",
5750          bfd, FD_SETSIZE);
5751    }
5752 #endif
5753 #endif
5754
5755    if (haddr == NULL)
5756    {
5757       log_error(LOG_LEVEL_INFO, "Listening on port %d on all IP addresses",
5758          hport);
5759    }
5760    else
5761    {
5762       log_error(LOG_LEVEL_INFO, "Listening on port %d on IP address %s",
5763          hport, haddr);
5764    }
5765
5766    return bfd;
5767 }
5768
5769
5770 /*********************************************************************
5771  *
5772  * Function    :  bind_ports_helper
5773  *
5774  * Description :  Bind the listen ports.  Handles logging, and aborts
5775  *                on failure.
5776  *
5777  * Parameters  :
5778  *          1  :  config = Privoxy configuration.  Specifies ports
5779  *                         to bind to.
5780  *          2  :  sockets = Preallocated array of opened sockets
5781  *                          corresponding to specification in config.
5782  *                          All non-opened sockets will be set to
5783  *                          JB_INVALID_SOCKET.
5784  *
5785  * Returns     :  Nothing. Inspect sockets argument.
5786  *
5787  *********************************************************************/
5788 static void bind_ports_helper(struct configuration_spec * config,
5789                               jb_socket sockets[])
5790 {
5791    int i;
5792
5793    for (i = 0; i < MAX_LISTENING_SOCKETS; i++)
5794    {
5795       if (config->hport[i])
5796       {
5797          sockets[i] = bind_port_helper(config->haddr[i],
5798             config->hport[i], config->listen_backlog);
5799 #if defined(FEATURE_ACCEPT_FILTER) && defined(SO_ACCEPTFILTER)
5800          if (config->enable_accept_filter && sockets[i] != JB_INVALID_SOCKET)
5801          {
5802             struct accept_filter_arg af_options;
5803             bzero(&af_options, sizeof(af_options));
5804             strlcpy(af_options.af_name, "httpready", sizeof(af_options.af_name));
5805             if (setsockopt(sockets[i], SOL_SOCKET, SO_ACCEPTFILTER, &af_options,
5806                   sizeof(af_options)))
5807             {
5808                log_error(LOG_LEVEL_ERROR,
5809                   "Enabling accept filter for socket %d failed: %E", sockets[i]);
5810             }
5811          }
5812 #endif
5813       }
5814       else
5815       {
5816          sockets[i] = JB_INVALID_SOCKET;
5817       }
5818    }
5819    config->need_bind = 0;
5820 }
5821
5822
5823 /*********************************************************************
5824  *
5825  * Function    :  close_ports_helper
5826  *
5827  * Description :  Close listenings ports.
5828  *
5829  * Parameters  :
5830  *          1  :  sockets = Array of opened and non-opened sockets to
5831  *                          close. All sockets will be set to
5832  *                          JB_INVALID_SOCKET.
5833  *
5834  * Returns     :  Nothing.
5835  *
5836  *********************************************************************/
5837 static void close_ports_helper(jb_socket sockets[])
5838 {
5839    int i;
5840
5841    for (i = 0; i < MAX_LISTENING_SOCKETS; i++)
5842    {
5843       if (JB_INVALID_SOCKET != sockets[i])
5844       {
5845          close_socket(sockets[i]);
5846       }
5847       sockets[i] = JB_INVALID_SOCKET;
5848    }
5849 }
5850
5851
5852 #ifdef _WIN32
5853 /* Without this simple workaround we get this compiler warning from _beginthread
5854  *     warning C4028: formal parameter 1 different from declaration
5855  */
5856 void w32_service_listen_loop(void *p)
5857 {
5858    listen_loop();
5859 }
5860 #endif /* def _WIN32 */
5861
5862
5863 /*********************************************************************
5864  *
5865  * Function    :  listen_loop
5866  *
5867  * Description :  bind the listen port and enter a "FOREVER" listening loop.
5868  *
5869  * Parameters  :  N/A
5870  *
5871  * Returns     :  Never.
5872  *
5873  *********************************************************************/
5874 static void listen_loop(void)
5875 {
5876    struct client_states *csp_list = NULL;
5877    struct client_state *csp = NULL;
5878    jb_socket bfds[MAX_LISTENING_SOCKETS];
5879    struct configuration_spec *config;
5880    unsigned int active_threads = 0;
5881 #if defined(FEATURE_PTHREAD)
5882    pthread_attr_t attrs;
5883
5884    pthread_attr_init(&attrs);
5885    pthread_attr_setdetachstate(&attrs, PTHREAD_CREATE_DETACHED);
5886 #endif
5887
5888    config = load_config();
5889
5890 #ifdef FEATURE_CONNECTION_SHARING
5891    /*
5892     * XXX: Should be relocated once it no
5893     * longer needs to emit log messages.
5894     */
5895    initialize_reusable_connections();
5896 #endif /* def FEATURE_CONNECTION_SHARING */
5897
5898    bind_ports_helper(config, bfds);
5899
5900 #ifdef FEATURE_GRACEFUL_TERMINATION
5901    while (!g_terminate)
5902 #else
5903    for (;;)
5904 #endif
5905    {
5906 #if !defined(FEATURE_PTHREAD) && !defined(_WIN32) && !defined(__BEOS__)
5907       while (waitpid(-1, NULL, WNOHANG) > 0)
5908       {
5909          /* zombie children */
5910       }
5911 #endif /* !defined(FEATURE_PTHREAD) && !defined(_WIN32) && !defined(__BEOS__) */
5912
5913       /*
5914        * Free data that was used by died threads
5915        */
5916       active_threads = sweep();
5917
5918 #if defined(unix)
5919       /*
5920        * Re-open the errlog after HUP signal
5921        */
5922       if (received_hup_signal)
5923       {
5924          if (NULL != config->logfile)
5925          {
5926             init_error_log(Argv[0], config->logfile);
5927          }
5928          received_hup_signal = 0;
5929       }
5930 #endif
5931
5932       csp_list = zalloc_or_die(sizeof(*csp_list));
5933       csp = &csp_list->csp;
5934
5935       log_error(LOG_LEVEL_CONNECT,
5936          "Waiting for the next client connection. Currently active threads: %u",
5937          active_threads);
5938
5939       /*
5940        * This config may be outdated, but for accept_connection()
5941        * it's fresh enough.
5942        */
5943       csp->config = config;
5944
5945       if (!accept_connection(csp, bfds))
5946       {
5947          log_error(LOG_LEVEL_CONNECT, "accept failed: %E");
5948          freez(csp_list);
5949          continue;
5950       }
5951
5952       csp->flags |= CSP_FLAG_ACTIVE;
5953       csp->server_connection.sfd = JB_INVALID_SOCKET;
5954
5955       csp->config = config = load_config();
5956
5957       if (config->need_bind)
5958       {
5959          /*
5960           * Since we were listening to the "old port", we will not see
5961           * a "listen" param change until the next request.  So, at
5962           * least 1 more request must be made for us to find the new
5963           * setting.  I am simply closing the old socket and binding the
5964           * new one.
5965           *
5966           * Which-ever is correct, we will serve 1 more page via the
5967           * old settings.  This should probably be a "show-status"
5968           * request.  This should not be a so common of an operation
5969           * that this will hurt people's feelings.
5970           */
5971
5972          close_ports_helper(bfds);
5973
5974          bind_ports_helper(config, bfds);
5975       }
5976
5977 #ifdef FEATURE_TOGGLE
5978       if (global_toggle_state)
5979 #endif /* def FEATURE_TOGGLE */
5980       {
5981          csp->flags |= CSP_FLAG_TOGGLED_ON;
5982       }
5983
5984       if (run_loader(csp))
5985       {
5986          log_error(LOG_LEVEL_FATAL, "a loader failed - must exit");
5987          /* Never get here - LOG_LEVEL_FATAL causes program exit */
5988       }
5989
5990 #ifdef FEATURE_ACL
5991       if (block_acl(NULL,csp))
5992       {
5993          log_error(LOG_LEVEL_CONNECT,
5994             "Connection from %s on %s (socket %d) dropped due to ACL",
5995             csp->ip_addr_str, csp->listen_addr_str, csp->cfd);
5996          close_socket(csp->cfd);
5997          freez(csp->ip_addr_str);
5998          freez(csp->listen_addr_str);
5999          freez(csp_list);
6000          continue;
6001       }
6002 #endif /* def FEATURE_ACL */
6003
6004       if ((0 != config->max_client_connections)
6005          && (active_threads >= config->max_client_connections))
6006       {
6007          log_error(LOG_LEVEL_CONNECT,
6008             "Rejecting connection from %s. Maximum number of connections reached.",
6009             csp->ip_addr_str);
6010          write_socket_delayed(csp->cfd, TOO_MANY_CONNECTIONS_RESPONSE,
6011             strlen(TOO_MANY_CONNECTIONS_RESPONSE), get_write_delay(csp));
6012          close_socket(csp->cfd);
6013          freez(csp->ip_addr_str);
6014          freez(csp->listen_addr_str);
6015          freez(csp_list);
6016          continue;
6017       }
6018
6019       /* add it to the list of clients */
6020       csp_list->next = clients->next;
6021       clients->next = csp_list;
6022
6023       if (config->multi_threaded)
6024       {
6025          int child_id;
6026
6027 /* this is a switch () statement in the C preprocessor - ugh */
6028 #undef SELECTED_ONE_OPTION
6029
6030 /* Use Pthreads in preference to native code */
6031 #if defined(FEATURE_PTHREAD) && !defined(SELECTED_ONE_OPTION)
6032 #define SELECTED_ONE_OPTION
6033          {
6034             pthread_t the_thread;
6035             int ret;
6036
6037             ret = pthread_create(&the_thread, &attrs,
6038                (void * (*)(void *))serve, csp);
6039             child_id = ret ? -1 : 0;
6040          }
6041 #endif
6042
6043 #if defined(_WIN32) && !defined(_CYGWIN) && !defined(SELECTED_ONE_OPTION)
6044 #define SELECTED_ONE_OPTION
6045          child_id = _beginthread(
6046             (void (*)(void *))serve,
6047             64 * 1024,
6048             csp);
6049 #endif
6050
6051 #if defined(__BEOS__) && !defined(SELECTED_ONE_OPTION)
6052 #define SELECTED_ONE_OPTION
6053          {
6054             thread_id tid = spawn_thread
6055                (server_thread, "server", B_NORMAL_PRIORITY, csp);
6056
6057             if ((tid >= 0) && (resume_thread(tid) == B_OK))
6058             {
6059                child_id = (int) tid;
6060             }
6061             else
6062             {
6063                child_id = -1;
6064             }
6065          }
6066 #endif
6067
6068 #if !defined(SELECTED_ONE_OPTION)
6069          child_id = fork();
6070
6071          /* This block is only needed when using fork().
6072           * When using threads, the server thread was
6073           * created and run by the call to _beginthread().
6074           */
6075          if (child_id == 0)   /* child */
6076          {
6077             int rc = 0;
6078 #ifdef FEATURE_TOGGLE
6079             int inherited_toggle_state = global_toggle_state;
6080 #endif /* def FEATURE_TOGGLE */
6081
6082             serve(csp);
6083
6084             /*
6085              * If we've been toggled or we've blocked the request, tell Mom
6086              */
6087
6088 #ifdef FEATURE_TOGGLE
6089             if (inherited_toggle_state != global_toggle_state)
6090             {
6091                rc |= RC_FLAG_TOGGLED;
6092             }
6093 #endif /* def FEATURE_TOGGLE */
6094
6095 #ifdef FEATURE_STATISTICS
6096             if (csp->flags & CSP_FLAG_REJECTED)
6097             {
6098                rc |= RC_FLAG_BLOCKED;
6099             }
6100 #endif /* ndef FEATURE_STATISTICS */
6101
6102             _exit(rc);
6103          }
6104          else if (child_id > 0) /* parent */
6105          {
6106             /* in a fork()'d environment, the parent's
6107              * copy of the client socket and the CSP
6108              * are not used.
6109              */
6110             int child_status;
6111 #if !defined(_WIN32) && !defined(__CYGWIN__)
6112
6113             wait(&child_status);
6114
6115             /*
6116              * Evaluate child's return code: If the child has
6117              *  - been toggled, toggle ourselves
6118              *  - blocked its request, bump up the stats counter
6119              */
6120
6121 #ifdef FEATURE_TOGGLE
6122             if (WIFEXITED(child_status) && (WEXITSTATUS(child_status) & RC_FLAG_TOGGLED))
6123             {
6124                global_toggle_state = !global_toggle_state;
6125             }
6126 #endif /* def FEATURE_TOGGLE */
6127
6128 #ifdef FEATURE_STATISTICS
6129             urls_read++;
6130             if (WIFEXITED(child_status) && (WEXITSTATUS(child_status) & RC_FLAG_BLOCKED))
6131             {
6132                urls_rejected++;
6133             }
6134 #endif /* def FEATURE_STATISTICS */
6135
6136 #endif /* !defined(_WIN32) && defined(__CYGWIN__) */
6137             close_socket(csp->cfd);
6138             csp->flags &= ~CSP_FLAG_ACTIVE;
6139          }
6140 #endif
6141
6142 #undef SELECTED_ONE_OPTION
6143 /* end of cpp switch () */
6144
6145          if (child_id < 0)
6146          {
6147             /*
6148              * Spawning the child failed, assume it's because
6149              * there are too many children running already.
6150              * XXX: If you assume ...
6151              */
6152             log_error(LOG_LEVEL_ERROR,
6153                "Unable to take any additional connections: %E. Active threads: %u",
6154                active_threads);
6155             write_socket_delayed(csp->cfd, TOO_MANY_CONNECTIONS_RESPONSE,
6156                strlen(TOO_MANY_CONNECTIONS_RESPONSE), get_write_delay(csp));
6157             close_socket(csp->cfd);
6158             csp->flags &= ~CSP_FLAG_ACTIVE;
6159          }
6160       }
6161       else
6162       {
6163          serve(csp);
6164       }
6165    }
6166
6167 #if defined(FEATURE_PTHREAD)
6168    pthread_attr_destroy(&attrs);
6169 #endif
6170
6171    /* NOTREACHED unless FEATURE_GRACEFUL_TERMINATION is defined */
6172
6173 #ifdef FEATURE_HTTPS_INSPECTION
6174    /* Clean up.  Aim: free all memory (no leaks) */
6175    ssl_release();
6176 #endif
6177
6178 #ifdef FEATURE_GRACEFUL_TERMINATION
6179
6180    log_error(LOG_LEVEL_INFO, "Graceful termination requested");
6181
6182    unload_current_config_file();
6183    unload_current_actions_file();
6184    unload_current_re_filterfile();
6185 #ifdef FEATURE_TRUST
6186    unload_current_trust_file();
6187 #endif
6188
6189    if (config->multi_threaded)
6190    {
6191       int i = 60;
6192       do
6193       {
6194          sleep(1);
6195          sweep();
6196       } while ((clients->next != NULL) && (--i > 0));
6197
6198       if (i <= 0)
6199       {
6200          log_error(LOG_LEVEL_ERROR, "Graceful termination failed - still some live clients after 1 minute wait.");
6201       }
6202    }
6203    sweep();
6204    sweep();
6205
6206 #if defined(unix)
6207    freez(basedir);
6208 #endif
6209
6210 #if defined(_WIN32) && !defined(_WIN_CONSOLE)
6211    /* Cleanup - remove taskbar icon etc. */
6212    TermLogWindow();
6213 #endif
6214
6215    exit(0);
6216 #endif /* FEATURE_GRACEFUL_TERMINATION */
6217
6218 }
6219
6220
6221 /*
6222   Local Variables:
6223   tab-width: 3
6224   end:
6225 */