Added event wrapper around request_free
[freeradius.git] / src / main / event.c
1 /*
2  * event.c      Server event handling
3  *
4  * Version:     $Id$
5  *
6  *   This program is free software; you can redistribute it and/or modify
7  *   it under the terms of the GNU General Public License as published by
8  *   the Free Software Foundation; either version 2 of the License, or
9  *   (at your option) any later version.
10  *
11  *   This program is distributed in the hope that it will be useful,
12  *   but WITHOUT ANY WARRANTY; without even the implied warranty of
13  *   MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
14  *   GNU General Public License for more details.
15  *
16  *   You should have received a copy of the GNU General Public License
17  *   along with this program; if not, write to the Free Software
18  *   Foundation, Inc., 51 Franklin St, Fifth Floor, Boston, MA 02110-1301, USA
19  *
20  * Copyright 2007  The FreeRADIUS server project
21  * Copyright 2007  Alan DeKok <aland@deployingradius.com>
22  */
23
24 #include <freeradius-devel/ident.h>
25 RCSID("$Id$")
26
27 #include <freeradius-devel/radiusd.h>
28 #include <freeradius-devel/modules.h>
29 #include <freeradius-devel/event.h>
30 #include <freeradius-devel/detail.h>
31
32 #include <freeradius-devel/rad_assert.h>
33
34 #include <signal.h>
35 #include <fcntl.h>
36
37 #ifdef HAVE_SYS_WAIT_H
38 #       include <sys/wait.h>
39 #endif
40
41 #define USEC (1000000)
42
43 extern pid_t radius_pid;
44 extern int dont_fork;
45 extern int check_config;
46 extern void force_log_reopen(void);
47 extern char *debug_condition;
48
49 /*
50  *      Ridiculous amounts of local state.
51  */
52 static fr_event_list_t  *el = NULL;
53 static fr_packet_list_t *pl = NULL;
54 static int                      request_num_counter = 0;
55 static struct timeval           now;
56 time_t                          fr_start_time;
57 static int                      have_children;
58 static int                      just_started = TRUE;
59
60 #ifndef __MINGW32__
61 #ifdef HAVE_PTHREAD_H
62 #define WITH_SELF_PIPE (1)
63 #endif
64 #endif
65
66 #ifdef WITH_SELF_PIPE
67 static int self_pipe[2];
68 #endif
69
70 #ifdef HAVE_PTHREAD_H
71 #ifdef WITH_PROXY
72 static pthread_mutex_t  proxy_mutex;
73 #endif
74
75 #define PTHREAD_MUTEX_LOCK if (have_children) pthread_mutex_lock
76 #define PTHREAD_MUTEX_UNLOCK if (have_children) pthread_mutex_unlock
77
78 static pthread_t NO_SUCH_CHILD_PID;
79 #else
80 /*
81  *      This is easier than ifdef's throughout the code.
82  */
83 #define PTHREAD_MUTEX_LOCK(_x)
84 #define PTHREAD_MUTEX_UNLOCK(_x)
85 int thread_pool_addrequest(REQUEST *request, RAD_REQUEST_FUNP fun)
86 {
87         radius_handle_request(request, fun);
88         return 1;
89 }
90 #endif
91
92 #define INSERT_EVENT(_function, _ctx) if (!fr_event_insert(el, _function, _ctx, &((_ctx)->when), &((_ctx)->ev))) { _rad_panic(__FILE__, __LINE__, "Failed to insert event"); }
93
94 #ifdef WITH_PROXY
95 static fr_packet_list_t *proxy_list = NULL;
96
97 /*
98  *      We keep the proxy FD's here.  The RADIUS Id's are marked
99  *      "allocated" per Id, via a bit per proxy FD.
100  */
101 static int              proxy_fds[32];
102 static rad_listen_t     *proxy_listeners[32];
103 #else
104 #define remove_from_proxy_hash(foo)
105 #endif
106
107 static void request_post_handler(REQUEST *request);
108 static void wait_a_bit(void *ctx);
109 static void event_socket_handler(fr_event_list_t *xel, UNUSED int fd, void *ctx);
110 #ifdef WITH_DETAIL
111 static void event_poll_detail(void *ctx);
112 #endif
113
114 static void NEVER_RETURNS _rad_panic(const char *file, unsigned int line,
115                                     const char *msg)
116 {
117         radlog(L_ERR, "[%s:%d] %s", file, line, msg);
118         _exit(1);
119 }
120
121 #define rad_panic(x) _rad_panic(__FILE__, __LINE__, x)
122
123
124 static void tv_add(struct timeval *tv, int usec_delay)
125 {
126         if (usec_delay > USEC) {
127                 tv->tv_sec += usec_delay / USEC;
128                 usec_delay %= USEC;
129         }
130         tv->tv_usec += usec_delay;
131
132         if (tv->tv_usec > USEC) {
133                 tv->tv_usec -= USEC;
134                 tv->tv_sec++;
135         }
136 }
137
138 static void remove_from_request_hash(REQUEST *request)
139 {
140         if (!request->in_request_hash) return;
141
142         fr_packet_list_yank(pl, request->packet);
143         request->in_request_hash = FALSE;
144
145         request_stats_final(request);
146 }
147
148
149 #ifdef WITH_PROXY
150 static REQUEST *lookup_in_proxy_hash(RADIUS_PACKET *reply)
151 {
152         RADIUS_PACKET **proxy_p;
153         REQUEST *request;
154
155         PTHREAD_MUTEX_LOCK(&proxy_mutex);
156         proxy_p = fr_packet_list_find_byreply(proxy_list, reply);
157
158         if (!proxy_p) {
159                 PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
160                 return NULL;
161         }
162
163         request = fr_packet2myptr(REQUEST, proxy, proxy_p);
164
165         if (!request) {
166                 PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
167                 return NULL;
168         }
169
170         request->num_proxied_responses++;
171
172         /*
173          *      Catch the most common case of everything working
174          *      correctly.
175          */
176         if (request->num_proxied_requests == request->num_proxied_responses) {
177                 fr_packet_list_yank(proxy_list, request->proxy);
178                 fr_packet_list_id_free(proxy_list, request->proxy);
179                 request->in_proxy_hash = FALSE;
180         }
181
182         /*
183          *      On the FIRST reply, decrement the count of outstanding
184          *      requests.  Note that this is NOT the count of sent
185          *      packets, but whether or not the home server has
186          *      responded at all.
187          */
188         if (!request->proxy_reply &&
189             request->home_server &&
190             request->home_server->currently_outstanding) {
191                 request->home_server->currently_outstanding--;
192         }
193
194         PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
195
196         return request;
197 }
198
199
200 static void remove_from_proxy_hash(REQUEST *request)
201 {
202         /*
203          *      Check this without grabbing the mutex because it's a
204          *      lot faster that way.
205          */
206         if (!request->in_proxy_hash) return;
207
208         /*
209          *      The "not in hash" flag is definitive.  However, if the
210          *      flag says that it IS in the hash, there might still be
211          *      a race condition where it isn't.
212          */
213         PTHREAD_MUTEX_LOCK(&proxy_mutex);
214
215         if (!request->in_proxy_hash) {
216                 PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
217                 return;
218         }
219
220         fr_packet_list_yank(proxy_list, request->proxy);
221         fr_packet_list_id_free(proxy_list, request->proxy);
222
223         /*
224          *      The home server hasn't replied, but we've given up on
225          *      this request.  Don't count this request against the
226          *      home server.
227          */
228         if (!request->proxy_reply &&
229             request->home_server &&
230             request->home_server->currently_outstanding) {
231                 request->home_server->currently_outstanding--;
232         }
233
234         /*
235          *      Got from YES in hash, to NO, not in hash while we hold
236          *      the mutex.  This guarantees that when another thread
237          *      grans the mutex, the "not in hash" flag is correct.
238          */
239         request->in_proxy_hash = FALSE;
240
241         PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
242 }
243
244 static void ev_request_free(REQUEST **prequest)
245 {
246         REQUEST *request;
247         
248         if (!prequest || !*prequest) return;
249
250         request = *prequest;
251
252 #ifdef WITH_COA
253         if (request->coa) {
254                 /*
255                  *      Divorce the child from the parent first,
256                  *      then clean up the child.
257                  */
258                 request->coa->parent = NULL;
259                 ev_request_free(&request->coa);
260         }
261
262         /*
263          *      Divorce the parent from the child, and leave the
264          *      parent still alive.
265          */
266         if (request->parent && (request->parent->coa == request)) {
267                 request->parent->coa = NULL;
268         }
269 #endif
270
271         if (request->ev) fr_event_delete(el, &request->ev);
272         if (request->in_proxy_hash) remove_from_proxy_hash(request);
273         if (request->in_request_hash) remove_from_request_hash(request);
274
275         request_free(prequest);
276 }
277
278 static int proxy_id_alloc(REQUEST *request, RADIUS_PACKET *packet)
279 {
280         int i, proxy, found;
281         rad_listen_t *proxy_listener;
282
283         if (fr_packet_list_id_alloc(proxy_list, packet)) return 1;
284
285         /*
286          *      Allocate a new proxy fd.  This function adds
287          *      it to the tail of the list of listeners.  With
288          *      some care, this can be thread-safe.
289          */
290         proxy_listener = proxy_new_listener();
291         if (!proxy_listener) {
292                 RDEBUG2("ERROR: Failed to create a new socket for proxying requests.");
293                 return 0;
294         }
295         
296         /*
297          *      Cache it locally.
298          */
299         found = -1;
300         proxy = proxy_listener->fd;
301         for (i = 0; i < 32; i++) {
302                 /*
303                  *      Found a free entry.  Save the socket,
304                  *      and remember where we saved it.
305                  */
306                 if (proxy_fds[(proxy + i) & 0x1f] == -1) {
307                         found = (proxy + i) & 0x1f;
308                         proxy_fds[found] = proxy;
309                         proxy_listeners[found] = proxy_listener;
310                         break;
311                 }
312         }
313         rad_assert(found >= 0);
314         
315         if (!fr_packet_list_socket_add(proxy_list, proxy_listener->fd)) {
316                         RDEBUG2("ERROR: Failed to create a new socket for proxying requests.");
317                 return 0;
318                 
319         }
320         
321         if (!fr_packet_list_id_alloc(proxy_list, packet)) {
322                         RDEBUG2("ERROR: Failed to create a new socket for proxying requests.");
323                 return 0;
324         }
325         
326         /*
327          *      Signal the main thread to add the new FD to the list
328          *      of listening FD's.
329          */
330         radius_signal_self(RADIUS_SIGNAL_SELF_NEW_FD);
331         return 1;
332 }
333
334
335 static int insert_into_proxy_hash(REQUEST *request, int retransmit)
336 {
337         int i, proxy;
338         char buf[128];
339
340         rad_assert(request->proxy != NULL);
341         rad_assert(proxy_list != NULL);
342
343         PTHREAD_MUTEX_LOCK(&proxy_mutex);
344
345         /*
346          *      Keep track of maximum outstanding requests to a
347          *      particular home server.  'max_outstanding' is
348          *      enforced in home_server_ldb(), in realms.c.
349          */
350         if (request->home_server) {
351                 request->home_server->currently_outstanding++;
352                 request->home_server->stats.total_requests++;
353         }
354
355         if (retransmit) {
356                 RADIUS_PACKET packet;
357
358                 packet = *request->proxy;
359
360                 if (!proxy_id_alloc(request, &packet)) {
361                         PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
362                         return 0;
363                 }
364
365                 /*
366                  *      Yank the request, free the old Id, and
367                  *      remember the new Id.
368                  */
369                 fr_packet_list_yank(proxy_list, request->proxy);
370                 fr_packet_list_id_free(proxy_list, request->proxy);
371                 *request->proxy = packet;
372
373         } else if (!proxy_id_alloc(request, request->proxy)) {
374                 PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
375                 return 0;
376         }
377
378         rad_assert(request->proxy->sockfd >= 0);
379
380         /*
381          *      FIXME: Hack until we get rid of rad_listen_t, and put
382          *      the information into the packet_list.
383          */
384         proxy = -1;
385         for (i = 0; i < 32; i++) {
386                 if (proxy_fds[i] == request->proxy->sockfd) {
387                         proxy = i;
388                         break;
389                 }
390         }
391
392         if (proxy < 0) {
393                 PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
394                 RDEBUG2("ERROR: All sockets are full.");
395                 return 0;
396         }
397
398         rad_assert(proxy_fds[proxy] != -1);
399         rad_assert(proxy_listeners[proxy] != NULL);
400         request->proxy_listener = proxy_listeners[proxy];
401
402         if (!fr_packet_list_insert(proxy_list, &request->proxy)) {
403                 fr_packet_list_id_free(proxy_list, request->proxy);
404                 PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
405                 RDEBUG2("ERROR: Failed to insert entry into proxy list");
406                 return 0;
407         }
408
409         request->in_proxy_hash = TRUE;
410
411         PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
412
413         RDEBUG3(" proxy: allocating destination %s port %d - Id %d",
414                inet_ntop(request->proxy->dst_ipaddr.af,
415                          &request->proxy->dst_ipaddr.ipaddr, buf, sizeof(buf)),
416                request->proxy->dst_port,
417                request->proxy->id);
418
419         return 1;
420 }
421
422
423 /*
424  *      Called as BOTH an event, and in-line from other functions.
425  */
426 static void wait_for_proxy_id_to_expire(void *ctx)
427 {
428         REQUEST *request = ctx;
429
430         rad_assert(request->magic == REQUEST_MAGIC);
431         rad_assert(request->proxy != NULL);
432
433         if (!fr_event_now(el, &now)) gettimeofday(&now, NULL);
434         request->when = request->proxy_when;
435
436 #ifdef WITH_COA
437         if ((request->proxy->code == PW_COA_REQUEST) ||
438             (request->proxy->code == PW_DISCONNECT_REQUEST)) {
439                 request->when.tv_sec += request->home_server->coa_mrd;
440         } else
441 #endif
442         request->when.tv_sec += request->home_server->response_window;
443
444         if ((request->num_proxied_requests == request->num_proxied_responses) ||
445             timercmp(&now, &request->when, >)) {
446                 if (request->packet) {
447                         RDEBUG2("Cleaning up request %d ID %d with timestamp +%d",
448                                request->number, request->packet->id,
449                                (unsigned int) (request->timestamp - fr_start_time));
450                 } else {
451                         RDEBUG2("Cleaning up request %d with timestamp +%d",
452                                request->number,
453                                (unsigned int) (request->timestamp - fr_start_time));
454                 }
455
456                 ev_request_free(&request);
457                 return;
458         }
459
460         INSERT_EVENT(wait_for_proxy_id_to_expire, request);
461 }
462 #endif
463
464 #ifdef HAVE_PTHREAD_H
465 static void wait_for_child_to_die(void *ctx)
466 {
467         REQUEST *request = ctx;
468
469         rad_assert(request->magic == REQUEST_MAGIC);
470
471         if ((request->child_state == REQUEST_QUEUED) |
472             (request->child_state == REQUEST_RUNNING)) {
473                 request->delay += (request->delay >> 1);
474                 tv_add(&request->when, request->delay);
475
476                 RDEBUG2("Child is still stuck for request %d", request->number);
477
478                 INSERT_EVENT(wait_for_child_to_die, request);
479                 return;
480         }
481
482         RDEBUG2("Child is finally responsive for request %d", request->number);
483         remove_from_request_hash(request);
484
485 #ifdef WITH_PROXY
486         if (request->proxy) {
487                 wait_for_proxy_id_to_expire(request);
488                 return;
489         }
490 #endif
491
492         ev_request_free(&request);
493 }
494 #endif
495
496 static void cleanup_delay(void *ctx)
497 {
498         REQUEST *request = ctx;
499
500         rad_assert(request->magic == REQUEST_MAGIC);
501         rad_assert((request->child_state == REQUEST_CLEANUP_DELAY) ||
502                    (request->child_state == REQUEST_DONE));
503
504         remove_from_request_hash(request);
505
506 #ifdef WITH_PROXY
507         if (request->proxy && request->in_proxy_hash) {
508                 wait_for_proxy_id_to_expire(request);
509                 return;
510         }
511 #endif
512
513         RDEBUG2("Cleaning up request %d ID %d with timestamp +%d",
514                request->number, request->packet->id,
515                (unsigned int) (request->timestamp - fr_start_time));
516
517         ev_request_free(&request);
518 }
519
520
521 /*
522  *      FIXME: Put into a libradius function.
523  */
524 #define MAX_PACKET_CODE (52)
525 static const char *packet_codes[] = {
526   "",
527   "Access-Request",
528   "Access-Accept",
529   "Access-Reject",
530   "Accounting-Request",
531   "Accounting-Response",
532   "Accounting-Status",
533   "Password-Request",
534   "Password-Accept",
535   "Password-Reject",
536   "Accounting-Message",
537   "Access-Challenge",
538   "Status-Server",
539   "Status-Client",
540   "14",
541   "15",
542   "16",
543   "17",
544   "18",
545   "19",
546   "20",
547   "Resource-Free-Request",
548   "Resource-Free-Response",
549   "Resource-Query-Request",
550   "Resource-Query-Response",
551   "Alternate-Resource-Reclaim-Request",
552   "NAS-Reboot-Request",
553   "NAS-Reboot-Response",
554   "28",
555   "Next-Passcode",
556   "New-Pin",
557   "Terminate-Session",
558   "Password-Expired",
559   "Event-Request",
560   "Event-Response",
561   "35",
562   "36",
563   "37",
564   "38",
565   "39",
566   "Disconnect-Request",
567   "Disconnect-ACK",
568   "Disconnect-NAK",
569   "CoA-Request",
570   "CoA-ACK",
571   "CoA-NAK",
572   "46",
573   "47",
574   "48",
575   "49",
576   "IP-Address-Allocate",
577   "IP-Address-Release"
578 };
579
580
581 /*
582  *      In daemon mode, AND this request has debug flags set.
583  */
584 #define DEBUG_PACKET if (!debug_flag && request->options && request->radlog) debug_packet
585
586 static void debug_packet(REQUEST *request, RADIUS_PACKET *packet, int direction)
587 {
588         VALUE_PAIR *vp;
589         char buffer[1024];
590         const char *received, *from;
591         const fr_ipaddr_t *ip;
592         int port;
593
594         if (!packet) return;
595
596         rad_assert(debug_flag != 0);
597         rad_assert(request->radlog != NULL);
598
599         if (direction == 0) {
600                 received = "Received";
601                 from = "from";  /* what else? */
602                 ip = &packet->src_ipaddr;
603                 port = packet->src_port;
604
605         } else {
606                 received = "Sending";
607                 from = "to";    /* hah! */
608                 ip = &packet->dst_ipaddr;
609                 port = packet->dst_port;
610         }
611         
612         /*
613          *      Client-specific debugging re-prints the input
614          *      packet into the client log.
615          *
616          *      This really belongs in a utility library
617          */
618         if ((packet->code > 0) && (packet->code < MAX_PACKET_CODE)) {
619                 RDEBUG("%s %s packet %s host %s port %d, id=%d, length=%d",
620                        received, packet_codes[packet->code], from,
621                        inet_ntop(ip->af, &ip->ipaddr, buffer, sizeof(buffer)),
622                        port, packet->id, packet->data_len);
623         } else {
624                 RDEBUG("%s packet %s host %s port %d code=%d, id=%d, length=%d",
625                        received, from,
626                        inet_ntop(ip->af, &ip->ipaddr, buffer, sizeof(buffer)),
627                        port,
628                        packet->code, packet->id, packet->data_len);
629         }
630
631         for (vp = packet->vps; vp != NULL; vp = vp->next) {
632                 vp_prints(buffer, sizeof(buffer), vp);
633                 request->radlog(L_DBG, 0, request, "\t%s", buffer);
634         }
635 }
636
637 static void reject_delay(void *ctx)
638 {
639         REQUEST *request = ctx;
640
641         rad_assert(request->magic == REQUEST_MAGIC);
642         rad_assert(request->child_state == REQUEST_REJECT_DELAY);
643
644         RDEBUG2("Sending delayed reject for request %d", request->number);
645
646         DEBUG_PACKET(request, request->reply, 1);
647
648         request->listener->send(request->listener, request);
649
650         request->when.tv_sec += request->root->cleanup_delay;
651         request->child_state = REQUEST_CLEANUP_DELAY;
652
653         INSERT_EVENT(cleanup_delay, request);
654 }
655
656
657 #ifdef WITH_PROXY
658 void revive_home_server(void *ctx)
659 {
660         home_server *home = ctx;
661         char buffer[128];
662
663         home->state = HOME_STATE_ALIVE;
664         home->currently_outstanding = 0;
665         home->revive_time = now;
666
667         /*
668          *      Delete any outstanding events.
669          */
670         if (home->ev) fr_event_delete(el, &home->ev);
671
672         radlog(L_INFO, "PROXY: Marking home server %s port %d alive again... we have no idea if it really is alive or not.",
673                inet_ntop(home->ipaddr.af, &home->ipaddr.ipaddr,
674                          buffer, sizeof(buffer)),
675                home->port);
676
677 }
678
679
680 static void no_response_to_ping(void *ctx)
681 {
682         REQUEST *request = ctx;
683         home_server *home;
684         char buffer[128];
685
686         rad_assert(request->home_server != NULL);
687
688         home = request->home_server;
689         home->num_received_pings = 0;
690
691         RDEBUG2("No response to status check %d from home server %s port %d",
692                request->number,
693                inet_ntop(request->proxy->dst_ipaddr.af,
694                          &request->proxy->dst_ipaddr.ipaddr,
695                          buffer, sizeof(buffer)),
696                request->proxy->dst_port);
697
698         wait_for_proxy_id_to_expire(request);
699 }
700
701
702 static void received_response_to_ping(REQUEST *request)
703 {
704         home_server *home;
705         char buffer[128];
706
707         rad_assert(request->home_server != NULL);
708
709         if (rad_verify(request->proxy_reply, request->proxy,
710                        request->home_server->secret) != 0) {
711                 DEBUG("Ignoring spoofed proxy reply.  Signature is invalid");
712                 return;
713         }
714                 
715         home = request->home_server;
716         home->num_received_pings++;
717
718         RDEBUG2("Received response to status check %d (%d in current sequence)",
719                request->number, home->num_received_pings);
720
721         /*
722          *      Remove the request from any hashes
723          */
724         fr_event_delete(el, &request->ev);
725         remove_from_proxy_hash(request);
726         rad_assert(request->in_request_hash == FALSE);
727
728         /*
729          *      The control socket may have marked the home server as
730          *      alive.  OR, it may have suddenly started responding to
731          *      requests again.  If so, don't re-do the "make alive"
732          *      work.
733          */
734         if (home->state == HOME_STATE_ALIVE) return;
735
736         /*
737          *      We haven't received enough ping responses to mark it
738          *      "alive".  Wait a bit.
739          */
740         if (home->num_received_pings < home->num_pings_to_alive) {
741                 return;
742         }
743
744         home->state = HOME_STATE_ALIVE;
745         home->currently_outstanding = 0;
746         home->revive_time = now;
747
748         if (!fr_event_delete(el, &home->ev)) {
749                 RDEBUG2("Hmm... no event for home server.  Oh well.");
750         }
751
752         radlog(L_INFO, "PROXY: Marking home server %s port %d alive",
753                inet_ntop(request->proxy->dst_ipaddr.af,
754                          &request->proxy->dst_ipaddr.ipaddr,
755                          buffer, sizeof(buffer)),
756                request->proxy->dst_port);
757 }
758
759
760 /*
761  *      Called from start of zombie period, OR after control socket
762  *      marks the home server dead.
763  */
764 static void ping_home_server(void *ctx)
765 {
766         uint32_t jitter;
767         home_server *home = ctx;
768         REQUEST *request;
769         VALUE_PAIR *vp;
770
771         if (home->state == HOME_STATE_ALIVE) {
772                 radlog(L_INFO, "Suspicious proxy state... continuing");
773                 return;
774         }
775
776         request = request_alloc();
777         request->number = request_num_counter++;
778
779         request->proxy = rad_alloc(1);
780         rad_assert(request->proxy != NULL);
781
782         fr_event_now(el, &request->when);
783         home->when = request->when;
784
785         if (home->ping_check == HOME_PING_CHECK_STATUS_SERVER) {
786                 request->proxy->code = PW_STATUS_SERVER;
787
788                 radius_pairmake(request, &request->proxy->vps,
789                                 "Message-Authenticator", "0x00", T_OP_SET);
790
791         } else if (home->type == HOME_TYPE_AUTH) {
792                 request->proxy->code = PW_AUTHENTICATION_REQUEST;
793
794                 radius_pairmake(request, &request->proxy->vps,
795                                 "User-Name", home->ping_user_name, T_OP_SET);
796                 radius_pairmake(request, &request->proxy->vps,
797                                 "User-Password", home->ping_user_password, T_OP_SET);
798                 radius_pairmake(request, &request->proxy->vps,
799                                 "Service-Type", "Authenticate-Only", T_OP_SET);
800                 radius_pairmake(request, &request->proxy->vps,
801                                 "Message-Authenticator", "0x00", T_OP_SET);
802
803         } else {
804 #ifdef WITH_ACCOUNTING
805                 request->proxy->code = PW_ACCOUNTING_REQUEST;
806                 
807                 radius_pairmake(request, &request->proxy->vps,
808                                 "User-Name", home->ping_user_name, T_OP_SET);
809                 radius_pairmake(request, &request->proxy->vps,
810                                 "Acct-Status-Type", "Stop", T_OP_SET);
811                 radius_pairmake(request, &request->proxy->vps,
812                                 "Acct-Session-Id", "00000000", T_OP_SET);
813                 vp = radius_pairmake(request, &request->proxy->vps,
814                                      "Event-Timestamp", "0", T_OP_SET);
815                 vp->vp_date = now.tv_sec;
816 #else
817                 rad_assert("Internal sanity check failed");
818 #endif
819         }
820
821         radius_pairmake(request, &request->proxy->vps,
822                         "NAS-Identifier", "Status Check. Are you alive?",
823                         T_OP_SET);
824
825         request->proxy->dst_ipaddr = home->ipaddr;
826         request->proxy->dst_port = home->port;
827         request->home_server = home;
828
829         rad_assert(request->proxy_listener == NULL);
830
831         if (!insert_into_proxy_hash(request, FALSE)) {
832                 RDEBUG2("ERROR: Failed inserting status check %d into proxy hash.  Discarding it.",
833                        request->number);
834                 ev_request_free(&request);
835                 return;
836         }
837         rad_assert(request->proxy_listener != NULL);
838         request->proxy_listener->send(request->proxy_listener,
839                                       request);
840
841         request->next_callback = NULL;
842         request->child_state = REQUEST_PROXIED;
843         request->when.tv_sec += home->ping_timeout;;
844
845         INSERT_EVENT(no_response_to_ping, request);
846
847         /*
848          *      Add +/- 2s of jitter, as suggested in RFC 3539
849          *      and in the Issues and Fixes draft.
850          */
851         home->when.tv_sec += home->ping_interval - 2;
852
853         jitter = fr_rand();
854         jitter ^= (jitter >> 10);
855         jitter &= ((1 << 23) - 1); /* 22 bits of 1 */
856
857         tv_add(&home->when, jitter);
858
859         INSERT_EVENT(ping_home_server, home);
860 }
861
862
863 void mark_home_server_dead(home_server *home, struct timeval *when)
864 {
865         int previous_state = home->state;
866         char buffer[128];
867
868         radlog(L_INFO, "PROXY: Marking home server %s port %d as dead.",
869                inet_ntop(home->ipaddr.af, &home->ipaddr.ipaddr,
870                          buffer, sizeof(buffer)),
871                home->port);
872
873         home->state = HOME_STATE_IS_DEAD;
874         home->num_received_pings = 0;
875
876         if (home->ping_check != HOME_PING_CHECK_NONE) {
877                 /*
878                  *      If the control socket marks us dead, start
879                  *      pinging.  Otherwise, we already started
880                  *      pinging when it was marked "zombie".
881                  */
882                 if (previous_state == HOME_STATE_ALIVE) {
883                         ping_home_server(home);
884                 }
885
886         } else {
887                 /*
888                  *      Revive it after a fixed period of time.  This
889                  *      is very, very, bad.
890                  */
891                 home->when = *when;
892                 home->when.tv_sec += home->revive_interval;
893
894                 INSERT_EVENT(revive_home_server, home);
895         }
896 }
897
898 static void check_for_zombie_home_server(REQUEST *request)
899 {
900         home_server *home;
901         struct timeval when;
902
903         home = request->home_server;
904
905         if (home->state != HOME_STATE_ZOMBIE) return;
906
907         when = home->zombie_period_start;
908         when.tv_sec += home->zombie_period;
909
910         fr_event_now(el, &now);
911         if (timercmp(&now, &when, <)) {
912                 return;
913         }
914
915         mark_home_server_dead(home, &request->when);
916 }
917
918 static int proxy_to_virtual_server(REQUEST *request);
919
920 static int virtual_server_handler(UNUSED REQUEST *request)
921 {
922         proxy_to_virtual_server(request);
923         return 0;
924 }
925
926 static void proxy_fallback_handler(REQUEST *request)
927 {
928         /*
929          *      A proper time is required for wait_a_bit.
930          */
931         request->delay = USEC / 10;
932         gettimeofday(&now, NULL);
933         request->next_when = now;
934         tv_add(&request->next_when, request->delay);
935         request->next_callback = wait_a_bit;
936
937         /*
938          *      Re-queue the request.
939          */
940         request->child_state = REQUEST_QUEUED;
941         
942         rad_assert(request->proxy != NULL);
943         if (!thread_pool_addrequest(request, virtual_server_handler)) {
944                 request->child_state = REQUEST_DONE;
945         }
946
947 #ifdef HAVE_PTHREAD_H
948         /*
949          *      MAY free the request if we're over max_request_time,
950          *      AND we're not in threaded mode!
951          *
952          *      Note that we call this ONLY if we're threaded, as
953          *      if we're NOT threaded, request_post_handler() calls
954          *      wait_a_bit(), which means that "request" may not
955          *      exist any more...
956          */
957         if (have_children) wait_a_bit(request);
958 #endif
959 }
960
961
962 static int setup_post_proxy_fail(REQUEST *request)
963 {
964         DICT_VALUE *dval = NULL;
965         VALUE_PAIR *vp;
966
967         if (request->packet->code == PW_AUTHENTICATION_REQUEST) {
968                 dval = dict_valbyname(PW_POST_PROXY_TYPE, "Fail-Authentication");
969
970         } else if (request->packet->code == PW_ACCOUNTING_REQUEST) {
971                 dval = dict_valbyname(PW_POST_PROXY_TYPE, "Fail-Accounting");
972
973 #ifdef WITH_COA
974                 /*
975                  *      See no_response_to_coa_request
976                  */
977         } else if (((request->packet->code >> 8) & 0xff) == PW_COA_REQUEST) {
978                 request->packet->code &= 0xff; /* restore it */
979
980                 if (request->proxy->code == PW_COA_REQUEST) {
981                         dval = dict_valbyname(PW_POST_PROXY_TYPE, "Fail-CoA");
982
983                 } else if (request->proxy->code == PW_DISCONNECT_REQUEST) {
984                         dval = dict_valbyname(PW_POST_PROXY_TYPE, "Fail-Disconnect");
985                 } else {
986                         return 0;
987                 }
988
989 #endif
990         } else {
991                 return 0;
992         }
993
994         if (!dval) dval = dict_valbyname(PW_POST_PROXY_TYPE, "Fail");
995
996         if (!dval) {
997                 pairdelete(&request->config_items, PW_POST_PROXY_TYPE);
998                 return 0;
999         }
1000
1001         vp = pairfind(request->config_items, PW_POST_PROXY_TYPE);
1002         if (!vp) vp = radius_paircreate(request, &request->config_items,
1003                                         PW_POST_PROXY_TYPE, PW_TYPE_INTEGER);
1004         vp->vp_integer = dval->value;
1005
1006         rad_assert(request->proxy_reply == NULL);
1007
1008         return 1;
1009 }
1010
1011
1012 static int null_handler(UNUSED REQUEST *request)
1013 {
1014         return 0;
1015 }
1016
1017 static void post_proxy_fail_handler(REQUEST *request)
1018 {
1019         /*
1020          *      A proper time is required for wait_a_bit.
1021          */
1022         request->delay = USEC / 10;
1023         gettimeofday(&now, NULL);
1024
1025         /*
1026          *      Not set up to run Post-Proxy-Type = Fail.
1027          *
1028          *      Mark the request as still running, and figure out what
1029          *      to do next.
1030          */
1031         if (!setup_post_proxy_fail(request)) {
1032                 request->child_state = REQUEST_RUNNING;
1033                 request_post_handler(request);
1034
1035         } else {
1036                 /*
1037                  *      Re-queue the request.
1038                  */
1039                 request->child_state = REQUEST_QUEUED;
1040
1041                 /*
1042                  *      There is a post-proxy-type of fail.  We run
1043                  *      the request through the pre/post proxy
1044                  *      handlers, just like it was a real proxied
1045                  *      request.  However, we set the per-request
1046                  *      handler to NULL, as we don't want to do
1047                  *      anything else.
1048                  *
1049                  *      Note that when we're not threaded, this will
1050                  *      process the request even if it's greater than
1051                  *      max_request_time.  That's not fatal.
1052                  */
1053                 request->priority = 0;
1054                 rad_assert(request->proxy != NULL);
1055                 thread_pool_addrequest(request, null_handler);
1056         }
1057
1058         /*
1059          *      MAY free the request if we're over max_request_time,
1060          *      AND we're not in threaded mode!
1061          *
1062          *      Note that we call this ONLY if we're threaded, as
1063          *      if we're NOT threaded, request_post_handler() calls
1064          *      wait_a_bit(), which means that "request" may not
1065          *      exist any more...
1066          */
1067         if (have_children) wait_a_bit(request);
1068 }
1069
1070
1071 /* maybe check this against wait_for_proxy_id_to_expire? */
1072 static void no_response_to_proxied_request(void *ctx)
1073 {
1074         REQUEST *request = ctx;
1075         home_server *home;
1076         char buffer[128];
1077
1078         rad_assert(request->magic == REQUEST_MAGIC);
1079         rad_assert(request->child_state == REQUEST_PROXIED);
1080
1081         /*
1082          *      If we've failed over to an internal home server,
1083          *      replace the callback with the correct one.  This
1084          *      is due to locking issues with child threads...
1085          */
1086         if (request->home_server->server) {
1087                 wait_a_bit(request);
1088                 return;
1089         }
1090
1091         radlog(L_ERR, "Rejecting request %d due to lack of any response from home server %s port %d",
1092                request->number,
1093                inet_ntop(request->proxy->dst_ipaddr.af,
1094                          &request->proxy->dst_ipaddr.ipaddr,
1095                          buffer, sizeof(buffer)),
1096                request->proxy->dst_port);
1097
1098         check_for_zombie_home_server(request);
1099
1100         home = request->home_server;
1101
1102         post_proxy_fail_handler(request);
1103
1104         /*
1105          *      Don't touch request due to race conditions
1106          */
1107         if (home->state == HOME_STATE_IS_DEAD) {
1108                 rad_assert(home->ev != NULL); /* or it will never wake up */
1109                 return;
1110         }
1111
1112         /*
1113          *      Enable the zombie period when we notice that the home
1114          *      server hasn't responded.  We do NOT back-date the start
1115          *      of the zombie period.
1116          */
1117         if (home->state == HOME_STATE_ALIVE) {
1118                 radlog(L_ERR, "PROXY: Marking home server %s port %d as zombie (it looks like it is dead).",
1119                        inet_ntop(home->ipaddr.af, &home->ipaddr.ipaddr,
1120                                  buffer, sizeof(buffer)),
1121                        home->port);
1122                 home->state = HOME_STATE_ZOMBIE;
1123                 home->zombie_period_start = now;
1124
1125                 /*
1126                  *      Start pinging the home server.
1127                  */
1128                 ping_home_server(home);
1129         }
1130 }
1131 #endif
1132
1133 static void wait_a_bit(void *ctx)
1134 {
1135         struct timeval when;
1136         REQUEST *request = ctx;
1137         fr_event_callback_t callback = NULL;
1138
1139         rad_assert(request->magic == REQUEST_MAGIC);
1140
1141 #ifdef WITH_COA
1142         /*
1143          *      The CoA request is a new (internally generated)
1144          *      request, created in a child thread.  We therefore need
1145          *      some way to tie its events back into the main event
1146          *      handler.
1147          */
1148         if (request->coa && !request->coa->proxy_reply &&
1149             request->coa->next_callback) {
1150                 request->coa->when = request->coa->next_when;
1151                 INSERT_EVENT(request->coa->next_callback, request->coa);
1152                 request->coa->next_callback = NULL;
1153                 request->coa->parent = NULL;
1154                 request->coa = NULL;
1155         }
1156 #endif
1157
1158         switch (request->child_state) {
1159         case REQUEST_QUEUED:
1160         case REQUEST_RUNNING:
1161                 when = request->received;
1162                 when.tv_sec += request->root->max_request_time;
1163
1164                 /*
1165                  *      Normally called from the event loop with the
1166                  *      proper event loop time.  Otherwise, called from
1167                  *      post proxy fail handler, which sets "now", and
1168                  *      this call won't re-set it, because we're not
1169                  *      in the event loop.
1170                  */
1171                 fr_event_now(el, &now);
1172
1173                 /*
1174                  *      Request still has more time.  Continue
1175                  *      waiting.
1176                  */
1177                 if (timercmp(&now, &when, <) ||
1178                     ((request->listener->type == RAD_LISTEN_DETAIL) &&
1179                      (request->child_state == REQUEST_QUEUED))) {
1180                         if (request->delay < (USEC / 10)) {
1181                                 request->delay = USEC / 10;
1182                         }
1183                         request->delay += request->delay >> 1;
1184
1185 #ifdef WITH_DETAIL
1186                         /*
1187                          *      Cap wait at some sane value for detail
1188                          *      files.
1189                          */
1190                         if ((request->listener->type == RAD_LISTEN_DETAIL) &&
1191                             (request->delay > (request->root->max_request_time * USEC))) {
1192                                 request->delay = request->root->max_request_time * USEC;
1193                         }
1194 #endif
1195
1196                         request->when = now;
1197                         tv_add(&request->when, request->delay);
1198                         callback = wait_a_bit;
1199                         break;
1200                 }
1201
1202 #if defined(HAVE_PTHREAD_H)
1203                 /*
1204                  *      A child thread MAY still be running on the
1205                  *      request.  Ask the thread to stop working on
1206                  *      the request.
1207                  */
1208                 if (have_children) {
1209                         /* FIXME: kill unresponsive children? */
1210
1211                         /*
1212                          *      Print this error message ONLY if
1213                          *      there's a child currently processing
1214                          *      the request.  As we don't have thread
1215                          *      locks here, there may be race
1216                          *      conditions on this check.  But it's
1217                          *      just an error message, so that's OK.
1218                          */
1219                         if (!pthread_equal(request->child_pid, NO_SUCH_CHILD_PID)) {
1220                                 radlog(L_ERR, "WARNING: Unresponsive child for request %d, in module %s component %s",
1221                                        request->number,
1222                                        request->module ? request->module : "<server core>",
1223                                        request->component ? request->component : "<server core>");
1224                         }
1225
1226                         request->master_state = REQUEST_STOP_PROCESSING;
1227                         
1228                         request->delay = USEC / 4;
1229                         tv_add(&request->when, request->delay);
1230                         callback = wait_for_child_to_die;
1231                         break;
1232                 }
1233 #endif
1234
1235                 /*
1236                  *      Else there are no child threads.  We probably
1237                  *      should have just marked the request as 'done'
1238                  *      elsewhere, like in the post-proxy-fail
1239                  *      handler.  But doing that would involve
1240                  *      checking for max_request_time in multiple
1241                  *      places, so this may be simplest.
1242                  */
1243                 request->child_state = REQUEST_DONE;
1244                 /* FALL-THROUGH */
1245
1246                 /*
1247                  *      Mark the request as no longer running,
1248                  *      and clean it up.
1249                  */
1250         case REQUEST_DONE:
1251 #ifdef HAVE_PTHREAD_H
1252                 request->child_pid = NO_SUCH_CHILD_PID;
1253 #endif
1254
1255 #ifdef WTH_COA
1256                 /*
1257                  *      This is a CoA request.  It's been divorced
1258                  *      from everything else, so we clean it up now.
1259                  */
1260                 if (!request->in_request_hash &&
1261                     request->proxy &&
1262                     (request->packet->code != request->proxy->code) &&
1263                     ((request->proxy->code == PW_COA_REQUEST) ||
1264                      (request->proxy->code == PW_DISCONNECT_REQUEST))) {
1265                         /*
1266                          *      FIXME: Do CoA MIBs
1267                          */
1268                         ev_request_free(&request);
1269                         return;
1270                 }
1271 #endif
1272                 request_stats_final(request);
1273                 cleanup_delay(request);
1274                 return;
1275
1276         case REQUEST_REJECT_DELAY:
1277         case REQUEST_CLEANUP_DELAY:
1278 #ifdef HAVE_PTHREAD_H
1279                 request->child_pid = NO_SUCH_CHILD_PID;
1280 #endif
1281                 request_stats_final(request);
1282
1283         case REQUEST_PROXIED:
1284                 rad_assert(request->next_callback != NULL);
1285                 rad_assert(request->next_callback != wait_a_bit);
1286
1287                 request->when = request->next_when;
1288                 callback = request->next_callback;
1289                 request->next_callback = NULL;
1290                 break;
1291
1292         default:
1293                 rad_panic("Internal sanity check failure");
1294                 return;
1295         }
1296
1297         /*
1298          *      Something major went wrong.  Discard the request, and
1299          *      keep running.
1300          *
1301          *      FIXME: No idea why this happens or how to fix it...
1302          *      It seems to happen *only* when requests are proxied,
1303          *      and where the home server doesn't respond.  So it looks
1304          *      like a race condition above, but it happens in debug
1305          *      mode, with no threads...
1306          */
1307         if (!callback) {
1308                 RDEBUG("WARNING: Internal sanity check failed in event handler for request %d: Discarding the request!", request->number);
1309                 ev_request_free(&request);
1310                 return;
1311         }
1312
1313         INSERT_EVENT(callback, request);
1314 }
1315
1316 #ifdef WITH_COA
1317 static void no_response_to_coa_request(void *ctx)
1318 {
1319         REQUEST *request = ctx;
1320         char buffer[128];
1321
1322         rad_assert(request->magic == REQUEST_MAGIC);
1323         rad_assert(request->child_state == REQUEST_PROXIED);
1324         rad_assert(request->home_server != NULL);
1325         rad_assert(!request->in_request_hash);
1326
1327         radlog(L_ERR, "No response to CoA request sent to %s",
1328                inet_ntop(request->proxy->dst_ipaddr.af,
1329                          &request->proxy->dst_ipaddr.ipaddr,
1330                          buffer, sizeof(buffer)));
1331
1332         /*
1333          *      Hack.
1334          */
1335         request->packet->code |= (PW_COA_REQUEST << 8);
1336         post_proxy_fail_handler(request);
1337 }
1338
1339
1340 static int update_event_timestamp(RADIUS_PACKET *packet, time_t when)
1341 {
1342         VALUE_PAIR *vp;
1343
1344         vp = pairfind(packet->vps, PW_EVENT_TIMESTAMP);
1345         if (!vp) return 0;
1346
1347         vp->vp_date = when;
1348
1349         if (packet->data) {
1350                 free(packet->data);
1351                 packet->data = NULL;
1352                 packet->data_len = 0;
1353         }
1354
1355         return 1;               /* time stamp updated */
1356 }
1357
1358
1359 /*
1360  *      Called when we haven't received a response to a CoA request.
1361  */
1362 static void retransmit_coa_request(void *ctx)
1363 {
1364         int delay, frac;
1365         struct timeval mrd;
1366         REQUEST *request = ctx;
1367
1368         rad_assert(request->magic == REQUEST_MAGIC);
1369         rad_assert(request->child_state == REQUEST_PROXIED);
1370         rad_assert(request->home_server != NULL);
1371         rad_assert(!request->in_request_hash);
1372         rad_assert(request->parent == NULL);
1373         
1374         fr_event_now(el, &now);
1375
1376         /*
1377          *      Cap count at MRC, if it is non-zero.
1378          */
1379         if (request->home_server->coa_mrc &&
1380             (request->num_coa_requests >= request->home_server->coa_mrc)) {
1381                 no_response_to_coa_request(request);
1382                 return;
1383         }
1384
1385         /*
1386          *      RFC 5080 Section 2.2.1
1387          *
1388          *      RT = 2*RTprev + RAND*RTprev
1389          *         = 1.9 * RTprev + rand(0,.2) * RTprev
1390          *         = 1.9 * RTprev + rand(0,1) * (RTprev / 5)
1391          */
1392         delay = fr_rand();
1393         delay ^= (delay >> 16);
1394         delay &= 0xffff;
1395         frac = request->delay / 5;
1396         delay = ((frac >> 16) * delay) + (((frac & 0xffff) * delay) >> 16);
1397
1398         delay += (2 * request->delay) - (request->delay / 10);
1399
1400         /*
1401          *      Cap delay at MRT, if MRT is non-zero.
1402          */
1403         if (request->home_server->coa_mrt &&
1404             (delay > (request->home_server->coa_mrt * USEC))) {
1405                 int mrt_usec = request->home_server->coa_mrt * USEC;
1406
1407                 /*
1408                  *      delay = MRT + RAND * MRT
1409                  *            = 0.9 MRT + rand(0,.2)  * MRT
1410                  */
1411                 delay = fr_rand();
1412                 delay ^= (delay >> 15);
1413                 delay &= 0x1ffff;
1414                 delay = ((mrt_usec >> 16) * delay) + (((mrt_usec & 0xffff) * delay) >> 16);
1415                 delay += mrt_usec - (mrt_usec / 10);
1416         }
1417
1418         request->delay = delay;
1419         request->when = now;
1420         tv_add(&request->when, request->delay);
1421         mrd = request->proxy_when;
1422         mrd.tv_sec += request->home_server->coa_mrd;
1423
1424         /*
1425          *      Cap duration at MRD.
1426          */
1427         if (timercmp(&mrd, &request->when, <)) {
1428                 request->when = mrd;
1429                 INSERT_EVENT(no_response_to_coa_request, request);
1430
1431         } else {
1432                 INSERT_EVENT(retransmit_coa_request, request);
1433         }
1434         
1435         if (update_event_timestamp(request->proxy, now.tv_sec)) {
1436                 if (!insert_into_proxy_hash(request, TRUE)) {
1437                         DEBUG("ERROR: Failed re-inserting CoA request into proxy hash.");
1438                         return;
1439                 }
1440
1441                 request->num_proxied_requests = 0;
1442                 request->num_proxied_responses = 0;
1443         }
1444
1445         request->num_proxied_requests++;
1446         request->num_coa_requests++; /* is NOT reset by code 3 lines above! */
1447
1448         request->proxy_listener->send(request->proxy_listener,
1449                                       request);
1450 }
1451
1452
1453 /*
1454  *      The original request is either DONE, or in CLEANUP_DELAY.
1455  */
1456 static int originated_coa_request(REQUEST *request)
1457 {
1458         int delay, rcode, pre_proxy_type = 0;
1459         VALUE_PAIR *vp;
1460         REQUEST *coa;
1461         fr_ipaddr_t ipaddr;
1462         char buffer[256];
1463
1464         rad_assert(request->proxy == NULL);
1465         rad_assert(!request->in_proxy_hash);
1466         rad_assert(request->proxy_reply == NULL);
1467
1468         vp = pairfind(request->config_items, PW_SEND_COA_REQUEST);
1469         if (!vp && request->coa) vp = pairfind(request->coa->proxy->vps, PW_SEND_COA_REQUEST);
1470         if (vp) {
1471                 if (vp->vp_integer == 0) {
1472                         ev_request_free(&request->coa);
1473                         return 1;       /* success */
1474                 }
1475
1476                 if (!request->coa) request_alloc_coa(request);
1477                 if (!request->coa) return 0;
1478         }
1479
1480         coa = request->coa;
1481
1482         /*
1483          *      src_ipaddr will be set up in proxy_encode.
1484          */
1485         memset(&ipaddr, 0, sizeof(ipaddr));
1486         vp = pairfind(coa->proxy->vps, PW_PACKET_DST_IP_ADDRESS);
1487         if (vp) {
1488                 ipaddr.af = AF_INET;
1489                 ipaddr.ipaddr.ip4addr.s_addr = vp->vp_ipaddr;
1490
1491         } else if ((vp = pairfind(coa->proxy->vps,
1492                                   PW_PACKET_DST_IPV6_ADDRESS)) != NULL) {
1493                 ipaddr.af = AF_INET6;
1494                 ipaddr.ipaddr.ip6addr = vp->vp_ipv6addr;
1495                 
1496         } else if ((vp = pairfind(coa->proxy->vps,
1497                                   PW_HOME_SERVER_POOL)) != NULL) {
1498                 coa->home_pool = home_pool_byname(vp->vp_strvalue,
1499                                                   HOME_TYPE_COA);
1500                 if (!coa->home_pool) {
1501                         RDEBUG2("WARNING: No such home_server_pool %s",
1502                                vp->vp_strvalue);
1503         fail:
1504                         ev_request_free(&request->coa);
1505                         return 0;
1506                 }
1507
1508                 /*
1509                  *      Prefer
1510                  */
1511         } else if (request->client->coa_pool) {
1512                 coa->home_pool = request->client->coa_pool;
1513
1514         } else if (request->client->coa_server) {
1515                 coa->home_server = request->client->coa_server;
1516
1517         } else {
1518                 /*
1519                  *      If all else fails, send it to the client that
1520                  *      originated this request.
1521                  */
1522                 memcpy(&ipaddr, &request->packet->src_ipaddr, sizeof(ipaddr));
1523         }
1524
1525         /*
1526          *      Use the pool, if it exists.
1527          */
1528         if (coa->home_pool) {
1529                 coa->home_server = home_server_ldb(NULL, coa->home_pool, coa);
1530                 if (!coa->home_server) {
1531                         RDEBUG("WARNING: No live home server for home_server_pool %s", vp->vp_strvalue);
1532                         goto fail;
1533                 }
1534
1535         } else if (!coa->home_server) {
1536                 int port = PW_COA_UDP_PORT;
1537
1538                 vp = pairfind(coa->proxy->vps, PW_PACKET_DST_PORT);
1539                 if (vp) port = vp->vp_integer;
1540
1541                 coa->home_server = home_server_find(&ipaddr, port);
1542                 if (!coa->home_server) {
1543                         RDEBUG2("WARNING: Unknown destination %s:%d for CoA request.",
1544                                inet_ntop(ipaddr.af, &ipaddr.ipaddr,
1545                                          buffer, sizeof(buffer)), port);
1546                         goto fail;
1547                 }
1548         }
1549
1550         vp = pairfind(coa->proxy->vps, PW_PACKET_TYPE);
1551         if (vp) {
1552                 switch (vp->vp_integer) {
1553                 case PW_COA_REQUEST:
1554                 case PW_DISCONNECT_REQUEST:
1555                         coa->proxy->code = vp->vp_integer;
1556                         break;
1557                         
1558                 default:
1559                         DEBUG("Cannot set CoA Packet-Type to code %d",
1560                               vp->vp_integer);
1561                         goto fail;
1562                 }
1563         }
1564
1565         if (!coa->proxy->code) coa->proxy->code = PW_COA_REQUEST;
1566
1567         /*
1568          *      The rest of the server code assumes that
1569          *      request->packet && request->reply exist.  Copy them
1570          *      from the original request.
1571          */
1572         rad_assert(coa->packet != NULL);
1573         rad_assert(coa->packet->vps == NULL);
1574         memcpy(coa->packet, request->packet, sizeof(*request->packet));
1575         coa->packet->vps = paircopy(request->packet->vps);
1576         coa->packet->data = NULL;
1577         rad_assert(coa->reply != NULL);
1578         rad_assert(coa->reply->vps == NULL);
1579         memcpy(coa->reply, request->reply, sizeof(*request->reply));
1580         coa->reply->vps = paircopy(request->reply->vps);
1581         coa->reply->data = NULL;
1582         coa->config_items = paircopy(request->config_items);
1583
1584         /*
1585          *      Call the pre-proxy routines.
1586          */
1587         vp = pairfind(request->config_items, PW_PRE_PROXY_TYPE);
1588         if (vp) {
1589                 RDEBUG2("  Found Pre-Proxy-Type %s", vp->vp_strvalue);
1590                 pre_proxy_type = vp->vp_integer;
1591         }
1592
1593         if (coa->home_pool && coa->home_pool->virtual_server) {
1594                 const char *old_server = coa->server;
1595                 
1596                 coa->server = coa->home_pool->virtual_server;
1597                 RDEBUG2(" server %s {", coa->server);
1598                 rcode = module_pre_proxy(pre_proxy_type, coa);
1599                 RDEBUG2(" }");
1600                 coa->server = old_server;
1601         } else {
1602                 rcode = module_pre_proxy(pre_proxy_type, coa);
1603         }
1604         switch (rcode) {
1605         default:
1606                 goto fail;
1607
1608         /*
1609          *      Only send the CoA packet if the pre-proxy code succeeded.
1610          */
1611         case RLM_MODULE_NOOP:
1612         case RLM_MODULE_OK:
1613         case RLM_MODULE_UPDATED:
1614                 break;
1615         }
1616
1617         /*
1618          *      Source IP / port is set when the proxy socket
1619          *      is chosen.
1620          */
1621         coa->proxy->dst_ipaddr = coa->home_server->ipaddr;
1622         coa->proxy->dst_port = coa->home_server->port;
1623
1624         if (!insert_into_proxy_hash(coa, FALSE)) {
1625                 DEBUG("ERROR: Failed inserting CoA request into proxy hash.");
1626                 goto fail;
1627         }
1628
1629         /*
1630          *      We CANNOT divorce the CoA request from the parent
1631          *      request.  This function is running in a child thread,
1632          *      and we need access to the main event loop in order to
1633          *      to add the timers for the CoA packet.  See
1634          *      wait_a_bit().
1635          */
1636
1637         /*
1638          *      Forget about the original request completely at this
1639          *      point.
1640          */
1641         request = coa;
1642
1643         gettimeofday(&request->proxy_when, NULL);       
1644         request->received = request->next_when = request->proxy_when;
1645         rad_assert(request->proxy_reply == NULL);
1646
1647         /*
1648          *      Implement re-transmit algorithm as per RFC 5080
1649          *      Section 2.2.1.
1650          *
1651          *      We want IRT + RAND*IRT
1652          *      or 0.9 IRT + rand(0,.2) IRT
1653          *
1654          *      2^20 ~ USEC, and we want 2.
1655          *      rand(0,0.2) USEC ~ (rand(0,2^21) / 10)
1656          */
1657         delay = (fr_rand() & ((1 << 22) - 1)) / 10;
1658         request->delay = delay * request->home_server->coa_irt;
1659         delay = request->home_server->coa_irt * USEC;
1660         delay -= delay / 10;
1661         delay += request->delay;
1662      
1663         request->delay = delay;
1664         tv_add(&request->next_when, delay);
1665         request->next_callback = retransmit_coa_request;
1666         
1667         /*
1668          *      Note that we set proxied BEFORE sending the packet.
1669          *
1670          *      Once we send it, the request is tainted, as
1671          *      another thread may have picked it up.  Don't
1672          *      touch it!
1673          */
1674         request->num_proxied_requests = 1;
1675         request->num_proxied_responses = 0;
1676         request->child_pid = NO_SUCH_CHILD_PID;
1677
1678         update_event_timestamp(request->proxy, request->proxy_when.tv_sec);
1679
1680         request->child_state = REQUEST_PROXIED;
1681
1682         DEBUG_PACKET(request, request->proxy, 1);
1683
1684         request->proxy_listener->send(request->proxy_listener,
1685                                       request);
1686         return 1;
1687 }
1688 #endif  /* WITH_COA */
1689
1690 #ifdef WITH_PROXY
1691 static int process_proxy_reply(REQUEST *request)
1692 {
1693         int rcode;
1694         int post_proxy_type = 0;
1695         VALUE_PAIR *vp;
1696         
1697         /*
1698          *      Delete any reply we had accumulated until now.
1699          */
1700         pairfree(&request->reply->vps);
1701         
1702         /*
1703          *      Run the packet through the post-proxy stage,
1704          *      BEFORE playing games with the attributes.
1705          */
1706         vp = pairfind(request->config_items, PW_POST_PROXY_TYPE);
1707         if (vp) {
1708                 RDEBUG2("  Found Post-Proxy-Type %s", vp->vp_strvalue);
1709                 post_proxy_type = vp->vp_integer;
1710         }
1711         
1712         if (request->home_pool && request->home_pool->virtual_server) {
1713                 const char *old_server = request->server;
1714                 
1715                 request->server = request->home_pool->virtual_server;
1716                 RDEBUG2(" server %s {", request->server);
1717                 rcode = module_post_proxy(post_proxy_type, request);
1718                 RDEBUG2(" }");
1719                 request->server = old_server;
1720         } else {
1721                 rcode = module_post_proxy(post_proxy_type, request);
1722         }
1723
1724 #ifdef WITH_COA
1725         if (request->packet->code == request->proxy->code)
1726           /*
1727            *    Don't run the next bit if we originated a CoA
1728            *    packet, after receiving an Access-Request or
1729            *    Accounting-Request.
1730            */
1731 #endif
1732         
1733         /*
1734          *      There may NOT be a proxy reply, as we may be
1735          *      running Post-Proxy-Type = Fail.
1736          */
1737         if (request->proxy_reply) {
1738                 /*
1739                  *      Delete the Proxy-State Attributes from
1740                  *      the reply.  These include Proxy-State
1741                  *      attributes from us and remote server.
1742                  */
1743                 pairdelete(&request->proxy_reply->vps, PW_PROXY_STATE);
1744                 
1745                 /*
1746                  *      Add the attributes left in the proxy
1747                  *      reply to the reply list.
1748                  */
1749                 pairadd(&request->reply->vps, request->proxy_reply->vps);
1750                 request->proxy_reply->vps = NULL;
1751                 
1752                 /*
1753                  *      Free proxy request pairs.
1754                  */
1755                 pairfree(&request->proxy->vps);
1756         }
1757         
1758         switch (rcode) {
1759         default:  /* Don't do anything */
1760                 break;
1761         case RLM_MODULE_FAIL:
1762                 /* FIXME: debug print stuff */
1763                 request->child_state = REQUEST_DONE;
1764                 return 0;
1765                 
1766         case RLM_MODULE_HANDLED:
1767                 /* FIXME: debug print stuff */
1768                 request->child_state = REQUEST_DONE;
1769                 return 0;
1770         }
1771
1772         return 1;
1773 }
1774 #endif
1775
1776 static int request_pre_handler(REQUEST *request)
1777 {
1778         int rcode;
1779
1780         rad_assert(request->magic == REQUEST_MAGIC);
1781         rad_assert(request->packet != NULL);
1782
1783         request->child_state = REQUEST_RUNNING;
1784
1785         /*
1786          *      Don't decode the packet if it's an internal "fake"
1787          *      request.  Instead, just return so that the caller can
1788          *      process it.
1789          */
1790         if (request->packet->dst_port == 0) {
1791                 request->username = pairfind(request->packet->vps,
1792                                              PW_USER_NAME);
1793                 request->password = pairfind(request->packet->vps,
1794                                              PW_USER_PASSWORD);
1795                 return 1;
1796         }
1797
1798 #ifdef WITH_PROXY
1799         /*
1800          *      Put the decoded packet into it's proper place.
1801          */
1802         if (request->proxy_reply != NULL) {
1803                 rcode = request->proxy_listener->decode(request->proxy_listener,
1804                                                         request);
1805                 DEBUG_PACKET(request, request->proxy_reply, 0);
1806         } else
1807 #endif
1808         if (request->packet->vps == NULL) {
1809                 rcode = request->listener->decode(request->listener, request);
1810                 
1811                 if (debug_condition) {
1812                         int result = FALSE;
1813                         const char *my_debug = debug_condition;
1814
1815                         /*
1816                          *      Ignore parse errors.
1817                          */
1818                         radius_evaluate_condition(request, RLM_MODULE_OK, 0,
1819                                                   &my_debug, 1,
1820                                                   &result);
1821                         if (result) {
1822                                 request->options = 2;
1823                                 request->radlog = radlog_request;
1824                         }
1825                 }
1826                 
1827                 DEBUG_PACKET(request, request->packet, 0);
1828         } else {
1829                 rcode = 0;
1830         }
1831
1832         if (rcode < 0) {
1833                 radlog(L_ERR, "%s Dropping packet without response.", fr_strerror());
1834                 request->child_state = REQUEST_DONE;
1835                 return 0;
1836         }
1837
1838         if (!request->username) {
1839                 request->username = pairfind(request->packet->vps,
1840                                              PW_USER_NAME);
1841         }
1842
1843 #ifdef WITH_PROXY
1844         if (request->proxy) {
1845                 return process_proxy_reply(request);
1846 #endif
1847         }
1848
1849         return 1;
1850 }
1851
1852
1853 #ifdef WITH_PROXY
1854 /*
1855  *      Do state handling when we proxy a request.
1856  */
1857 static int proxy_request(REQUEST *request)
1858 {
1859         struct timeval when;
1860         char buffer[128];
1861
1862         if (request->home_server->server) {
1863                 RDEBUG("ERROR: Cannot perform real proxying to a virtual server.");
1864                 return 0;
1865         }
1866
1867         if (!insert_into_proxy_hash(request, FALSE)) {
1868                 RDEBUG("ERROR: Failed inserting request into proxy hash.");
1869                 return 0;
1870         }
1871
1872         request->proxy_listener->encode(request->proxy_listener, request);
1873
1874         when = request->received;
1875         when.tv_sec += request->root->max_request_time;
1876
1877         gettimeofday(&request->proxy_when, NULL);
1878
1879         request->next_when = request->proxy_when;
1880         request->next_when.tv_sec += request->home_server->response_window;
1881
1882         rad_assert(request->home_server->response_window > 0);
1883
1884         if (timercmp(&when, &request->next_when, <)) {
1885                 request->next_when = when;
1886         }
1887         request->next_callback = no_response_to_proxied_request;
1888
1889         RDEBUG2("Proxying request %d to home server %s port %d",
1890                request->number,
1891                inet_ntop(request->proxy->dst_ipaddr.af,
1892                          &request->proxy->dst_ipaddr.ipaddr,
1893                          buffer, sizeof(buffer)),
1894                request->proxy->dst_port);
1895
1896         /*
1897          *      Note that we set proxied BEFORE sending the packet.
1898          *
1899          *      Once we send it, the request is tainted, as
1900          *      another thread may have picked it up.  Don't
1901          *      touch it!
1902          */
1903         request->num_proxied_requests = 1;
1904         request->num_proxied_responses = 0;
1905 #ifdef HAVE_PTHREAD_H
1906         request->child_pid = NO_SUCH_CHILD_PID;
1907 #endif
1908         request->child_state = REQUEST_PROXIED;
1909
1910         DEBUG_PACKET(request, request->proxy, 1);
1911
1912         request->proxy_listener->send(request->proxy_listener,
1913                                       request);
1914         return 1;
1915 }
1916
1917
1918 /*
1919  *      "Proxy" the request by sending it to a new virtual server.
1920  */
1921 static int proxy_to_virtual_server(REQUEST *request)
1922 {
1923         REQUEST *fake;
1924         RAD_REQUEST_FUNP fun;
1925
1926         if (!request->home_server || !request->home_server->server) return 0;
1927
1928         if (request->parent) {
1929                 RDEBUG2("WARNING: Cancelling proxy request to virtual server %s as this request was itself proxied.", request->home_server->server);
1930                 return 0;
1931         }
1932
1933         fake = request_alloc_fake(request);
1934         if (!fake) {
1935                 RDEBUG2("WARNING: Out of memory");
1936                 return 0;
1937         }
1938
1939         fake->packet->vps = paircopy(request->proxy->vps);
1940         fake->server = request->home_server->server;
1941
1942         if (request->proxy->code == PW_AUTHENTICATION_REQUEST) {
1943                 fun = rad_authenticate;
1944
1945 #ifdef WITH_ACCOUNTING
1946         } else if (request->proxy->code == PW_ACCOUNTING_REQUEST) {
1947                 fun = rad_accounting;
1948 #endif
1949
1950         } else {
1951                 RDEBUG2("Unknown packet type %d", request->proxy->code);
1952                 ev_request_free(&fake);
1953                 return 0;
1954         }
1955
1956         RDEBUG2(">>> Sending proxied request internally to virtual server.");
1957         radius_handle_request(fake, fun);
1958         RDEBUG2("<<< Received proxied response from internal virtual server.");
1959
1960         request->proxy_reply = fake->reply;
1961         fake->reply = NULL;
1962
1963         ev_request_free(&fake);
1964
1965         process_proxy_reply(request);
1966
1967         if (request->server) RDEBUG("server %s {",
1968                                     request->server != NULL ?
1969                                     request->server : ""); 
1970         fun(request);
1971         
1972         if (request->server) RDEBUG("} # server %s",
1973                                     request->server != NULL ?
1974                                     request->server : "");
1975
1976         return 2;               /* success, but NOT '1' !*/
1977 }
1978
1979 /*
1980  *      Return 1 if we did proxy it, or the proxy attempt failed
1981  *      completely.  Either way, the caller doesn't touch the request
1982  *      any more if we return 1.
1983  */
1984 static int successfully_proxied_request(REQUEST *request)
1985 {
1986         int rcode;
1987         int pre_proxy_type = 0;
1988         VALUE_PAIR *realmpair;
1989         VALUE_PAIR *strippedname;
1990         VALUE_PAIR *vp;
1991         char *realmname = NULL;
1992         home_server *home;
1993         REALM *realm = NULL;
1994         home_pool_t *pool;
1995
1996         /*
1997          *      If it was already proxied, do nothing.
1998          *
1999          *      FIXME: This should really be a serious error.
2000          */
2001         if (request->in_proxy_hash) {
2002                 return 0;
2003         }
2004
2005         realmpair = pairfind(request->config_items, PW_PROXY_TO_REALM);
2006         if (!realmpair || (realmpair->length == 0)) {
2007                 return 0;
2008         }
2009
2010         realmname = (char *) realmpair->vp_strvalue;
2011
2012         realm = realm_find2(realmname);
2013         if (!realm) {
2014                 RDEBUG2("ERROR: Cannot proxy to unknown realm %s", realmname);
2015                 return 0;
2016         }
2017
2018         /*
2019          *      Figure out which pool to use.
2020          */
2021         if (request->packet->code == PW_AUTHENTICATION_REQUEST) {
2022                 pool = realm->auth_pool;
2023
2024 #ifdef WITH_ACCOUNTING
2025         } else if (request->packet->code == PW_ACCOUNTING_REQUEST) {
2026                 pool = realm->acct_pool;
2027 #endif
2028
2029         } else {
2030                 rad_panic("Internal sanity check failed");
2031         }
2032
2033         if (!pool) {
2034                 RDEBUG2(" WARNING: Cancelling proxy to Realm %s, as the realm is local.",
2035                        realmname);
2036                 return 0;
2037         }
2038
2039         home = home_server_ldb(realmname, pool, request);
2040         if (!home) {
2041                 RDEBUG2("ERROR: Failed to find live home server for realm %s",
2042                        realmname);
2043                 return -1;
2044         }
2045         request->home_pool = pool;
2046
2047 #ifdef WITH_COA
2048         /*
2049          *      Once we've decided to proxy a request, we cannot send
2050          *      a CoA packet.  So we free up any CoA packet here.
2051          */
2052         ev_request_free(&request->coa);
2053 #endif
2054         /*
2055          *      Remember that we sent the request to a Realm.
2056          */
2057         pairadd(&request->packet->vps,
2058                 pairmake("Realm", realmname, T_OP_EQ));
2059
2060         /*
2061          *      Strip the name, if told to.
2062          *
2063          *      Doing it here catches the case of proxied tunneled
2064          *      requests.
2065          */
2066         if (realm->striprealm == TRUE &&
2067            (strippedname = pairfind(request->proxy->vps, PW_STRIPPED_USER_NAME)) != NULL) {
2068                 /*
2069                  *      If there's a Stripped-User-Name attribute in
2070                  *      the request, then use THAT as the User-Name
2071                  *      for the proxied request, instead of the
2072                  *      original name.
2073                  *
2074                  *      This is done by making a copy of the
2075                  *      Stripped-User-Name attribute, turning it into
2076                  *      a User-Name attribute, deleting the
2077                  *      Stripped-User-Name and User-Name attributes
2078                  *      from the vps list, and making the new
2079                  *      User-Name the head of the vps list.
2080                  */
2081                 vp = pairfind(request->proxy->vps, PW_USER_NAME);
2082                 if (!vp) {
2083                         vp = radius_paircreate(request, NULL,
2084                                                PW_USER_NAME, PW_TYPE_STRING);
2085                         rad_assert(vp != NULL); /* handled by above function */
2086                         /* Insert at the START of the list */
2087                         vp->next = request->proxy->vps;
2088                         request->proxy->vps = vp;
2089                 }
2090                 memcpy(vp->vp_strvalue, strippedname->vp_strvalue,
2091                        sizeof(vp->vp_strvalue));
2092                 vp->length = strippedname->length;
2093
2094                 /*
2095                  *      Do NOT delete Stripped-User-Name.
2096                  */
2097         }
2098
2099         /*
2100          *      If there is no PW_CHAP_CHALLENGE attribute but
2101          *      there is a PW_CHAP_PASSWORD we need to add it
2102          *      since we can't use the request authenticator
2103          *      anymore - we changed it.
2104          */
2105         if (pairfind(request->proxy->vps, PW_CHAP_PASSWORD) &&
2106             pairfind(request->proxy->vps, PW_CHAP_CHALLENGE) == NULL) {
2107                 vp = radius_paircreate(request, &request->proxy->vps,
2108                                        PW_CHAP_CHALLENGE, PW_TYPE_OCTETS);
2109                 vp->length = AUTH_VECTOR_LEN;
2110                 memcpy(vp->vp_strvalue, request->packet->vector, AUTH_VECTOR_LEN);
2111         }
2112
2113         /*
2114          *      The RFC's say we have to do this, but FreeRADIUS
2115          *      doesn't need it.
2116          */
2117         vp = radius_paircreate(request, &request->proxy->vps,
2118                                PW_PROXY_STATE, PW_TYPE_OCTETS);
2119         snprintf(vp->vp_strvalue, sizeof(vp->vp_strvalue), "%d",
2120                  request->packet->id);
2121         vp->length = strlen(vp->vp_strvalue);
2122
2123         /*
2124          *      Should be done BEFORE inserting into proxy hash, as
2125          *      pre-proxy may use this information, or change it.
2126          */
2127         request->proxy->code = request->packet->code;
2128
2129         /*
2130          *      Call the pre-proxy routines.
2131          */
2132         vp = pairfind(request->config_items, PW_PRE_PROXY_TYPE);
2133         if (vp) {
2134                 RDEBUG2("  Found Pre-Proxy-Type %s", vp->vp_strvalue);
2135                 pre_proxy_type = vp->vp_integer;
2136         }
2137
2138         rad_assert(request->home_pool != NULL);
2139
2140         if (request->home_pool->virtual_server) {
2141                 const char *old_server = request->server;
2142                 
2143                 request->server = request->home_pool->virtual_server;
2144                 RDEBUG2(" server %s {", request->server);
2145                 rcode = module_pre_proxy(pre_proxy_type, request);
2146                 RDEBUG2(" }");
2147                         request->server = old_server;
2148         } else {
2149                 rcode = module_pre_proxy(pre_proxy_type, request);
2150         }
2151         switch (rcode) {
2152         case RLM_MODULE_FAIL:
2153         case RLM_MODULE_INVALID:
2154         case RLM_MODULE_NOTFOUND:
2155         case RLM_MODULE_USERLOCK:
2156         default:
2157                 /* FIXME: debug print failed stuff */
2158                 return -1;
2159
2160         case RLM_MODULE_REJECT:
2161         case RLM_MODULE_HANDLED:
2162                 return 0;
2163
2164         /*
2165          *      Only proxy the packet if the pre-proxy code succeeded.
2166          */
2167         case RLM_MODULE_NOOP:
2168         case RLM_MODULE_OK:
2169         case RLM_MODULE_UPDATED:
2170                 break;
2171         }
2172
2173         /*
2174          *      If it's a fake request, don't send the proxy
2175          *      packet.  The outer tunnel session will take
2176          *      care of doing that.
2177          */
2178         if (request->packet->dst_port == 0) {
2179                 request->home_server = NULL;
2180                 return 1;
2181         }
2182
2183         if (request->home_server->server) {
2184                 return proxy_to_virtual_server(request);
2185         }
2186
2187         if (!proxy_request(request)) {
2188                 RDEBUG("ERROR: Failed to proxy request %d", request->number);
2189                 return -1;
2190         }
2191         
2192         return 1;
2193 }
2194 #endif
2195
2196 static void request_post_handler(REQUEST *request)
2197 {
2198         int child_state = -1;
2199         struct timeval when;
2200         VALUE_PAIR *vp;
2201
2202         if ((request->master_state == REQUEST_STOP_PROCESSING) ||
2203             (request->parent &&
2204              (request->parent->master_state == REQUEST_STOP_PROCESSING))) {
2205                 RDEBUG2("Request %d was cancelled.", request->number);
2206 #ifdef HAVE_PTHREAD_H
2207                 request->child_pid = NO_SUCH_CHILD_PID;
2208 #endif
2209                 child_state = REQUEST_DONE;
2210                 goto cleanup;
2211         }
2212
2213         if (request->child_state != REQUEST_RUNNING) {
2214                 rad_panic("Internal sanity check failed");
2215         }
2216
2217 #ifdef WITH_COA
2218         /*
2219          *      If it's not in the request hash, it's a CoA request.
2220          *      We hope.
2221          */
2222         if (!request->in_request_hash &&
2223             request->proxy &&
2224             ((request->proxy->code == PW_COA_REQUEST) ||
2225              (request->proxy->code == PW_DISCONNECT_REQUEST))) {
2226                 request->next_callback = NULL;
2227                 child_state = REQUEST_DONE;
2228                 goto cleanup;
2229         }
2230 #endif
2231
2232         if ((request->reply->code == 0) &&
2233             ((vp = pairfind(request->config_items, PW_AUTH_TYPE)) != NULL) &&
2234             (vp->vp_integer == PW_AUTHTYPE_REJECT)) {
2235                 request->reply->code = PW_AUTHENTICATION_REJECT;
2236         }
2237
2238 #ifdef WITH_PROXY
2239         if (request->root->proxy_requests &&
2240             !request->in_proxy_hash &&
2241             (request->reply->code == 0) &&
2242             (request->packet->dst_port != 0) &&
2243             (request->packet->code != PW_STATUS_SERVER)) {
2244                 int rcode = successfully_proxied_request(request);
2245
2246                 if (rcode == 1) return; /* request is invalid */
2247
2248                 /*
2249                  *      Failed proxying it (dead home servers, etc.)
2250                  *      Run it through Post-Proxy-Type = Fail, and
2251                  *      respond to the request.
2252                  *
2253                  *      Note that we're in a child thread here, so we
2254                  *      do NOT re-schedule the request.  Instead, we
2255                  *      do what we would have done, which is run the
2256                  *      pre-handler, a NULL request handler, and then
2257                  *      the post handler.
2258                  */
2259                 if ((rcode < 0) && setup_post_proxy_fail(request)) {
2260                         request_pre_handler(request);
2261                 }
2262
2263                 /*
2264                  *      Else we weren't supposed to proxy it,
2265                  *      OR we proxied it internally to a virutal server.
2266                  */
2267         }
2268 #endif
2269
2270         /*
2271          *      Fake requests don't get encoded or signed.  The caller
2272          *      also requires the reply VP's, so we don't free them
2273          *      here!
2274          */
2275         if (request->packet->dst_port == 0) {
2276                 /* FIXME: RDEBUG going to the next request */
2277 #ifdef HAVE_PTHREAD_H
2278                 request->child_pid = NO_SUCH_CHILD_PID;
2279 #endif
2280                 request->child_state = REQUEST_DONE;
2281                 return;
2282         }
2283
2284 #ifdef WITH_PROXY
2285         /*
2286          *      Copy Proxy-State from the request to the reply.
2287          */
2288         vp = paircopy2(request->packet->vps, PW_PROXY_STATE);
2289         if (vp) pairadd(&request->reply->vps, vp);
2290 #endif
2291
2292         /*
2293          *      Access-Requests get delayed or cached.
2294          */
2295         switch (request->packet->code) {
2296         case PW_AUTHENTICATION_REQUEST:
2297                 gettimeofday(&request->next_when, NULL);
2298
2299                 if (request->reply->code == 0) {
2300                         /*
2301                          *      Check if the lack of response is intentional.
2302                          */
2303                         vp = pairfind(request->config_items,
2304                                       PW_RESPONSE_PACKET_TYPE);
2305                         if (!vp) {
2306                                 RDEBUG2("There was no response configured: rejecting request %d",
2307                                        request->number);
2308                                 request->reply->code = PW_AUTHENTICATION_REJECT;
2309
2310                         } else if (vp->vp_integer == 256) {
2311                                 RDEBUG2("Not responding to request %d",
2312                                        request->number);
2313
2314                                 /*
2315                                  *      Force cleanup after a long
2316                                  *      time, so that we don't
2317                                  *      re-process the packet.
2318                                  */
2319                                 request->next_when.tv_sec += request->root->max_request_time;
2320                                 request->next_callback = cleanup_delay;
2321                                 child_state = REQUEST_CLEANUP_DELAY;
2322                                 break;
2323                         } else {
2324                                 request->reply->code = vp->vp_integer;
2325
2326                         }
2327                 }
2328
2329                 /*
2330                  *      Run rejected packets through
2331                  *
2332                  *      Post-Auth-Type = Reject
2333                  */
2334                 if (request->reply->code == PW_AUTHENTICATION_REJECT) {
2335                         pairdelete(&request->config_items, PW_POST_AUTH_TYPE);
2336                         vp = radius_pairmake(request, &request->config_items,
2337                                              "Post-Auth-Type", "Reject",
2338                                              T_OP_SET);
2339                         if (vp) rad_postauth(request);
2340
2341                         /*
2342                          *      If configured, delay Access-Reject packets.
2343                          *
2344                          *      If request->root->reject_delay = 0, we discover
2345                          *      that we have to send the packet now.
2346                          */
2347                         when = request->received;
2348                         when.tv_sec += request->root->reject_delay;
2349
2350                         if (timercmp(&when, &request->next_when, >)) {
2351                                 RDEBUG2("Delaying reject of request %d for %d seconds",
2352                                        request->number,
2353                                        request->root->reject_delay);
2354                                 request->next_when = when;
2355                                 request->next_callback = reject_delay;
2356 #ifdef HAVE_PTHREAD_H
2357                                 request->child_pid = NO_SUCH_CHILD_PID;
2358 #endif
2359                                 request->child_state = REQUEST_REJECT_DELAY;
2360                                 return;
2361                         }
2362                 }
2363
2364                 request->next_when.tv_sec += request->root->cleanup_delay;
2365                 request->next_callback = cleanup_delay;
2366                 child_state = REQUEST_CLEANUP_DELAY;
2367                 break;
2368
2369         case PW_ACCOUNTING_REQUEST:
2370                 request->next_callback = NULL; /* just to be safe */
2371                 child_state = REQUEST_DONE;
2372                 break;
2373
2374                 /*
2375                  *      FIXME: Status-Server should probably not be
2376                  *      handled here...
2377                  */
2378         case PW_STATUS_SERVER:
2379                 request->next_callback = NULL;
2380                 child_state = REQUEST_DONE;
2381                 break;
2382
2383         default:
2384                 if ((request->packet->code > 1024) &&
2385                     (request->packet->code < (1024 + 254 + 1))) {
2386                         request->next_callback = NULL;
2387                         child_state = REQUEST_DONE;
2388                         break;
2389                 }
2390
2391                 radlog(L_ERR, "Unknown packet type %d", request->packet->code);
2392                 request->next_callback = NULL;
2393                 child_state = REQUEST_DONE;
2394                 break;
2395         }
2396
2397         /*
2398          *      Suppress "no reply" packets here, unless we're reading
2399          *      from the "detail" file.  In that case, we've got to
2400          *      tell the detail file handler that the request is dead,
2401          *      and it should re-send it.
2402          *      If configured, encode, sign, and send.
2403          */
2404         if ((request->reply->code != 0) ||
2405             (request->listener->type == RAD_LISTEN_DETAIL)) {
2406                 DEBUG_PACKET(request, request->reply, 1);
2407                 request->listener->send(request->listener, request);
2408         }
2409
2410 #ifdef WITH_COA
2411         /*
2412          *      Now that we've completely processed the request,
2413          *      see if we need to originate a CoA request.
2414          */
2415         if (request->coa ||
2416             (pairfind(request->config_items, PW_SEND_COA_REQUEST) != NULL)) {
2417                 if (!originated_coa_request(request)) {
2418                         RDEBUG2("Do CoA Fail handler here");
2419                 }
2420                 /* request->coa is stil set, so we can update events */
2421         }
2422 #endif
2423
2424  cleanup:
2425         /*
2426          *      Clean up.  These are no longer needed.
2427          */
2428         pairfree(&request->config_items);
2429
2430         pairfree(&request->packet->vps);
2431         request->username = NULL;
2432         request->password = NULL;
2433
2434         pairfree(&request->reply->vps);
2435
2436 #ifdef WITH_PROXY
2437         if (request->proxy) {
2438                 pairfree(&request->proxy->vps);
2439
2440                 if (request->proxy_reply) {
2441                         pairfree(&request->proxy_reply->vps);
2442                 }
2443
2444 #if 0
2445                 /*
2446                  *      We're not tracking responses from the home
2447                  *      server, we can therefore free this memory in
2448                  *      the child thread.
2449                  */
2450                 if (!request->in_proxy_hash) {
2451                         rad_free(&request->proxy);
2452                         rad_free(&request->proxy_reply);
2453                         request->home_server = NULL;
2454                 }
2455 #endif
2456         }
2457 #endif
2458
2459         RDEBUG2("Finished request %d.", request->number);
2460         rad_assert(child_state >= 0);
2461         request->child_state = child_state;
2462
2463         /*
2464          *      Single threaded mode: update timers now.
2465          */
2466         if (!have_children) wait_a_bit(request);
2467 }
2468
2469
2470 static void received_retransmit(REQUEST *request, const RADCLIENT *client)
2471 {
2472 #ifdef WITH_PROXY
2473         char buffer[128];
2474 #endif
2475
2476         RAD_STATS_TYPE_INC(request->listener, total_dup_requests);
2477         RAD_STATS_CLIENT_INC(request->listener, client, total_dup_requests);
2478         
2479         switch (request->child_state) {
2480         case REQUEST_QUEUED:
2481         case REQUEST_RUNNING:
2482 #ifdef WITH_PROXY
2483         discard:
2484 #endif
2485                 radlog(L_ERR, "Discarding duplicate request from "
2486                        "client %s port %d - ID: %d due to unfinished request %d",
2487                        client->shortname,
2488                        request->packet->src_port,request->packet->id,
2489                        request->number);
2490                 break;
2491
2492 #ifdef WITH_PROXY
2493         case REQUEST_PROXIED:
2494                 /*
2495                  *      We're not supposed to have duplicate
2496                  *      accounting packets.  The other states handle
2497                  *      duplicates fine (discard, or send duplicate
2498                  *      reply).  But we do NOT want to retransmit an
2499                  *      accounting request here, because that would
2500                  *      involve updating the Acct-Delay-Time, and
2501                  *      therefore changing the packet Id, etc.
2502                  *
2503                  *      Instead, we just discard the packet.  We may
2504                  *      eventually respond, or the client will send a
2505                  *      new accounting packet.            
2506                  *
2507                  *      The same comments go for Status-Server, and
2508                  *      other packet types.
2509                  *
2510                  *      FIXME: coa: when we proxy CoA && Disconnect
2511                  *      packets, this logic has to be fixed.
2512                  */
2513                 if (request->packet->code != PW_AUTHENTICATION_REQUEST) {
2514                         goto discard;
2515                 }
2516
2517                 check_for_zombie_home_server(request);
2518
2519                 /*
2520                  *      If we've just discovered that the home server is
2521                  *      dead, send the packet to another one.
2522                  */
2523                 if ((request->packet->dst_port != 0) &&
2524                     (request->home_server->state == HOME_STATE_IS_DEAD)) {
2525                         home_server *home;
2526
2527                         remove_from_proxy_hash(request);
2528
2529                         home = home_server_ldb(NULL, request->home_pool, request);
2530                         if (!home) {
2531                                 RDEBUG2("Failed to find live home server for request %d", request->number);
2532                         no_home_servers:
2533                                 /*
2534                                  *      Do post-request processing,
2535                                  *      and any insertion of necessary
2536                                  *      events.
2537                                  */
2538                                 post_proxy_fail_handler(request);
2539                                 return;
2540                         }
2541
2542                         request->proxy->code = request->packet->code;
2543
2544                         /*
2545                          *      Free the old packet, to force re-encoding
2546                          */
2547                         free(request->proxy->data);
2548                         request->proxy->data = NULL;
2549                         request->proxy->data_len = 0;
2550
2551                         /*
2552                          *      This request failed over to a virtual
2553                          *      server.  Push it back onto the queue
2554                          *      to be processed.
2555                          */
2556                         if (request->home_server->server) {
2557                                 proxy_fallback_handler(request);
2558                                 return;
2559                         }
2560
2561                         /*
2562                          *      Try to proxy the request.
2563                          */
2564                         if (!proxy_request(request)) {
2565                                 RDEBUG("ERROR: Failed to re-proxy request %d", request->number);
2566                                 goto no_home_servers;
2567                         }
2568
2569                         /*
2570                          *      This code executes in the main server
2571                          *      thread, so there's no need for locking.
2572                          */
2573                         rad_assert(request->next_callback != NULL);
2574                         INSERT_EVENT(request->next_callback, request);
2575                         request->next_callback = NULL;
2576                         return;
2577                 } /* else the home server is still alive */
2578
2579                 RDEBUG2("Sending duplicate proxied request to home server %s port %d - ID: %d",
2580                        inet_ntop(request->proxy->dst_ipaddr.af,
2581                                  &request->proxy->dst_ipaddr.ipaddr,
2582                                  buffer, sizeof(buffer)),
2583                        request->proxy->dst_port,
2584                        request->proxy->id);
2585                 request->num_proxied_requests++;
2586
2587                 DEBUG_PACKET(request, request->proxy, 1);
2588                 request->proxy_listener->send(request->proxy_listener,
2589                                               request);
2590                 break;
2591 #endif
2592
2593         case REQUEST_REJECT_DELAY:
2594                 RDEBUG2("Waiting to send Access-Reject "
2595                        "to client %s port %d - ID: %d",
2596                        client->shortname,
2597                        request->packet->src_port, request->packet->id);
2598                 break;
2599
2600         case REQUEST_CLEANUP_DELAY:
2601         case REQUEST_DONE:
2602                 if (request->reply->code == 0) {
2603                         RDEBUG2("Ignoring retransmit from client %s port %d "
2604                                 "- ID: %d, no reply was configured",
2605                                 client->shortname,
2606                                 request->packet->src_port, request->packet->id);
2607                         return;
2608                 }
2609
2610                 /*
2611                  *      FIXME: This sends duplicate replies to
2612                  *      accounting requests, even if Acct-Delay-Time
2613                  *      or Event-Timestamp is in the packet.  In those
2614                  *      cases, the Id should be changed, and the packet
2615                  *      re-calculated.
2616                  */
2617                 RDEBUG2("Sending duplicate reply "
2618                        "to client %s port %d - ID: %d",
2619                        client->shortname,
2620                        request->packet->src_port, request->packet->id);
2621                 DEBUG_PACKET(request, request->reply, 1);
2622                 request->listener->send(request->listener, request);
2623                 break;
2624         }
2625 }
2626
2627
2628 static void received_conflicting_request(REQUEST *request,
2629                                          const RADCLIENT *client)
2630 {
2631         radlog(L_ERR, "Received conflicting packet from "
2632                "client %s port %d - ID: %d due to unfinished request %d.  Giving up on old request.",
2633                client->shortname,
2634                request->packet->src_port, request->packet->id,
2635                request->number);
2636
2637         /*
2638          *      Nuke it from the request hash, so we can receive new
2639          *      packets.
2640          */
2641         remove_from_request_hash(request);
2642
2643         switch (request->child_state) {
2644 #ifdef HAVE_PTHREAD_H
2645                 /*
2646                  *      It's queued or running.  Tell it to stop, and
2647                  *      wait for it to do so.
2648                  */
2649         case REQUEST_QUEUED:
2650         case REQUEST_RUNNING:
2651                 request->master_state = REQUEST_STOP_PROCESSING;
2652                 request->delay += request->delay >> 1;
2653
2654                 tv_add(&request->when, request->delay);
2655
2656                 INSERT_EVENT(wait_for_child_to_die, request);
2657                 return;
2658 #endif
2659
2660                 /*
2661                  *      It's in some other state, and therefore also
2662                  *      in the event queue.  At some point, the
2663                  *      child will notice, and we can then delete it.
2664                  */
2665         default:
2666                 rad_assert(request->ev != NULL);
2667                 break;
2668         }
2669 }
2670
2671
2672 static int can_handle_new_request(RADIUS_PACKET *packet,
2673                                   RADCLIENT *client,
2674                                   struct main_config_t *root)
2675 {
2676         /*
2677          *      Count the total number of requests, to see if
2678          *      there are too many.  If so, return with an
2679          *      error.
2680          */
2681         if (root->max_requests) {
2682                 int request_count = fr_packet_list_num_elements(pl);
2683
2684                 /*
2685                  *      This is a new request.  Let's see if
2686                  *      it makes us go over our configured
2687                  *      bounds.
2688                  */
2689                 if (request_count > root->max_requests) {
2690                         radlog(L_ERR, "Dropping request (%d is too many): "
2691                                "from client %s port %d - ID: %d", request_count,
2692                                client->shortname,
2693                                packet->src_port, packet->id);
2694                         radlog(L_INFO, "WARNING: Please check the configuration file.\n"
2695                                "\tThe value for 'max_requests' is probably set too low.\n");
2696                         return 0;
2697                 } /* else there were a small number of requests */
2698         } /* else there was no configured limit for requests */
2699
2700         /*
2701          *      FIXME: Add per-client checks.  If one client is sending
2702          *      too many packets, start discarding them.
2703          *
2704          *      We increment the counters here, and decrement them
2705          *      when the response is sent... somewhere in this file.
2706          */
2707
2708         /*
2709          *      FUTURE: Add checks for system load.  If the system is
2710          *      busy, start dropping requests...
2711          *
2712          *      We can probably keep some statistics ourselves...  if
2713          *      there are more requests coming in than we can handle,
2714          *      start dropping some.
2715          */
2716
2717         return 1;
2718 }
2719
2720
2721 int received_request(rad_listen_t *listener,
2722                      RADIUS_PACKET *packet, REQUEST **prequest,
2723                      RADCLIENT *client)
2724 {
2725         RADIUS_PACKET **packet_p;
2726         REQUEST *request = NULL;
2727         struct main_config_t *root = &mainconfig;
2728
2729         packet_p = fr_packet_list_find(pl, packet);
2730         if (packet_p) {
2731                 request = fr_packet2myptr(REQUEST, packet, packet_p);
2732                 rad_assert(request->in_request_hash);
2733
2734                 if ((request->packet->data_len == packet->data_len) &&
2735                     (memcmp(request->packet->vector, packet->vector,
2736                             sizeof(packet->vector)) == 0)) {
2737                         received_retransmit(request, client);
2738                         return 0;
2739                 }
2740
2741                 /*
2742                  *      The new request is different from the old one,
2743                  *      but maybe the old is finished.  If so, delete
2744                  *      the old one.
2745                  */
2746                 switch (request->child_state) {
2747                         struct timeval when;
2748
2749                 default:
2750                         /*
2751                          *      Special hacks for race conditions.
2752                          *      The reply is encoded, and therefore
2753                          *      likely sent.  We received a *new*
2754                          *      packet from the client, likely before
2755                          *      the next line or two of code which
2756                          *      updated the child state.  In this
2757                          *      case, just accept the new request.
2758                          */
2759                         if ((request->reply->code != 0) &&
2760                             request->reply->data) {
2761                                 radlog(L_INFO, "WARNING: Allowing fast client %s port %d - ID: %d for recent request %d.",
2762                                        client->shortname,
2763                                        packet->src_port, packet->id,
2764                                        request->number);
2765                                 remove_from_request_hash(request);
2766                                 request = NULL;
2767                                 break;
2768                         }
2769
2770                         gettimeofday(&when, NULL);
2771                         when.tv_sec -= 1;
2772
2773                         /*
2774                          *      If the cached request was received
2775                          *      within the last second, then we
2776                          *      discard the NEW request instead of the
2777                          *      old one.  This will happen ONLY when
2778                          *      the client is severely broken, and is
2779                          *      sending conflicting packets very
2780                          *      quickly.
2781                          */
2782                         if (timercmp(&when, &request->received, <)) {
2783                                 radlog(L_ERR, "Discarding conflicting packet from "
2784                                        "client %s port %d - ID: %d due to recent request %d.",
2785                                        client->shortname,
2786                                        packet->src_port, packet->id,
2787                                        request->number);
2788                                 return 0;
2789                         }
2790
2791                         received_conflicting_request(request, client);
2792                         request = NULL;
2793                         break;
2794
2795                 case REQUEST_REJECT_DELAY:
2796                 case REQUEST_CLEANUP_DELAY:
2797                         request->child_state = REQUEST_DONE;
2798                 case REQUEST_DONE:
2799                         cleanup_delay(request);
2800                         request = NULL;
2801                         break;
2802                 }
2803         }
2804
2805         /*
2806          *      We may want to quench the new request.
2807          */
2808         if ((listener->type != RAD_LISTEN_DETAIL) &&
2809             !can_handle_new_request(packet, client, root)) {
2810                 return 0;
2811         }
2812
2813         /*
2814          *      Create and initialize the new request.
2815          */
2816         request = request_alloc(); /* never fails */
2817
2818         if ((request->reply = rad_alloc(0)) == NULL) {
2819                 radlog(L_ERR, "No memory");
2820                 exit(1);
2821         }
2822
2823         request->listener = listener;
2824         request->client = client;
2825         request->packet = packet;
2826         request->packet->timestamp = request->timestamp;
2827         request->number = request_num_counter++;
2828         request->priority = listener->type;
2829 #ifdef HAVE_PTHREAD_H
2830         request->child_pid = NO_SUCH_CHILD_PID;
2831 #endif
2832
2833         /*
2834          *      Status-Server packets go to the head of the queue.
2835          */
2836         if (request->packet->code == PW_STATUS_SERVER) request->priority = 0;
2837
2838         /*
2839          *      Set virtual server identity
2840          */
2841         if (client->server) {
2842                 request->server = client->server;
2843         } else if (listener->server) {
2844                 request->server = listener->server;
2845         } else {
2846                 request->server = NULL;
2847         }
2848
2849         /*
2850          *      Remember the request in the list.
2851          */
2852         if (!fr_packet_list_insert(pl, &request->packet)) {
2853                 radlog(L_ERR, "Failed to insert request %d in the list of live requests: discarding", request->number);
2854                 ev_request_free(&request);
2855                 return 0;
2856         }
2857
2858         request->in_request_hash = TRUE;
2859         request->root = root;
2860         root->refcount++;
2861
2862         /*
2863          *      The request passes many of our sanity checks.
2864          *      From here on in, if anything goes wrong, we
2865          *      send a reject message, instead of dropping the
2866          *      packet.
2867          */
2868
2869         /*
2870          *      Build the reply template from the request.
2871          */
2872
2873         request->reply->sockfd = request->packet->sockfd;
2874         request->reply->dst_ipaddr = request->packet->src_ipaddr;
2875         request->reply->src_ipaddr = request->packet->dst_ipaddr;
2876         request->reply->dst_port = request->packet->src_port;
2877         request->reply->src_port = request->packet->dst_port;
2878         request->reply->id = request->packet->id;
2879         request->reply->code = 0; /* UNKNOWN code */
2880         memcpy(request->reply->vector, request->packet->vector,
2881                sizeof(request->reply->vector));
2882         request->reply->vps = NULL;
2883         request->reply->data = NULL;
2884         request->reply->data_len = 0;
2885
2886         request->master_state = REQUEST_ACTIVE;
2887         request->child_state = REQUEST_QUEUED;
2888         request->next_callback = NULL;
2889
2890         gettimeofday(&request->received, NULL);
2891         request->timestamp = request->received.tv_sec;
2892         request->when = request->received;
2893
2894         request->delay = USEC;
2895
2896         tv_add(&request->when, request->delay);
2897
2898         INSERT_EVENT(wait_a_bit, request);
2899
2900         *prequest = request;
2901         return 1;
2902 }
2903
2904
2905 #ifdef WITH_PROXY
2906 REQUEST *received_proxy_response(RADIUS_PACKET *packet)
2907 {
2908         char            buffer[128];
2909         REQUEST         *request;
2910
2911         /*
2912          *      Also removes from the proxy hash if responses == requests
2913          */
2914         request = lookup_in_proxy_hash(packet);
2915
2916         if (!request) {
2917                 radlog(L_PROXY, "No outstanding request was found for reply from host %s port %d - ID %d",
2918                        inet_ntop(packet->src_ipaddr.af,
2919                                  &packet->src_ipaddr.ipaddr,
2920                                  buffer, sizeof(buffer)),
2921                        packet->src_port, packet->id);
2922                 return NULL;
2923         }
2924
2925         /*
2926          *      We haven't replied to the NAS, but we have seen an
2927          *      earlier reply from the home server.  Ignore this packet,
2928          *      as we're likely still processing the previous reply.
2929          */
2930         if (request->proxy_reply) {
2931                 if (memcmp(request->proxy_reply->vector,
2932                            packet->vector,
2933                            sizeof(request->proxy_reply->vector)) == 0) {
2934                         RDEBUG2("Discarding duplicate reply from host %s port %d  - ID: %d for request %d",
2935                                inet_ntop(packet->src_ipaddr.af,
2936                                          &packet->src_ipaddr.ipaddr,
2937                                          buffer, sizeof(buffer)),
2938                                packet->src_port, packet->id,
2939                                request->number);
2940                 } else {
2941                         /*
2942                          *      ? The home server gave us a new proxy
2943                          *      reply which doesn't match the old
2944                          *      one.  Delete it.
2945                          */
2946                         RDEBUG2("Ignoring conflicting proxy reply");
2947                 }
2948                 
2949                 /* assert that there's an event queued for request? */
2950                 return NULL;
2951         }
2952
2953         gettimeofday(&now, NULL);
2954
2955         /*
2956          *      Maybe move this earlier in the decision process?
2957          *      Having it here means that late or duplicate proxy
2958          *      replies no longer get the home server marked as
2959          *      "alive".  This might be good for stability, though.
2960          */
2961         request->home_server->state = HOME_STATE_ALIVE;
2962         
2963 #ifdef WITH_COA
2964         /*
2965          *      When originating CoA, the "proxy" reply is the reply
2966          *      to the CoA request that we originated.  At this point,
2967          *      the original request is finished, and it has a reply.
2968          *
2969          *      However, if we haven't separated the two requests, do
2970          *      so now.  This is done so that cleaning up the original
2971          *      request won't cause the CoA request to be free'd.  See
2972          *      util.c, request_free()
2973          */
2974         if (request->parent && (request->parent->coa == request)) {
2975                 request->parent->coa = NULL;
2976                 request->parent = NULL;
2977
2978         } else
2979                 /*
2980                  *      Skip the next set of checks, as the original
2981                  *      reply is cached.  We want to be able to still
2982                  *      process the CoA reply, AND to reference the
2983                  *      original request/reply.
2984                  *
2985                  *      This is getting to be really quite a bit of a
2986                  *      hack.
2987                  */
2988 #endif
2989
2990         /*
2991          *      If there's a reply to the NAS, ignore everything
2992          *      related to proxy responses
2993          */
2994         if (request->reply && request->reply->code != 0) {
2995                 RDEBUG2("Ignoring proxy reply that arrived after we sent a reply to the NAS");
2996                 return NULL;
2997         }
2998         
2999 #ifdef WITH_STATS
3000         /*
3001          *      The average includes our time to receive packets and
3002          *      look them up in the hashes, which should be the same
3003          *      for all packets.
3004          *
3005          *      We update the response time only for the FIRST packet
3006          *      we receive.
3007          */
3008         if (request->home_server->ema.window > 0) {
3009                 radius_stats_ema(&request->home_server->ema,
3010                                  &now, &request->proxy_when);
3011         }
3012 #endif
3013
3014         switch (request->child_state) {
3015         case REQUEST_QUEUED:
3016         case REQUEST_RUNNING:
3017                 radlog(L_ERR, "Internal sanity check failed for child state");
3018                 /* FALL-THROUGH */
3019
3020         case REQUEST_REJECT_DELAY:
3021         case REQUEST_CLEANUP_DELAY:
3022         case REQUEST_DONE:
3023                 radlog(L_ERR, "Reply from home server %s port %d  - ID: %d arrived too late for request %d. Try increasing 'retry_delay' or 'max_request_time'",
3024                        inet_ntop(packet->src_ipaddr.af,
3025                                  &packet->src_ipaddr.ipaddr,
3026                                  buffer, sizeof(buffer)),
3027                        packet->src_port, packet->id,
3028                        request->number);
3029                 /* assert that there's an event queued for request? */
3030                 return NULL;
3031
3032         case REQUEST_PROXIED:
3033                 break;
3034         }
3035
3036         request->proxy_reply = packet;
3037
3038 #if 0
3039         /*
3040          *      Perform RTT calculations, as per RFC 2988 (for TCP).
3041          *      Note that we only do so on the first response.
3042          */
3043         if ((request->num_proxied_responses == 1)
3044                 int rtt;
3045                 home_server *home = request->home_server;
3046
3047                 rtt = now.tv_sec - request->proxy_when.tv_sec;
3048                 rtt *= USEC;
3049                 rtt += now.tv_usec;
3050                 rtt -= request->proxy_when.tv_usec;
3051
3052                 if (!home->has_rtt) {
3053                         home->has_rtt = TRUE;
3054
3055                         home->srtt = rtt;
3056                         home->rttvar = rtt / 2;
3057
3058                 } else {
3059                         home->rttvar -= home->rttvar >> 2;
3060                         home->rttvar += (home->srtt - rtt);
3061                         home->srtt -= home->srtt >> 3;
3062                         home->srtt += rtt >> 3;
3063                 }
3064
3065                 home->rto = home->srtt;
3066                 if (home->rttvar > (USEC / 4)) {
3067                         home->rto += home->rttvar * 4;
3068                 } else {
3069                         home->rto += USEC;
3070                 }
3071         }
3072 #endif
3073
3074         /*
3075          *      There's no incoming request, so it's a proxied packet
3076          *      we originated.
3077          */
3078         if (!request->packet) {
3079                 received_response_to_ping(request);
3080                 request->proxy_reply = NULL; /* caller will free it */
3081                 ev_request_free(&request);
3082                 return NULL;
3083         }
3084
3085         request->child_state = REQUEST_QUEUED;
3086         request->when = now;
3087         request->delay = USEC;
3088         request->priority = RAD_LISTEN_PROXY;
3089         tv_add(&request->when, request->delay);
3090
3091         /*
3092          *      Wait a bit will take care of max_request_time
3093          */
3094         INSERT_EVENT(wait_a_bit, request);
3095
3096         return request;
3097 }
3098 #endif
3099
3100 void event_new_fd(rad_listen_t *this)
3101 {
3102         char buffer[1024];
3103
3104         if (this->status == RAD_LISTEN_STATUS_KNOWN) return;
3105         
3106         this->print(this, buffer, sizeof(buffer));
3107         
3108         if (this->status == RAD_LISTEN_STATUS_INIT) {
3109                 if (just_started) {
3110                         DEBUG("Listening on %s", buffer);
3111                 } else {
3112                         DEBUG2(" ... adding new socket %s", buffer);
3113                 }
3114                 if (!fr_event_fd_insert(el, 0, this->fd,
3115                                         event_socket_handler, this)) {
3116                         radlog(L_ERR, "Failed remembering handle for proxy socket!");
3117                         exit(1);
3118                 }
3119                 
3120                 this->status = RAD_LISTEN_STATUS_KNOWN;
3121                 return;
3122         }
3123         
3124         if (this->status == RAD_LISTEN_STATUS_CLOSED) {
3125                 DEBUG2(" ... closing socket %s", buffer);
3126                 
3127                 fr_event_fd_delete(el, 0, this->fd);
3128                 this->status = RAD_LISTEN_STATUS_FINISH;
3129                 
3130                 /*
3131                  *      Close the fd AFTER fixing up the requests and
3132                  *      listeners, so that they don't send/recv on the
3133                  *      wrong socket (if someone manages to open
3134                  *      another one).
3135                  */
3136                 close(this->fd);
3137                 this->fd = -1;
3138         }
3139 }
3140
3141 static void handle_signal_self(int flag)
3142 {
3143         if ((flag & (RADIUS_SIGNAL_SELF_EXIT | RADIUS_SIGNAL_SELF_TERM)) != 0) {
3144                 if ((flag & RADIUS_SIGNAL_SELF_EXIT) != 0) {
3145                         fr_event_loop_exit(el, 1);
3146                 } else {
3147                         fr_event_loop_exit(el, 2);
3148                 }
3149
3150                 return;
3151         } /* else exit/term flags weren't set */
3152
3153         /*
3154          *      Tell the even loop to stop processing.
3155          */
3156         if ((flag & RADIUS_SIGNAL_SELF_HUP) != 0) {
3157                 time_t when;
3158                 static time_t last_hup = 0;
3159
3160                 DEBUG("Received HUP signal.");
3161
3162                 when = time(NULL);
3163                 if ((int) (when - last_hup) < 5) {
3164                         radlog(L_INFO, "Ignoring HUP (less than 5s since last one)");
3165                         return;
3166                 }
3167                 last_hup = when;
3168
3169                 fr_event_loop_exit(el, 0x80);
3170         }
3171
3172 #ifdef WITH_DETAIL
3173         if ((flag & RADIUS_SIGNAL_SELF_DETAIL) != 0) {
3174                 rad_listen_t *this;
3175                 
3176                 /*
3177                  *      FIXME: O(N) loops suck.
3178                  */
3179                 for (this = mainconfig.listen;
3180                      this != NULL;
3181                      this = this->next) {
3182                         if (this->type != RAD_LISTEN_DETAIL) continue;
3183
3184                         /*
3185                          *      This one didn't send the signal, skip
3186                          *      it.
3187                          */
3188                         if (!this->decode(this, NULL)) continue;
3189
3190                         /*
3191                          *      Go service the interrupt.
3192                          */
3193                         event_poll_detail(this);
3194                 }
3195         }
3196 #endif
3197
3198         if ((flag & RADIUS_SIGNAL_SELF_NEW_FD) != 0) {
3199                 rad_listen_t *this;
3200                 
3201                 for (this = mainconfig.listen;
3202                      this != NULL;
3203                      this = this->next) {
3204                         event_new_fd(this);
3205                 }
3206         }
3207 }
3208
3209 #ifndef WITH_SELF_PIPE
3210 void radius_signal_self(int flag)
3211 {
3212         handle_signal_self(flag);
3213 }
3214 #else
3215 /*
3216  *      Inform ourselves that we received a signal.
3217  */
3218 void radius_signal_self(int flag)
3219 {
3220         ssize_t rcode;
3221         uint8_t buffer[16];
3222
3223         /*
3224          *      The read MUST be non-blocking for this to work.
3225          */
3226         rcode = read(self_pipe[0], buffer, sizeof(buffer));
3227         if (rcode > 0) {
3228                 ssize_t i;
3229
3230                 for (i = 0; i < rcode; i++) {
3231                         buffer[0] |= buffer[i];
3232                 }
3233         } else {
3234                 buffer[0] = 0;
3235         }
3236
3237         buffer[0] |= flag;
3238
3239         write(self_pipe[1], buffer, 1);
3240 }
3241
3242
3243 static void event_signal_handler(UNUSED fr_event_list_t *xel,
3244                                  UNUSED int fd, UNUSED void *ctx)
3245 {
3246         ssize_t i, rcode;
3247         uint8_t buffer[32];
3248
3249         rcode = read(self_pipe[0], buffer, sizeof(buffer));
3250         if (rcode <= 0) return;
3251
3252         /*
3253          *      Merge pending signals.
3254          */
3255         for (i = 0; i < rcode; i++) {
3256                 buffer[0] |= buffer[i];
3257         }
3258
3259         handle_signal_self(buffer[0]);
3260 }
3261 #endif
3262
3263
3264 static void event_socket_handler(fr_event_list_t *xel, UNUSED int fd,
3265                                  void *ctx)
3266 {
3267         rad_listen_t *listener = ctx;
3268         RAD_REQUEST_FUNP fun;
3269         REQUEST *request;
3270
3271         rad_assert(xel == el);
3272
3273         xel = xel;
3274
3275         if (listener->fd < 0) rad_panic("Socket was closed on us!");
3276         
3277         if (!listener->recv(listener, &fun, &request)) return;
3278
3279         if (!thread_pool_addrequest(request, fun)) {
3280                 request->child_state = REQUEST_DONE;
3281         }
3282 }
3283
3284 typedef struct listen_detail_t {
3285         fr_event_t      *ev;
3286 } listen_detail_t;
3287
3288 /*
3289  *      This function is called periodically to see if this detail
3290  *      file is available for reading.
3291  */
3292 static void event_poll_detail(void *ctx)
3293 {
3294         int rcode, delay;
3295         RAD_REQUEST_FUNP fun;
3296         REQUEST *request;
3297         rad_listen_t *this = ctx;
3298         struct timeval when;
3299         listen_detail_t *detail = this->data;
3300
3301         rad_assert(this->type == RAD_LISTEN_DETAIL);
3302
3303         /*
3304          *      Try to read something.
3305          *
3306          *      FIXME: This does poll AND receive.
3307          */
3308         rcode = this->recv(this, &fun, &request);
3309         if (rcode != 0) {
3310                 rad_assert(fun != NULL);
3311                 rad_assert(request != NULL);
3312                 
3313                 if (!thread_pool_addrequest(request, fun)) {
3314                         request->child_state = REQUEST_DONE;
3315                 }
3316         }
3317
3318         if (!fr_event_now(el, &now)) gettimeofday(&now, NULL);
3319         when = now;
3320
3321         /*
3322          *      Backdoor API to get the delay until the next poll time.
3323          */
3324         delay = this->encode(this, NULL);
3325         tv_add(&when, delay);
3326
3327         if (!fr_event_insert(el, event_poll_detail, this,
3328                              &when, &detail->ev)) {
3329                 radlog(L_ERR, "Failed creating handler");
3330                 exit(1);
3331         }
3332 }
3333
3334
3335 static void event_status(struct timeval *wake)
3336 {
3337 #if !defined(HAVE_PTHREAD_H) && defined(WNOHANG)
3338         int argval;
3339 #endif
3340
3341         if (debug_flag == 0) {
3342                 if (just_started) {
3343                         radlog(L_INFO, "Ready to process requests.");
3344                         just_started = FALSE;
3345                 }
3346                 return;
3347         }
3348
3349         if (!wake) {
3350                 DEBUG("Ready to process requests.");
3351
3352         } else if ((wake->tv_sec != 0) ||
3353                    (wake->tv_usec >= 100000)) {
3354                 DEBUG("Waking up in %d.%01u seconds.",
3355                       (int) wake->tv_sec, (unsigned int) wake->tv_usec / 100000);
3356         }
3357
3358
3359         /*
3360          *      FIXME: Put this somewhere else, where it isn't called
3361          *      all of the time...
3362          */
3363
3364 #if !defined(HAVE_PTHREAD_H) && defined(WNOHANG)
3365         /*
3366          *      If there are no child threads, then there may
3367          *      be child processes.  In that case, wait for
3368          *      their exit status, and throw that exit status
3369          *      away.  This helps get rid of zxombie children.
3370          */
3371         while (waitpid(-1, &argval, WNOHANG) > 0) {
3372                 /* do nothing */
3373         }
3374 #endif
3375
3376 }
3377
3378 /*
3379  *      Externally-visibly functions.
3380  */
3381 int radius_event_init(CONF_SECTION *cs, int spawn_flag)
3382 {
3383         rad_listen_t *this, *head = NULL;
3384
3385         if (el) return 0;
3386
3387         time(&fr_start_time);
3388
3389         el = fr_event_list_create(event_status);
3390         if (!el) return 0;
3391
3392         pl = fr_packet_list_create(0);
3393         if (!pl) return 0;      /* leak el */
3394
3395         request_num_counter = 0;
3396
3397         /*
3398          *      Move all of the thread calls to this file?
3399          *
3400          *      It may be best for the mutexes to be in this file...
3401          */
3402         have_children = spawn_flag;
3403
3404 #ifdef WITH_PROXY
3405         if (mainconfig.proxy_requests) {
3406                 /*
3407                  *      Create the tree for managing proxied requests and
3408                  *      responses.
3409                  */
3410                 proxy_list = fr_packet_list_create(1);
3411                 if (!proxy_list) return 0;
3412
3413 #ifdef HAVE_PTHREAD_H
3414                 if (pthread_mutex_init(&proxy_mutex, NULL) != 0) {
3415                         radlog(L_ERR, "FATAL: Failed to initialize proxy mutex: %s",
3416                                strerror(errno));
3417                         exit(1);
3418                 }
3419 #endif
3420         }
3421 #endif
3422
3423         /*
3424          *      Just before we spawn the child threads, force the log
3425          *      subsystem to re-open the log file for every write.
3426          */
3427         if (spawn_flag) force_log_reopen();
3428
3429 #ifdef HAVE_PTHREAD_H
3430 #ifndef __MINGW32__
3431         NO_SUCH_CHILD_PID = (pthread_t ) (0);
3432 #else
3433         NO_SUCH_CHILD_PID = pthread_self(); /* not a child thread */
3434 #endif
3435         if (thread_pool_init(cs, spawn_flag) < 0) {
3436                 exit(1);
3437         }
3438 #endif
3439
3440         if (check_config) {
3441                 DEBUG("%s: #### Skipping IP addresses and Ports ####",
3442                        mainconfig.name);
3443                 return 1;
3444         }
3445
3446 #ifdef WITH_SELF_PIPE
3447         /*
3448          *      Child threads need a pipe to signal us, as do the
3449          *      signal handlers.
3450          */
3451         if (pipe(self_pipe) < 0) {
3452                 radlog(L_ERR, "radiusd: Error opening internal pipe: %s",
3453                        strerror(errno));
3454                 exit(1);
3455         }
3456         if (fcntl(self_pipe[0], F_SETFL, O_NONBLOCK | FD_CLOEXEC) < 0) {
3457                 radlog(L_ERR, "radiusd: Error setting internal flags: %s",
3458                        strerror(errno));
3459                 exit(1);
3460         }
3461         if (fcntl(self_pipe[1], F_SETFL, O_NONBLOCK | FD_CLOEXEC) < 0) {
3462                 radlog(L_ERR, "radiusd: Error setting internal flags: %s",
3463                        strerror(errno));
3464                 exit(1);
3465         }
3466
3467         if (!fr_event_fd_insert(el, 0, self_pipe[0],
3468                                   event_signal_handler, el)) {
3469                 radlog(L_ERR, "Failed creating handler for signals");
3470                 exit(1);
3471         }
3472 #endif  /* WITH_SELF_PIPE */
3473
3474 #ifdef WITH_PROXY
3475         /*
3476          *      Mark the proxy Fd's as unused.
3477          */
3478         {
3479                 int i;
3480
3481                 for (i = 0; i < 32; i++) proxy_fds[i] = -1;
3482         }
3483 #endif
3484
3485        DEBUG("%s: #### Opening IP addresses and Ports ####",
3486                mainconfig.name);
3487
3488        /*
3489         *       The server temporarily switches to an unprivileged
3490         *       user very early in the bootstrapping process.
3491         *       However, some sockets MAY require privileged access
3492         *       (bind to device, or to port < 1024, or to raw
3493         *       sockets).  Those sockets need to call suid up/down
3494         *       themselves around the functions that need a privileged
3495         *       uid.
3496         */
3497         if (listen_init(cs, &head) < 0) {
3498                 _exit(1);
3499         }
3500         
3501         /*
3502          *      At this point, no one has any business *ever* going
3503          *      back to root uid.
3504          */
3505         fr_suid_down_permanent();
3506
3507         /*
3508          *      Add all of the sockets to the event loop.
3509          */
3510         for (this = head;
3511              this != NULL;
3512              this = this->next) {
3513                 char buffer[256];
3514
3515                 this->print(this, buffer, sizeof(buffer));
3516
3517                 switch (this->type) {
3518 #ifdef WITH_DETAIL
3519                 case RAD_LISTEN_DETAIL:
3520                         DEBUG("Listening on %s", buffer);
3521
3522                         /*
3523                          *      Detail files are always known, and aren't
3524                          *      put into the socket event loop.
3525                          */
3526                         this->status = RAD_LISTEN_STATUS_KNOWN;
3527
3528                         /*
3529                          *      Set up the first poll interval.
3530                          */
3531                         event_poll_detail(this);
3532                         break;
3533 #endif
3534
3535 #ifdef WITH_PROXY
3536                 case RAD_LISTEN_PROXY:
3537                         rad_assert(proxy_fds[this->fd & 0x1f] == -1);
3538                         rad_assert(proxy_listeners[this->fd & 0x1f] == NULL);
3539                         
3540                         proxy_fds[this->fd & 0x1f] = this->fd;
3541                         proxy_listeners[this->fd & 0x1f] = this;
3542                         if (!fr_packet_list_socket_add(proxy_list,
3543                                                          this->fd)) {
3544                                 rad_assert(0 == 1);
3545                         }
3546                         /* FALL-THROUGH */
3547 #endif
3548
3549                 default:
3550                         break;
3551                 }
3552
3553                 event_new_fd(this);
3554         }
3555
3556         mainconfig.listen = head;
3557
3558         return 1;
3559 }
3560
3561
3562 static int request_hash_cb(UNUSED void *ctx, void *data)
3563 {
3564         REQUEST *request = fr_packet2myptr(REQUEST, packet, data);
3565
3566 #ifdef WITH_PROXY
3567         rad_assert(request->in_proxy_hash == FALSE);
3568 #endif
3569
3570         ev_request_free(&request);
3571
3572         return 0;
3573 }
3574
3575
3576 #ifdef WITH_PROXY
3577 static int proxy_hash_cb(UNUSED void *ctx, void *data)
3578 {
3579         REQUEST *request = fr_packet2myptr(REQUEST, proxy, data);
3580
3581         ev_request_free(&request);
3582
3583         return 0;
3584 }
3585 #endif
3586
3587 void radius_event_free(void)
3588 {
3589         /*
3590          *      FIXME: Stop all threads, or at least check that
3591          *      they're all waiting on the semaphore, and the queues
3592          *      are empty.
3593          */
3594
3595 #ifdef WITH_PROXY
3596         /*
3597          *      There are requests in the proxy hash that aren't
3598          *      referenced from anywhere else.  Remove them first.
3599          */
3600         if (proxy_list) {
3601                 PTHREAD_MUTEX_LOCK(&proxy_mutex);
3602                 fr_packet_list_walk(proxy_list, NULL, proxy_hash_cb);
3603                 PTHREAD_MUTEX_UNLOCK(&proxy_mutex);
3604                 fr_packet_list_free(proxy_list);
3605                 proxy_list = NULL;
3606         }
3607 #endif
3608
3609         fr_packet_list_walk(pl, NULL, request_hash_cb);
3610
3611         fr_packet_list_free(pl);
3612         pl = NULL;
3613
3614         fr_event_list_free(el);
3615 }
3616
3617 int radius_event_process(void)
3618 {
3619         if (!el) return 0;
3620
3621         return fr_event_loop(el);
3622 }
3623
3624 void radius_handle_request(REQUEST *request, RAD_REQUEST_FUNP fun)
3625 {
3626         request->options = RAD_REQUEST_OPTION_DEBUG2;
3627
3628         if (request_pre_handler(request)) {
3629                 rad_assert(fun != NULL);
3630                 rad_assert(request != NULL);
3631                 
3632                 if (request->server) RDEBUG("server %s {",
3633                                             request->server != NULL ?
3634                                             request->server : ""); 
3635                 fun(request);
3636
3637                 if (request->server) RDEBUG("} # server %s",
3638                                              request->server != NULL ?
3639                                             request->server : "");
3640
3641                 request_post_handler(request);
3642         }
3643
3644         DEBUG2("Going to the next request");
3645         return;
3646 }