chiark / gitweb /
adf6cad9573b4b925b79c2dacd8a46278f5500ec
[inn-innduct.git] / backends / innduct.c
1 /*
2  *  innduct
3  *  tailing reliable realtime streaming feeder for inn
4  *
5  *  Copyright (C) 2010 Ian Jackson <ijackson@chiark.greenend.org.uk>
6  * 
7  *  This program is free software: you can redistribute it and/or modify
8  *  it under the terms of the GNU General Public License as published by
9  *  the Free Software Foundation, either version 3 of the License, or
10  *  (at your option) any later version.
11  * 
12  *  This program is distributed in the hope that it will be useful,
13  *  but WITHOUT ANY WARRANTY; without even the implied warranty of
14  *  MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
15  *  GNU General Public License for more details.
16  * 
17  *  You should have received a copy of the GNU General Public License
18  *  along with this program.  If not, see <http://www.gnu.org/licenses/>.
19  *
20  *  (I believe that when you compile and link this as part of the inn2
21  *  build, with the Makefile runes I have provided, all the libraries
22  *  and files which end up included in innduct are licence-compatible
23  *  with GPLv3.  If not then please let me know.  -Ian Jackson.)
24  */
25
26 /*
27  * todo
28  *
29  *  don't mind reconnecting if we just disconnected due to idle
30  *  some weird disconnection event still investigating
31  */
32
33 /*
34  * Newsfeeds file entries should look like this:
35  *     host.name.of.site[/exclude,exclude,...]\
36  *             :pattern,pattern...[/distribution,distribution...]\
37  *             :Tf,Wnm
38  *             :
39  * or
40  *     sitename[/exclude,exclude,...]\
41  *             :pattern,pattern...[/distribution,distribution...]\
42  *             :Tf,Wnm
43  *             :host.name.of.site
44  *
45  * Four files full of
46  *    token messageid
47  * or might be blanked out
48  *    <spc><spc><spc><spc>....
49  *
50  * F site.name                 main feed file
51  *                                opened/created, then written, by innd
52  *                                read by duct
53  *                                unlinked by duct
54  *                                tokens blanked out by duct when processed
55  *   site.name_lock            lock preventing multiple ducts
56  *                                to hold lock must open,F_SETLK[W]
57  *                                  and then stat to check that locked file
58  *                                  still has name site.name_lock
59  *                                holder of this lock is "duct"
60  *                                (only) lockholder may remove the lockfile
61  * D site.name_flushing        temporary feed file during flush (or crash)
62  *                                hardlink created by duct
63  *                                unlinked by duct
64  *   site.name_defer           431'd articles, still being written,
65  *                                created, written, used by duct
66  *
67  *   site.name_backlog.<date>.<inum>
68  *                             431'd articles, ready for innxmit or duct
69  *                                created (link/mv) by duct
70  *   site.name_backlog<anything-else>  (where <anything-else> does not
71  *                                      contain '#' or '~') eg
72  *   site.name_backlog.manual
73  *                             anything the sysadmin likes (eg, feed files
74  *                             from old feeds to be merged into this one)
75  *                                created (link/mv) by admin
76  *                                may be symlinks (in which case links
77  *                                may be written through, but only links
78  *                                will be removed.
79  *
80  *                             It is safe to remove backlog files manually,
81  *                             if it's desired to throw away the backlog.
82  *
83  * Backlog files are also processed by innduct.  We find the oldest
84  * backlog file which is at least a certain amount old, and feed it
85  * back into our processing.  When every article in it has been read
86  * and processed, we unlink it and look for another backlog file.
87  *
88  * If we don't have a backlog file that we're reading, we close the
89  * defer file that we're writing and make it into a backlog file at
90  * the first convenient opportunity.
91  * -8<-
92
93
94    OVERALL STATES:
95
96                                                                 START
97                                                                   |
98      ,-->--.                                                 check F, D
99      |     |                                                      |
100      |     |                                                      |
101      |     |  <----------------<---------------------------------'|
102      |     |                                       F exists       |
103      |     |                                       D ENOENT       |
104      |     |  duct opens F                                        |
105      |     V                                                      |
106      |  Normal                                                    |
107      |   F: innd writing, duct reading                            |
108      |   D: ENOENT                                                |
109      |     |                                                      |
110      |     |  duct decides time to flush                          |
111      |     |  duct makes hardlink                                 |
112      |     |                                                      |
113      |     V                            <------------------------'|
114      |  Hardlinked                                  F==D          |
115      |   F == D: innd writing, duct reading         both exist    |
116      ^     |                                                      |
117      |     |  duct unlinks F                                      |
118      |     |                        <-----------<-------------<--'|
119      |     |                           open D         F ENOENT    |
120      |     |                           if exists                  |
121      |     |                                                      |
122      |     V                        <---------------------.       |
123      |  Moved                                             |       |
124      |   F: ENOENT                                        |       |
125      |   D: innd writing, duct reading; or ENOENT         |       |
126      |     |                                              |       |
127      |     |  duct requests flush of feed                 |       |
128      |     |   (others can too, harmlessly)               |       |
129      |     V                                              |       |
130      |  Flushing                                          |       |
131      |   F: ENOENT                                        |       |
132      |   D: innd flushing, duct; or ENOENT                |       |
133      |     |                                              |       |
134      |     |   inndcomm flush fails                       |       |
135      |     |`-------------------------->------------------'       |
136      |     |                                                      |
137      |     |   inndcomm reports no such site                      |
138      |     |`---------------------------------------------------- | -.
139      |     |                                                      |  |
140      |     |  innd finishes writing D, creates F                  |  |
141      |     |  inndcomm reports flush successful                   |  |
142      |     |                                                      |  |
143      |     V                                                      |  |
144      |  Separated                                <----------------'  |
145      |   F: innd writing                            F!=D             /
146      |   D: duct reading; or ENOENT                  both exist     /
147      |     |                                                       /
148      |     |  duct gets to the end of D                           /
149      |     |  duct opens F too                                   /
150      |     V                                                    /
151      |  Finishing                                              /
152      |   F: innd writing, duct reading                        |
153      |   D: duct finishing                                    V
154      |     |                                            Dropping
155      |     |  duct finishes processing D                 F: ENOENT
156      |     V  duct unlinks D                             D: duct reading
157      |     |                                                  |
158      `--<--'                                                  | duct finishes
159                                                               |  processing D
160                                                               | duct unlinks D
161                                                               | duct exits
162                                                               V
163                                                         Dropped
164                                                          F: ENOENT
165                                                          D: ENOENT
166                                                          duct not running
167
168    "duct reading" means innduct is reading the file but also
169    overwriting processed tokens.
170
171  * ->8- -^L-
172  *
173  * rune for printing diagrams:
174
175 perl -ne 'print if m/-8\<-/..m/-\>8-/; print "\f" if m/-\^L-/' backends/innduct.c |a2ps -R -B -ops
176
177  *
178  */
179
180 /*============================== PROGRAM ==============================*/
181
182 #define _GNU_SOURCE 1
183
184 #include "config.h"
185 #include "storage.h"
186 #include "nntp.h"
187 #include "libinn.h"
188 #include "inndcomm.h"
189
190 #include "inn/list.h"
191 #include "inn/innconf.h"
192
193 #include <sys/uio.h>
194 #include <sys/types.h>
195 #include <sys/wait.h>
196 #include <sys/stat.h>
197 #include <sys/socket.h>
198 #include <sys/un.h>
199 #include <unistd.h>
200 #include <string.h>
201 #include <signal.h>
202 #include <stdio.h>
203 #include <errno.h>
204 #include <syslog.h>
205 #include <fcntl.h>
206 #include <stdarg.h>
207 #include <assert.h>
208 #include <stdlib.h>
209 #include <stddef.h>
210 #include <glob.h>
211 #include <time.h>
212 #include <math.h>
213 #include <ctype.h>
214
215 #include <oop.h>
216 #include <oop-read.h>
217
218 /*----- general definitions, probably best not changed -----*/
219
220 #define CONNCHILD_ESTATUS_STREAM   24
221 #define CONNCHILD_ESTATUS_NOSTREAM 25
222
223 #define INNDCOMMCHILD_ESTATUS_FAIL     26
224 #define INNDCOMMCHILD_ESTATUS_NONESUCH 27
225
226 #define MAX_LINE_FEEDFILE (NNTP_MSGID_MAXLEN + sizeof(TOKEN)*2 + 10)
227 #define MAX_CLI_COMMAND 1000
228
229 #define VA                va_list al;  va_start(al,fmt)
230 #define PRINTF(f,a)       __attribute__((__format__(printf,f,a)))
231 #define NORET_PRINTF(f,a) __attribute__((__noreturn__,__format__(printf,f,a)))
232 #define NORET             __attribute__((__noreturn__))
233
234 #define NEW(ptr)              ((ptr)= zxmalloc(sizeof(*(ptr))))
235 #define NEW_DECL(type,ptr) type ptr = zxmalloc(sizeof(*(ptr)))
236
237 #define DUMPV(fmt,pfx,v) fprintf(f, " " #v "=" fmt, pfx v);
238
239 #define FOR_CONN(conn) \
240   for ((conn)=LIST_HEAD(conns); (conn); (conn)=LIST_NEXT((conn)))
241
242 /*----- doubly linked lists -----*/
243
244 #define ISNODE(T)   struct node list_node
245 #define DEFLIST(T)                              \
246    typedef struct {                             \
247      union { struct list li; T *for_type; } u;  \
248      int count;                                 \
249    } T##List
250
251 #define NODE(n) (assert((void*)&(n)->list_node == (n)), &(n)->list_node)
252
253 #define LIST_CHECKCANHAVENODE(l,n) \
254   ((void)((n) == ((l).u.for_type))) /* just for the type check */
255
256 #define LIST_ADDSOMEHOW(l,n,list_addsomehow)    \
257  ( LIST_CHECKCANHAVENODE(l,n),                  \
258    list_addsomehow(&(l).u.li, NODE((n))),       \
259    (void)(l).count++                            \
260    )
261
262 #define LIST_REMSOMEHOW(l,list_remsomehow)      \
263  ( (typeof((l).u.for_type))                     \
264    ( (l).count                                  \
265      ? ( (l).count--,                           \
266          list_remsomehow(&(l).u.li) )           \
267      : 0                                        \
268      )                                          \
269    )
270
271
272 #define LIST_ADDHEAD(l,n) LIST_ADDSOMEHOW((l),(n),list_addhead)
273 #define LIST_ADDTAIL(l,n) LIST_ADDSOMEHOW((l),(n),list_addtail)
274 #define LIST_REMHEAD(l) LIST_REMSOMEHOW((l),list_remhead)
275 #define LIST_REMTAIL(l) LIST_REMSOMEHOW((l),list_remtail)
276
277 #define LIST_INIT(l) ((l).count=0, list_new(&(l).u.li))
278 #define LIST_HEAD(l) ((typeof((l).u.for_type))(list_head((struct list*)&(l))))
279 #define LIST_NEXT(n) ((typeof(n))list_succ(NODE((n))))
280 #define LIST_BACK(n) ((typeof(n))list_pred(NODE((n))))
281
282 #define LIST_REMOVE(l,n)                        \
283  ( LIST_CHECKCANHAVENODE(l,n),                  \
284    list_remove(NODE((n))),                      \
285    (void)(l).count--                            \
286    )
287
288 #define LIST_INSERT(l,n,pred)                                   \
289  ( LIST_CHECKCANHAVENODE(l,n),                                  \
290    LIST_CHECKCANHAVENODE(l,pred),                               \
291    list_insert((struct list*)&(l), NODE((n)), NODE((pred))),    \
292    (void)(l).count++                                            \
293    )
294
295 /*----- type predeclarations -----*/
296
297 typedef struct Conn Conn;
298 typedef struct Article Article;
299 typedef struct InputFile InputFile;
300 typedef struct XmitDetails XmitDetails;
301 typedef struct Filemon_Perfile Filemon_Perfile;
302 typedef enum StateMachineState StateMachineState;
303 typedef struct CliCommand CliCommand;
304
305 DEFLIST(Conn);
306 DEFLIST(Article);
307
308 /*----- function predeclarations -----*/
309
310 static void conn_maybe_write(Conn *conn);
311 static void conn_make_some_xmits(Conn *conn);
312 static void *conn_write_some_xmits(Conn *conn);
313
314 static void xmit_free(XmitDetails *d);
315
316 #define SMS(newstate, periods, why) \
317    (statemc_setstate(sm_##newstate,(periods),#newstate,(why)))
318 static void statemc_setstate(StateMachineState newsms, int periods,
319                              const char *forlog, const char *why);
320
321 static void statemc_start_flush(const char *why); /* Normal => Flushing */
322 static void spawn_inndcomm_flush(const char *why); /* Moved => Flushing */
323 static int trigger_flush_ok(const char *why /* 0 means timeout */);
324                                   /* => Flushing,FLUSHING, ret 1; or ret 0 */
325
326 static void article_done(Article *art, int whichcount);
327
328 static void check_assign_articles(void);
329 static void queue_check_input_done(void);
330 static void check_reading_pause_resume(InputFile *ipf);
331
332 static void statemc_check_flushing_done(void);
333 static void statemc_check_backlog_done(void);
334
335 static void postfork(void);
336 static void period(void);
337
338 static void open_defer(void);
339 static void close_defer(void);
340 static void search_backlog_file(void);
341 static void preterminate(void);
342 static void raise_default(int signo) NORET;
343 static char *debug_report_ipf(InputFile *ipf);
344
345 static void inputfile_reading_start(InputFile *ipf);
346 static void inputfile_reading_stop(InputFile *ipf);
347 static void inputfile_reading_pause(InputFile *ipf);
348 static void inputfile_reading_resume(InputFile *ipf);
349   /* pause and resume are idempotent, and no-op if not done _reading_start */
350
351 static void filemon_start(InputFile *ipf);
352 static void filemon_stop(InputFile *ipf);
353 static void tailing_make_readable(InputFile *ipf);
354
355 static void vconnfail(Conn *conn, const char *fmt, va_list al) PRINTF(2,0);
356 static void connfail(Conn *conn, const char *fmt, ...)         PRINTF(2,3);
357
358 static const oop_rd_style peer_rd_style;
359 static oop_rd_call peer_rd_err, peer_rd_ok;
360
361
362 /*----- configuration options -----*/
363 /* when changing defaults, remember to update the manpage */
364
365 static const char *sitename, *remote_host;
366 static const char *feedfile, *path_run, *path_cli, *path_cli_dir;
367 static int quiet_multiple=0;
368 static int become_daemon=1, try_filemon=1;
369 static int try_stream=1;
370 static int port=119;
371 static const char *inndconffile;
372
373 static int max_connections=10;
374 static int max_queue_per_conn=200;
375 static int target_max_feedfile_size=100000;
376 static int period_seconds=60;
377 static int filepoll_seconds=5;
378 static int max_queue_per_ipf=-1;
379
380 static int connection_setup_timeout=200;
381 static int inndcomm_flush_timeout=100;
382
383 static double nocheck_thresh= 95.0; /* converted from percentage by main */
384 static double nocheck_decay= 100; /* conv'd from articles to lambda by main */
385
386 /* all these are initialised to seconds, and converted to periods in main */
387 static int reconnect_delay_periods=1000;
388 static int flushfail_retry_periods=1000;
389 static int backlog_retry_minperiods=100;
390 static int backlog_spontrescan_periods=300;
391 static int spontaneous_flush_periods=100000;
392 static int max_separated_periods=2000;
393 static int need_activity_periods=1000;
394 static int recentact_thresh=3;
395 static int recentact_periods=1000;
396
397 static double max_bad_data_ratio= 1; /* conv'd from percentage by main */
398 static int max_bad_data_initial= 30;
399   /* in one corrupt 4096-byte block the number of newlines has
400    * mean 16 and standard deviation 3.99.  30 corresponds to z=+3.5 */
401
402
403 /*----- statistics -----*/
404
405 typedef enum {      /* in queue                 in conn->sent             */
406   art_Unchecked,    /*   not checked, not sent    checking                */
407   art_Wanted,       /*   checked, wanted          sent body as requested  */
408   art_Unsolicited,  /*   -                        sent body without check */
409   art_MaxState,
410 } ArtState;
411
412 static const char *const artstate_names[]=
413   { "Unchecked", "Wanted", "Unsolicited", 0 };
414
415 #define RESULT_COUNTS(RCS,RCN)                  \
416   RCS(sent)                                     \
417   RCS(accepted)                                 \
418   RCN(unwanted)                                 \
419   RCN(rejected)                                 \
420   RCN(deferred)                                 \
421   RCN(missing)                                  \
422   RCN(connretry)
423
424 #define RCI_TRIPLE_FMT_BASE "%d (id=%d,bod=%d,nc=%d)"
425 #define RCI_TRIPLE_VALS_BASE(counts,x)          \
426        counts[art_Unchecked] x                  \
427        + counts[art_Wanted] x                   \
428        + counts[art_Unsolicited] x,             \
429        counts[art_Unchecked] x                  \
430        , counts[art_Wanted] x                   \
431        , counts[art_Unsolicited] x
432
433 typedef enum {
434 #define RC_INDEX(x) RC_##x,
435   RESULT_COUNTS(RC_INDEX, RC_INDEX)
436   RCI_max
437 } ResultCountIndex;
438
439
440 /*----- transmission buffers -----*/
441
442 #define CONNIOVS 128
443
444 typedef enum {
445   xk_Const, xk_Artdata
446 } XmitKind;
447
448 struct XmitDetails {
449   XmitKind kind;
450   union {
451     ARTHANDLE *sm_art;
452   } info;
453 };
454
455
456 /*----- core operational data structure types -----*/
457
458 struct InputFile {
459   /* This is also an instance of struct oop_readable */
460   struct oop_readable readable; /* first */
461   oop_readable_call *readable_callback;
462   void *readable_callback_user;
463
464   int fd;
465   Filemon_Perfile *filemon;
466
467   oop_read *rd; /* non-0: reading; 0: constructing, or had EOF */
468   off_t offset;
469   int skippinglong, paused, fake_readable;
470
471   ArticleList queue;
472   long inprogress; /* includes queue.count and also articles in conns */
473   long autodefer; /* -1 means not doing autodefer */
474
475   int counts[art_MaxState][RCI_max];
476   int readcount_ok, readcount_blank, readcount_err, count_nooffer_missing;
477   char path[];
478 };
479
480 struct Article {
481   ISNODE(Article);
482   ArtState state;
483   int midlen, missing;
484   InputFile *ipf;
485   TOKEN token;
486   off_t offset;
487   int blanklen;
488   char messageid[1];
489 };
490
491 #define SMS_LIST(X)                             \
492   X(NORMAL)                                     \
493   X(FLUSHING)                                   \
494   X(FLUSHFAILED)                                \
495   X(SEPARATED)                                  \
496   X(DROPPING)                                   \
497   X(DROPPED)
498
499 enum StateMachineState {
500 #define SMS_DEF_ENUM(s) sm_##s,
501   SMS_LIST(SMS_DEF_ENUM)
502 };
503
504 static const char *sms_names[]= {
505 #define SMS_DEF_NAME(s) #s ,
506   SMS_LIST(SMS_DEF_NAME)
507   0
508 };
509
510 struct Conn {
511   ISNODE(Conn);
512   int fd; /* may be 0, meaning closed (during construction/destruction) */
513   oop_read *rd; /* likewise */
514   int max_queue, stream, quitting;
515   int since_activity; /* periods */
516   ArticleList waiting; /* not yet told peer */
517   ArticleList priority; /* peer says send it now */
518   ArticleList sent; /* offered/transmitted - in xmit or waiting reply */
519   struct iovec xmit[CONNIOVS];
520   XmitDetails xmitd[CONNIOVS];
521   int xmitu;
522 };
523
524
525 /*----- general operational variables -----*/
526
527 /* main initialises */
528 static oop_source *loop;
529 static ConnList conns;
530 static char *path_lock, *path_flushing, *path_defer, *path_dump;
531 static char *globpat_backlog;
532 static pid_t self_pid;
533 static int *recentact_perperiod;
534 static int recentact_circptr;
535 static int recentact_total;
536
537 /* statemc_init initialises */
538 static StateMachineState sms;
539 static int until_flush;
540 static InputFile *main_input_file, *flushing_input_file, *backlog_input_file;
541 static FILE *defer;
542
543 /* initialisation to 0 is good */
544 static int until_connect, until_backlog_nextscan;
545 static double accept_proportion;
546 static int nocheck, nocheck_reported, in_child;
547
548 /* for simulation, debugging, etc. */
549 int simulate_flush= -1;
550
551 /*========== logging ==========*/
552
553 static void logcore(int sysloglevel, const char *fmt, ...) PRINTF(2,3);
554 static void logcore(int sysloglevel, const char *fmt, ...) {
555   VA;
556   if (become_daemon) {
557     vsyslog(sysloglevel,fmt,al);
558   } else {
559     if (self_pid) fprintf(stderr,"[%lu] ",(unsigned long)self_pid);
560     vfprintf(stderr,fmt,al);
561     putc('\n',stderr);
562   }
563   va_end(al);
564 }
565
566 static void logv(int sysloglevel, const char *pfx, int errnoval,
567                  const char *fmt, va_list al) PRINTF(5,0);
568 static void logv(int sysloglevel, const char *pfx, int errnoval,
569                  const char *fmt, va_list al) {
570   char msgbuf[1024]; /* NB do not call xvasprintf here or you'll recurse */
571   vsnprintf(msgbuf,sizeof(msgbuf), fmt,al);
572   msgbuf[sizeof(msgbuf)-1]= 0;
573
574   if (sysloglevel >= LOG_ERR && (errnoval==EACCES || errnoval==EPERM))
575     sysloglevel= LOG_ERR; /* run by wrong user, probably */
576
577   logcore(sysloglevel, "<%s>%s: %s%s%s",
578          sitename, pfx, msgbuf,
579          errnoval>=0 ? ": " : "",
580          errnoval>=0 ? strerror(errnoval) : "");
581 }
582
583 #define diewrap(fn, pfx, sysloglevel, err, estatus)             \
584   static void fn(const char *fmt, ...) NORET_PRINTF(1,2);       \
585   static void fn(const char *fmt, ...) {                        \
586     preterminate();                                             \
587     VA;                                                         \
588     logv(sysloglevel, pfx, err, fmt, al);                       \
589     exit(estatus);                                              \
590   }
591
592 #define logwrap(fn, pfx, sysloglevel, err)              \
593   static void fn(const char *fmt, ...) PRINTF(1,2);     \
594   static void fn(const char *fmt, ...) {                \
595     VA;                                                 \
596     logv(sysloglevel, pfx, err, fmt, al);               \
597     va_end(al);                                         \
598   }
599
600 diewrap(sysdie,   " critical", LOG_CRIT,    errno, 16);
601 diewrap(die,      " critical", LOG_CRIT,    -1,    16);
602
603 diewrap(sysfatal, " fatal",    LOG_ERR,     errno, 12);
604 diewrap(fatal,    " fatal",    LOG_ERR,     -1,    12);
605
606 logwrap(syswarn,  " warning",  LOG_WARNING, errno);
607 logwrap(warn,     " warning",  LOG_WARNING, -1);
608
609 logwrap(notice,   " notice",   LOG_NOTICE,  -1);
610 logwrap(info,     " info",     LOG_INFO,    -1);
611 logwrap(debug,    " debug",    LOG_DEBUG,   -1);
612
613
614 /*========== utility functions etc. ==========*/
615
616 static char *xvasprintf(const char *fmt, va_list al) PRINTF(1,0);
617 static char *xvasprintf(const char *fmt, va_list al) {
618   char *str;
619   int rc= vasprintf(&str,fmt,al);
620   if (rc<0) sysdie("vasprintf(\"%s\",...) failed", fmt);
621   return str;
622 }
623 static char *xasprintf(const char *fmt, ...) PRINTF(1,2);
624 static char *xasprintf(const char *fmt, ...) {
625   VA;
626   char *str= xvasprintf(fmt,al);
627   va_end(al);
628   return str;
629 }
630
631 static int close_perhaps(int *fd) {
632   if (*fd <= 0) return 0;
633   int r= close(*fd);
634   *fd=0;
635   return r;
636 }
637 static void xclose(int fd, const char *what, const char *what2) {
638   int r= close(fd);
639   if (r) sysdie("close %s%s",what,what2?what2:"");
640 }
641 static void xclose_perhaps(int *fd, const char *what, const char *what2) {
642   if (*fd <= 0) return;
643   xclose(*fd,what,what2);
644   *fd=0;
645 }
646
647 static pid_t xfork(const char *what) {
648   pid_t child;
649
650   child= fork();
651   if (child==-1) sysfatal("cannot fork for %s",what);
652   debug("forked %s %ld", what, (unsigned long)child);
653   if (!child) postfork();
654   return child;
655 }
656
657 static void on_fd_read_except(int fd, oop_call_fd callback) {
658   loop->on_fd(loop, fd, OOP_READ,      callback, 0);
659   loop->on_fd(loop, fd, OOP_EXCEPTION, callback, 0);
660 }
661 static void cancel_fd_read_except(int fd) {
662   loop->cancel_fd(loop, fd, OOP_READ);
663   loop->cancel_fd(loop, fd, OOP_EXCEPTION);
664 }
665
666 static void report_child_status(const char *what, int status) {
667   if (WIFEXITED(status)) {
668     int es= WEXITSTATUS(status);
669     if (es)
670       warn("%s: child died with error exit status %d", what, es);
671   } else if (WIFSIGNALED(status)) {
672     int sig= WTERMSIG(status);
673     const char *sigstr= strsignal(sig);
674     const char *coredump= WCOREDUMP(status) ? " (core dumped)" : "";
675     if (sigstr)
676       warn("%s: child died due to fatal signal %s%s", what, sigstr, coredump);
677     else
678       warn("%s: child died due to unknown fatal signal %d%s",
679            what, sig, coredump);
680   } else {
681     warn("%s: child died with unknown wait status %d", what,status);
682   }
683 }
684
685 static int xwaitpid(pid_t *pid, const char *what) {
686   int status;
687
688   int r= kill(*pid, SIGKILL);
689   if (r) sysdie("cannot kill %s child", what);
690
691   pid_t got= waitpid(*pid, &status, 0);
692   if (got==-1) sysdie("cannot reap %s child", what);
693   if (got==0) die("cannot reap %s child", what);
694
695   *pid= 0;
696
697   return status;
698 }
699
700 static void *zxmalloc(size_t sz) {
701   void *p= xmalloc(sz);
702   memset(p,0,sz);
703   return p;
704 }
705
706 static void xunlink(const char *path, const char *what) {
707   int r= unlink(path);
708   if (r) sysdie("can't unlink %s %s", path, what);
709 }
710
711 static time_t xtime(void) {
712   time_t now= time(0);
713   if (now==-1) sysdie("time(2) failed");
714   return now;
715 }
716
717 static void xsigaction(int signo, const struct sigaction *sa) {
718   int r= sigaction(signo,sa,0);
719   if (r) sysdie("sigaction failed for \"%s\"", strsignal(signo));
720 }
721
722 static void xsigsetdefault(int signo) {
723   struct sigaction sa;
724   memset(&sa,0,sizeof(sa));
725   sa.sa_handler= SIG_DFL;
726   xsigaction(signo,&sa);
727 }
728
729 static void xgettimeofday(struct timeval *tv_r) {
730   int r= gettimeofday(tv_r,0);
731   if (r) sysdie("gettimeofday(2) failed");
732 }
733
734 static void xsetnonblock(int fd, int nonblocking) {
735   int errnoval= oop_fd_nonblock(fd, nonblocking);
736   if (errnoval) { errno= errnoval; sysdie("setnonblocking"); }
737 }
738
739 static void check_isreg(const struct stat *stab, const char *path,
740                         const char *what) {
741   if (!S_ISREG(stab->st_mode))
742     die("%s %s not a plain file (mode 0%lo)",
743         what, path, (unsigned long)stab->st_mode);
744 }
745
746 static void xfstat(int fd, struct stat *stab_r, const char *what) {
747   int r= fstat(fd, stab_r);
748   if (r) sysdie("could not fstat %s", what);
749 }
750
751 static void xfstat_isreg(int fd, struct stat *stab_r,
752                          const char *path, const char *what) {
753   xfstat(fd, stab_r, what);
754   check_isreg(stab_r, path, what);
755 }
756
757 static void xlstat_isreg(const char *path, struct stat *stab,
758                          int *enoent_r /* 0 means ENOENT is fatal */,
759                          const char *what) {
760   int r= lstat(path, stab);
761   if (r) {
762     if (errno==ENOENT && enoent_r) { *enoent_r=1; return; }
763     sysdie("could not lstat %s %s", what, path);
764   }
765   if (enoent_r) *enoent_r= 0;
766   check_isreg(stab, path, what);
767 }
768
769 static int samefile(const struct stat *a, const struct stat *b) {
770   assert(S_ISREG(a->st_mode));
771   assert(S_ISREG(b->st_mode));
772   return (a->st_ino == b->st_ino &&
773           a->st_dev == b->st_dev);
774 }
775
776 static char *sanitise(const char *input, int len) {
777   static char sanibuf[100]; /* returns pointer to this buffer! */
778
779   const char *p= input;
780   const char *endp= len>=0 ? input+len : 0;
781   char *q= sanibuf;
782   *q++= '`';
783   for (;;) {
784     if (q > sanibuf+sizeof(sanibuf)-8) { strcpy(q,"'.."); break; }
785     int c= (!endp || p<endp) ? *p++ : 0;
786     if (!c) { *q++= '\''; *q=0; break; }
787     if (c>=' ' && c<=126 && c!='\\') { *q++= c; continue; }
788     sprintf(q,"\\x%02x",c);
789     q += 4;
790   }
791   return sanibuf;
792 }
793
794 static int isewouldblock(int errnoval) {
795   return errnoval==EWOULDBLOCK || errnoval==EAGAIN;
796 }
797
798 /*========== command and control (CLI) connections ==========*/
799
800 static int cli_master;
801
802 typedef struct CliConn CliConn;
803 struct CliConn {
804   void (*destroy)(CliConn*);
805   int fd;
806   oop_read *rd;
807   FILE *out;
808   union {
809     struct sockaddr sa;
810     struct sockaddr_un un;
811   } sa;
812   socklen_t salen;
813 };
814
815 static const oop_rd_style cli_rd_style= {
816   OOP_RD_DELIM_STRIP, '\n',
817   OOP_RD_NUL_FORBID,
818   OOP_RD_SHORTREC_FORBID
819 };
820
821 static void cli_destroy(CliConn *cc) {
822   cc->destroy(cc);
823 }
824
825 static void cli_checkouterr(CliConn *cc /* may destroy*/) {
826   if (ferror(cc->out) | fflush(cc->out)) {
827     info("CTRL%d write error %s", cc->fd, strerror(errno));
828     cli_destroy(cc);
829   }
830 }
831
832 static void cli_prompt(CliConn *cc /* may destroy*/) {
833   fprintf(cc->out, "%s| ", sitename);
834   cli_checkouterr(cc);
835 }
836
837 struct CliCommand {
838   const char *cmd;
839   void (*f)(CliConn *cc, const CliCommand *ccmd,
840             const char *arg, size_t argsz);
841   void *xdata;
842   int xval;
843 };
844
845 static const CliCommand cli_commands[];
846
847 #define CCMD(wh)                                                \
848   static void ccmd_##wh(CliConn *cc, const CliCommand *c,       \
849                         const char *arg, size_t argsz)
850
851 CCMD(help) {
852   fputs("commands:\n", cc->out);
853   const CliCommand *ccmd;
854   for (ccmd=cli_commands; ccmd->cmd; ccmd++)
855     fprintf(cc->out, " %s\n", ccmd->cmd);
856   fputs("NB: permissible arguments are not shown above."
857         "  Not all commands listed are safe.  See innduct(8).\n", cc->out);
858 }
859
860 CCMD(flush) {
861   int ok= trigger_flush_ok("manual request");
862   if (!ok) fprintf(cc->out,"already flushing (state is %s)\n", sms_names[sms]);
863 }
864
865 CCMD(stop) {
866   preterminate();
867   notice("terminating (CTRL%d)",cc->fd);
868   raise_default(SIGTERM);
869   abort();
870 }
871
872 CCMD(dump);
873
874 /* messing with our head: */
875 CCMD(period) { period(); }
876 CCMD(setintarg) { *(int*)c->xdata= atoi(arg); }
877 CCMD(setint) { *(int*)c->xdata= c->xval; }
878 CCMD(setint_period) { *(int*)c->xdata= c->xval; period(); }
879
880 static const CliCommand cli_commands[]= {
881   { "h",             ccmd_help      },
882   { "flush",         ccmd_flush     },
883   { "stop",          ccmd_stop      },
884   { "dump q",        ccmd_dump, 0,0 },
885   { "dump a",        ccmd_dump, 0,1 },
886
887   { "p",             ccmd_period    },
888
889 #define POKES(cmd,func)                                                 \
890   { cmd "flush",     func,           &until_flush,             1 },     \
891   { cmd "conn",      func,           &until_connect,           0 },     \
892   { cmd "blscan",    func,           &until_backlog_nextscan,  0 },
893 POKES("next ", ccmd_setint)
894 POKES("prod ", ccmd_setint_period)
895
896   { "pretend flush", ccmd_setintarg, &simulate_flush             },
897   { "wedge blscan",  ccmd_setint,    &until_backlog_nextscan, -1 },
898   { 0 }
899 };
900
901 static void *cli_rd_ok(oop_source *lp, oop_read *oread, oop_rd_event ev,
902                        const char *errmsg, int errnoval,
903                        const char *data, size_t recsz, void *cc_v) {
904   CliConn *cc= cc_v;
905
906   if (!data) {
907     info("CTRL%d closed", cc->fd);
908     cc->destroy(cc);
909     return OOP_CONTINUE;
910   }
911
912   if (recsz == 0) goto prompt;
913
914   const CliCommand *ccmd;
915   for (ccmd=cli_commands; ccmd->cmd; ccmd++) {
916     int l= strlen(ccmd->cmd);
917     if (recsz < l) continue;
918     if (recsz > l && data[l] != ' ') continue;
919     if (memcmp(data, ccmd->cmd, l)) continue;
920
921     int argl= (int)recsz - (l+1); 
922     ccmd->f(cc, ccmd, argl>=0 ? data+l+1 : 0, argl);
923     goto prompt;
924   }
925
926   fputs("unknown command; h for help\n", cc->out);
927
928  prompt:
929   cli_prompt(cc);
930   return OOP_CONTINUE;
931 }
932
933 static void *cli_rd_err(oop_source *lp, oop_read *oread, oop_rd_event ev,
934                         const char *errmsg, int errnoval,
935                         const char *data, size_t recsz, void *cc_v) {
936   CliConn *cc= cc_v;
937   
938   info("CTRL%d read error %s", cc->fd, errmsg);
939   cc->destroy(cc);
940   return OOP_CONTINUE;
941 }
942
943 static int cli_conn_startup(CliConn *cc /* may destroy*/,
944                                 const char *how) {
945   cc->rd= oop_rd_new_fd(loop, cc->fd, 0,0);
946   if (!cc->rd) { warn("oop_rd_new_fd cli failed"); return -1; }
947
948   int er= oop_rd_read(cc->rd, &cli_rd_style, MAX_CLI_COMMAND,
949                       cli_rd_ok, cc,
950                       cli_rd_err, cc);
951   if (er) { errno= er; syswarn("oop_rd_read cli failed"); return -1; }
952
953   info("CTRL%d %s ready", cc->fd, how);
954   cli_prompt(cc);
955   return 0;
956 }
957
958 static void cli_stdio_destroy(CliConn *cc) {
959   if (cc->rd) {
960     oop_rd_cancel(cc->rd);
961     errno= oop_rd_delete_tidy(cc->rd);
962     if (errno) syswarn("oop_rd_delete tidy failed (no-nonblock stdin?)");
963   }
964   free(cc);
965 }
966
967 static void cli_stdio(void) {
968   NEW_DECL(CliConn *,cc);
969   cc->destroy= cli_stdio_destroy;
970
971   cc->fd= 0;
972   cc->out= stdout;
973   int r= cli_conn_startup(cc,"stdio");
974   if (r) cc->destroy(cc);
975 }
976
977 static void cli_accepted_destroy(CliConn *cc) {
978   if (cc->rd) {
979     oop_rd_cancel(cc->rd);
980     oop_rd_delete_kill(cc->rd);
981   }
982   if (cc->out) { fclose(cc->out); cc->fd=0; }
983   close_perhaps(&cc->fd);
984   free(cc);
985 }
986
987 static void *cli_master_readable(oop_source *lp, int master,
988                                  oop_event ev, void *u) {
989   NEW_DECL(CliConn *,cc);
990   cc->destroy= cli_accepted_destroy;
991
992   cc->salen= sizeof(cc->sa);
993   cc->fd= accept(master, &cc->sa.sa, &cc->salen);
994   if (cc->fd<0) { syswarn("error accepting cli connection"); goto x; }
995
996   cc->out= fdopen(cc->fd, "w");
997   if (!cc->out) { syswarn("error fdopening accepted cli connection"); goto x; }
998
999   int r= cli_conn_startup(cc, "accepted");
1000   if (r) goto x;
1001
1002   return OOP_CONTINUE;
1003
1004  x:
1005   cc->destroy(cc);
1006   return OOP_CONTINUE;
1007 }
1008
1009 #define NOCLI(...) do{                                          \
1010     syswarn("no cli listener, because failed to " __VA_ARGS__); \
1011     goto nocli;                                                 \
1012   }while(0)
1013
1014 static void cli_init(void) {
1015   union {
1016     struct sockaddr sa;
1017     struct sockaddr_un un;
1018   } sa;
1019
1020   memset(&sa,0,sizeof(sa));
1021   int maxlen= sizeof(sa.un.sun_path);
1022
1023   if (!path_cli) {
1024     info("control command line disabled");
1025     return;
1026   }
1027
1028   int pathlen= strlen(path_cli);
1029   if (pathlen > maxlen) {
1030     warn("no cli listener, because cli socket path %s too long (%d>%d)",
1031          path_cli, pathlen, maxlen);
1032     return;
1033   }
1034
1035   if (path_cli_dir) {
1036     int r= mkdir(path_cli_dir, 0700);
1037     if (r && errno!=EEXIST)
1038       NOCLI("create cli socket directory %s", path_cli_dir);
1039   }
1040
1041   int r= unlink(path_cli);
1042   if (r && errno!=ENOENT)
1043     NOCLI("remove old cli socket %s", path_cli);
1044
1045   cli_master= socket(PF_UNIX, SOCK_STREAM, 0);
1046   if (cli_master<0) NOCLI("create new cli master socket");
1047
1048   int sl= pathlen + offsetof(struct sockaddr_un, sun_path);
1049   sa.un.sun_family= AF_UNIX;
1050   memcpy(sa.un.sun_path, path_cli, pathlen);
1051
1052   r= bind(cli_master, &sa.sa, sl);
1053   if (r) NOCLI("bind to cli socket path %s", sa.un.sun_path);
1054
1055   r= listen(cli_master, 5);
1056   if (r) NOCLI("listen to cli master socket");
1057
1058   xsetnonblock(cli_master, 1);
1059
1060   loop->on_fd(loop, cli_master, OOP_READ, cli_master_readable, 0);
1061   info("cli ready, listening on %s", path_cli);
1062
1063   return;
1064
1065  nocli:
1066   xclose_perhaps(&cli_master, "cli master",0);
1067   return;
1068 }
1069
1070 /*========== management of connections ==========*/
1071
1072 static void reconnect_blocking_event(void) {
1073   until_connect= reconnect_delay_periods;
1074 }
1075
1076 static void conn_closefd(Conn *conn, const char *msgprefix) {
1077   int r= close_perhaps(&conn->fd);
1078   if (r) info("C%d %serror closing socket: %s",
1079               conn->fd, msgprefix, strerror(errno));
1080 }
1081
1082 static int conn_busy(Conn *conn) {
1083   return
1084     conn->waiting.count ||
1085     conn->priority.count ||
1086     conn->sent.count ||
1087     conn->xmitu;
1088 }
1089
1090 static void conn_dispose(Conn *conn) {
1091   if (!conn) return;
1092   if (conn->rd) {
1093     oop_rd_cancel(conn->rd);
1094     oop_rd_delete_kill(conn->rd);
1095     conn->rd= 0;
1096   }
1097   if (conn->fd) {
1098     loop->cancel_fd(loop, conn->fd, OOP_WRITE);
1099     loop->cancel_fd(loop, conn->fd, OOP_EXCEPTION);
1100   }
1101   conn_closefd(conn,"");
1102   free(conn);
1103 }
1104
1105 static void *conn_exception(oop_source *lp, int fd,
1106                             oop_event ev, void *conn_v) {
1107   Conn *conn= conn_v;
1108   unsigned char ch;
1109   assert(fd == conn->fd);
1110   assert(ev == OOP_EXCEPTION);
1111   int r= read(conn->fd, &ch, 1);
1112   if (r<0) connfail(conn,"read failed: %s",strerror(errno));
1113   else connfail(conn,"exceptional condition on socket (peer sent urgent"
1114                 " data? read(,&ch,1)=%d,ch='\\x%02x')",r,ch);
1115   return OOP_CONTINUE;
1116 }  
1117
1118 static void vconnfail(Conn *conn, const char *fmt, va_list al) {
1119   int requeue[art_MaxState];
1120   memset(requeue,0,sizeof(requeue));
1121
1122   Article *art;
1123   
1124   while ((art= LIST_REMHEAD(conn->priority)))
1125     LIST_ADDTAIL(art->ipf->queue, art);
1126
1127   while ((art= LIST_REMHEAD(conn->waiting)))
1128     LIST_ADDTAIL(art->ipf->queue, art);
1129
1130   while ((art= LIST_REMHEAD(conn->sent))) {
1131     requeue[art->state]++;
1132     if (art->state==art_Unsolicited) art->state= art_Unchecked;
1133     LIST_ADDTAIL(art->ipf->queue,art);
1134     check_reading_pause_resume(art->ipf);
1135   }
1136
1137   int i;
1138   XmitDetails *d;
1139   for (i=0, d=conn->xmitd; i<conn->xmitu; i++, d++)
1140     xmit_free(d);
1141
1142   LIST_REMOVE(conns,conn);
1143
1144   char *m= xvasprintf(fmt,al);
1145   warn("C%d (now %d) connection failed requeueing " RCI_TRIPLE_FMT_BASE ": %s",
1146        conn->fd, conns.count, RCI_TRIPLE_VALS_BASE(requeue, /*nothing*/), m);
1147   free(m);
1148
1149   reconnect_blocking_event();
1150   conn_dispose(conn);
1151   check_assign_articles();
1152 }
1153
1154 static void connfail(Conn *conn, const char *fmt, ...) {
1155   va_list al;
1156   va_start(al,fmt);
1157   vconnfail(conn,fmt,al);
1158   va_end(al);
1159 }
1160
1161 static void conn_idle_close(Conn *conn, const char *why) {
1162   static const char quitcmd[]= "QUIT\r\n";
1163   int todo= sizeof(quitcmd)-1;
1164   const char *p= quitcmd;
1165   for (;;) {
1166     int r= write(conn->fd, p, todo);
1167     if (r<0) {
1168       if (isewouldblock(errno))
1169         connfail(conn, "blocked writing QUIT to idle connection");
1170       else
1171         connfail(conn, "failed to write QUIT to idle connection: %s",
1172                  strerror(errno));
1173       break;
1174     }
1175     assert(r<=todo);
1176     todo -= r;
1177     if (!todo) {
1178       conn->quitting= 1;
1179       conn->since_activity= 0;
1180       debug("C%d is idle (%s), quitting", conn->fd, why);
1181       break;
1182     }
1183   }
1184 }
1185
1186 /*
1187  * For our last connection, we also shut it down if we have had
1188  * less than K in the last L
1189  */
1190 static void check_idle_conns(void) {
1191   Conn *conn;
1192
1193   int veryrecentact= recentact_perperiod[recentact_circptr];
1194   recentact_circptr++;
1195   recentact_circptr %= recentact_periods;
1196   recentact_total -= recentact_perperiod[recentact_circptr];
1197   recentact_perperiod[recentact_circptr]= 0;
1198
1199   FOR_CONN(conn)
1200     conn->since_activity++;
1201
1202  search_again:
1203   FOR_CONN(conn) {
1204     if (conn->since_activity <= need_activity_periods) continue;
1205
1206     /* We need to shut this down */
1207     if (conn->quitting)
1208       connfail(conn,"timed out waiting for response to QUIT");
1209     else if (conn->sent.count)
1210       connfail(conn,"timed out waiting for responses");
1211     else if (conn->waiting.count || conn->priority.count)
1212       connfail(conn,"BUG IN INNDUCT conn has queue but nothing sent");
1213     else if (conn->xmitu)
1214       connfail(conn,"peer has been sending responses"
1215                " before receiving our commands!");
1216     else
1217       conn_idle_close(conn, "no activity");
1218     
1219     goto search_again;
1220   }
1221
1222   conn= LIST_HEAD(conns);
1223   if (!veryrecentact &&
1224       conns.count==1 &&
1225       recentact_total+veryrecentact < recentact_thresh &&
1226       !conn_busy(conn))
1227     conn_idle_close(conn, "low volume");
1228 }  
1229
1230 /*---------- making new connections ----------*/
1231
1232 static pid_t connecting_child;
1233 static int connecting_fdpass_sock;
1234
1235 static void connect_attempt_discard(void) {
1236   if (connecting_child) {
1237     int status= xwaitpid(&connecting_child, "connect");
1238     if (!(WIFEXITED(status) ||
1239           (WIFSIGNALED(status) && WTERMSIG(status) == SIGKILL)))
1240       report_child_status("connect", status);
1241   }
1242   if (connecting_fdpass_sock) {
1243     cancel_fd_read_except(connecting_fdpass_sock);
1244     xclose_perhaps(&connecting_fdpass_sock, "connecting fdpass socket",0);
1245   }
1246 }
1247
1248 #define PREP_DECL_MSG_CMSG(msg)                 \
1249   char msgbyte= 0;                              \
1250   struct iovec msgiov;                          \
1251   msgiov.iov_base= &msgbyte;                    \
1252   msgiov.iov_len= 1;                            \
1253   struct msghdr msg;                            \
1254   memset(&msg,0,sizeof(msg));                   \
1255   char msg##cbuf[CMSG_SPACE(sizeof(int))];      \
1256   msg.msg_iov= &msgiov;                         \
1257   msg.msg_iovlen= 1;                            \
1258   msg.msg_control= msg##cbuf;                   \
1259   msg.msg_controllen= sizeof(msg##cbuf);
1260
1261 static void *connchild_event(oop_source *lp, int fd, oop_event e, void *u) {
1262   Conn *conn= 0;
1263
1264   assert(fd == connecting_fdpass_sock);
1265
1266   PREP_DECL_MSG_CMSG(msg);
1267   
1268   ssize_t rs= recvmsg(fd, &msg, 0);
1269   if (rs<0) {
1270     if (isewouldblock(errno)) return OOP_CONTINUE;
1271     syswarn("failed to read socket from connecting child");
1272     goto x;
1273   }
1274
1275   NEW(conn);
1276   LIST_INIT(conn->waiting);
1277   LIST_INIT(conn->priority);
1278   LIST_INIT(conn->sent);
1279
1280   struct cmsghdr *h= 0;
1281   if (rs >= 0) h= CMSG_FIRSTHDR(&msg);
1282   if (!h) {
1283     int status= xwaitpid(&connecting_child, "connect child (broken)");
1284
1285     if (WIFEXITED(status)) {
1286       if (WEXITSTATUS(status) != 0 &&
1287           WEXITSTATUS(status) != CONNCHILD_ESTATUS_STREAM &&
1288           WEXITSTATUS(status) != CONNCHILD_ESTATUS_NOSTREAM)
1289         /* child already reported the problem */;
1290       else {
1291         if (e == OOP_EXCEPTION)
1292           warn("connect: connection child exited code %d but"
1293                " unexpected exception on fdpass socket",
1294                WEXITSTATUS(status));
1295         else
1296           warn("connect: connection child exited code %d but"
1297                " no cmsg (rs=%d)",
1298                WEXITSTATUS(status), (int)rs);
1299       }
1300     } else if (WIFSIGNALED(status) && WTERMSIG(status) == SIGALRM) {
1301       warn("connect: connection attempt timed out");
1302     } else {
1303       report_child_status("connect", status);
1304     }
1305     goto x;
1306   }
1307
1308 #define CHK(field, val)                                                  \
1309   if (h->cmsg_##field != val) {                                          \
1310     die("connect: child sent cmsg with cmsg_" #field "=%d, expected %d", \
1311         h->cmsg_##field, val);                                           \
1312     goto x;                                                              \
1313   }
1314   CHK(level, SOL_SOCKET);
1315   CHK(type,  SCM_RIGHTS);
1316   CHK(len,   CMSG_LEN(sizeof(conn->fd)));
1317 #undef CHK
1318
1319   if (CMSG_NXTHDR(&msg,h)) die("connect: child sent many cmsgs");
1320
1321   memcpy(&conn->fd, CMSG_DATA(h), sizeof(conn->fd));
1322
1323   int status;
1324   pid_t got= waitpid(connecting_child, &status, 0);
1325   if (got==-1) sysdie("connect: real wait for child");
1326   assert(got == connecting_child);
1327   connecting_child= 0;
1328
1329   if (!WIFEXITED(status)) { report_child_status("connect",status); goto x; }
1330   int es= WEXITSTATUS(status);
1331   switch (es) {
1332   case CONNCHILD_ESTATUS_STREAM:    conn->stream= 1;   break;
1333   case CONNCHILD_ESTATUS_NOSTREAM:  conn->stream= 0;   break;
1334   default:
1335     fatal("connect: child gave unexpected exit status %d", es);
1336   }
1337
1338   /* Phew! */
1339   conn->max_queue= conn->stream ? max_queue_per_conn : 1;
1340
1341   loop->on_fd(loop, conn->fd, OOP_EXCEPTION, conn_exception, conn);
1342   conn->rd= oop_rd_new_fd(loop,conn->fd, 0, 0); /* sets nonblocking, too */
1343   if (!conn->fd) die("oop_rd_new_fd conn failed (fd=%d)",conn->fd);
1344   int r= oop_rd_read(conn->rd, &peer_rd_style, NNTP_STRLEN,
1345                      &peer_rd_ok, conn,
1346                      &peer_rd_err, conn);
1347   if (r) sysdie("oop_rd_read for peer (fd=%d)",conn->fd);
1348
1349   LIST_ADDHEAD(conns, conn);
1350   notice("C%d (now %d) connected %s",
1351          conn->fd, conns.count, conn->stream ? "streaming" : "plain");
1352
1353   connect_attempt_discard();
1354   check_assign_articles();
1355   return OOP_CONTINUE;
1356
1357  x:
1358   conn_dispose(conn);
1359   connect_attempt_discard();
1360   reconnect_blocking_event();
1361   return OOP_CONTINUE;
1362 }
1363
1364 static int allow_connect_start(void) {
1365   return conns.count < max_connections
1366     && !connecting_child
1367     && !until_connect;
1368 }
1369
1370 static void connect_start(void) {
1371   assert(!connecting_child);
1372   assert(!connecting_fdpass_sock);
1373
1374   info("starting connection attempt");
1375   int ok_reconnect_delay_periods= reconnect_delay_periods;
1376   reconnect_blocking_event();
1377
1378   int socks[2];
1379   int r= socketpair(AF_UNIX, SOCK_STREAM, 0, socks);
1380   if (r) { syswarn("connect: cannot create socketpair for child"); return; }
1381
1382   connecting_child= xfork("connection");
1383
1384   if (!connecting_child) {
1385     FILE *cn_from, *cn_to;
1386     char buf[NNTP_STRLEN+100];
1387     int exitstatus= CONNCHILD_ESTATUS_NOSTREAM;
1388
1389     xclose(socks[0], "(in child) parent's connection fdpass socket",0);
1390
1391     alarm(connection_setup_timeout);
1392     if (NNTPconnect((char*)remote_host, port, &cn_from, &cn_to, buf) < 0) {
1393       int l= strlen(buf);
1394       int stripped=0;
1395       while (l>0) {
1396         unsigned char c= buf[l-1];
1397         if (!isspace(c)) break;
1398         if (c=='\n' || c=='\r') stripped=1;
1399         --l;
1400       }
1401       if (!buf[0]) {
1402         sysfatal("connect: connection attempt failed");
1403       } else {
1404         buf[l]= 0;
1405         fatal("connect: %s: %s", stripped ? "rejected" : "failed",
1406               sanitise(buf,-1));
1407       }
1408     }
1409     if (NNTPsendpassword((char*)remote_host, cn_from, cn_to) < 0)
1410       sysfatal("connect: authentication failed");
1411     if (try_stream) {
1412       if (fputs("MODE STREAM\r\n", cn_to)==EOF ||
1413           fflush(cn_to))
1414         sysfatal("connect: could not send MODE STREAM");
1415       buf[sizeof(buf)-1]= 0;
1416       if (!fgets(buf, sizeof(buf)-1, cn_from)) {
1417         if (ferror(cn_from))
1418           sysfatal("connect: could not read response to MODE STREAM");
1419         else
1420           fatal("connect: connection close in response to MODE STREAM");
1421       }
1422       int l= strlen(buf);
1423       assert(l>=1);
1424       if (buf[l-1]!='\n')
1425         fatal("connect: response to MODE STREAM is too long: %.100s...",
1426               sanitise(buf,-1));
1427       l--;  if (l>0 && buf[l-1]=='\r') l--;
1428       buf[l]= 0;
1429       char *ep;
1430       int rcode= strtoul(buf,&ep,10);
1431       if (ep != &buf[3])
1432         fatal("connect: bad response to MODE STREAM: %.50s", sanitise(buf,-1));
1433
1434       switch (rcode) {
1435       case 203:
1436         exitstatus= CONNCHILD_ESTATUS_STREAM;
1437         break;
1438       case 480:
1439       case 500:
1440         break;
1441       default:
1442         warn("connect: unexpected response to MODE STREAM: %.50s",
1443              sanitise(buf,-1));
1444         exitstatus= 2;
1445         break;
1446       }
1447     }
1448     int fd= fileno(cn_from);
1449
1450     PREP_DECL_MSG_CMSG(msg);
1451     struct cmsghdr *cmsg= CMSG_FIRSTHDR(&msg);
1452     cmsg->cmsg_level= SOL_SOCKET;
1453     cmsg->cmsg_type=  SCM_RIGHTS;
1454     cmsg->cmsg_len=   CMSG_LEN(sizeof(fd));
1455     memcpy(CMSG_DATA(cmsg), &fd, sizeof(fd));
1456
1457     msg.msg_controllen= cmsg->cmsg_len;
1458     r= sendmsg(socks[1], &msg, 0);
1459     if (r<0) sysdie("sendmsg failed for new connection");
1460     if (r!=1) die("sendmsg for new connection gave wrong result %d",r);
1461
1462     _exit(exitstatus);
1463   }
1464
1465   xclose(socks[1], "connecting fdpass child's socket",0);
1466   connecting_fdpass_sock= socks[0];
1467   xsetnonblock(connecting_fdpass_sock, 1);
1468   on_fd_read_except(connecting_fdpass_sock, connchild_event);
1469
1470   if (!conns.count)
1471     reconnect_delay_periods= ok_reconnect_delay_periods;
1472 }
1473
1474 /*---------- assigning articles to conns, and transmitting ----------*/
1475
1476 static Article *dequeue_from(int peek, InputFile *ipf) {
1477   if (!ipf) return 0;
1478   if (peek) return LIST_HEAD(ipf->queue);
1479
1480   Article *art= LIST_REMHEAD(ipf->queue);
1481   if (!art) return 0;
1482   check_reading_pause_resume(ipf);
1483   return art;
1484 }
1485
1486 static Article *dequeue(int peek) {
1487   Article *art;
1488   art= dequeue_from(peek, flushing_input_file);  if (art) return art;
1489   art= dequeue_from(peek, backlog_input_file);   if (art) return art;
1490   art= dequeue_from(peek, main_input_file);      if (art) return art;
1491   return 0;
1492 }
1493
1494 static void check_assign_articles(void) {
1495   for (;;) {
1496     if (!dequeue(1))
1497       break;
1498
1499     Conn *walk, *use=0;
1500     int spare=0, inqueue=0;
1501
1502     /* Find a connection to offer this article.  We prefer a busy
1503      * connection to an idle one, provided it's not full.  We take the
1504      * first (oldest) and since that's stable, it will mean we fill up
1505      * connections in order.  That way if we have too many
1506      * connections, the spare ones will go away eventually.
1507      */
1508     FOR_CONN(walk) {
1509       if (walk->quitting) continue;
1510       inqueue= walk->sent.count + walk->priority.count
1511              + walk->waiting.count;
1512       spare= walk->max_queue - inqueue;
1513       assert(inqueue <= max_queue_per_conn);
1514       assert(spare >= 0);
1515       if (inqueue==0) /*idle*/ { if (!use) use= walk; }
1516       else if (spare>0) /*working*/ { use= walk; break; }
1517     }
1518     if (use) {
1519       if (!inqueue) use->since_activity= 0; /* reset idle counter */
1520       while (spare>0) {
1521         Article *art= dequeue(0);
1522         if (!art) break;
1523         LIST_ADDTAIL(use->waiting, art);
1524         recentact_perperiod[recentact_circptr]++;
1525         spare--;
1526       }
1527       conn_maybe_write(use);
1528     } else if (allow_connect_start()) {
1529       connect_start();
1530       break;
1531     } else {
1532       break;
1533     }
1534   }
1535 }
1536
1537 static void *conn_writeable(oop_source *l, int fd, oop_event ev, void *u) {
1538   conn_maybe_write(u);
1539   return OOP_CONTINUE;
1540 }
1541
1542 static void conn_maybe_write(Conn *conn)  {
1543   for (;;) {
1544     conn_make_some_xmits(conn);
1545     if (!conn->xmitu) {
1546       loop->cancel_fd(loop, conn->fd, OOP_WRITE);
1547       return;
1548     }
1549
1550     void *rp= conn_write_some_xmits(conn);
1551     if (rp==OOP_CONTINUE) {
1552       loop->on_fd(loop, conn->fd, OOP_WRITE, conn_writeable, conn);
1553       return;
1554     } else if (rp==OOP_HALT) {
1555       return;
1556     } else if (!rp) {
1557       /* transmitted everything */
1558     } else {
1559       abort();
1560     }
1561   }
1562 }
1563
1564 /*---------- expiry, flow control and deferral ----------*/
1565
1566 /*
1567  * flow control notes
1568  * to ensure articles go away eventually
1569  * separate queue for each input file
1570  *   queue expiry
1571  *     every period, check head of backlog queue for expiry with SMretrieve
1572  *       if too old: discard, and check next article
1573  *     also check every backlog article as we read it
1574  *   flush expiry
1575  *     after too long in SEPARATED/DROPPING ie Separated/Finishing/Dropping
1576  *     one-off: eat queued articles from flushing and write them to defer
1577  *     one-off: connfail all connections which have any articles from flushing
1578  *     newly read articles from flushing go straight to defer
1579  *     this should take care of it and get us out of this state
1580  * to avoid filling up ram needlessly
1581  *   input control
1582  *     limit number of queued articles for each ipf
1583  *     pause/resume inputfile tailing
1584  */
1585
1586 static void check_reading_pause_resume(InputFile *ipf) {
1587   if (ipf->queue.count >= max_queue_per_ipf)
1588     inputfile_reading_pause(ipf);
1589   else
1590     inputfile_reading_resume(ipf);
1591 }
1592
1593 static void article_defer(Article *art /* not on a queue */, int whichcount) {
1594   open_defer();
1595   if (fprintf(defer, "%s %s\n", TokenToText(art->token), art->messageid) <0
1596       || fflush(defer))
1597     sysfatal("write to defer file %s",path_defer);
1598   article_done(art, whichcount);
1599 }
1600
1601 static int article_check_expired(Article *art /* must be queued, not conn */) {
1602   ARTHANDLE *artdata= SMretrieve(art->token, RETR_STAT);
1603   if (artdata) { SMfreearticle(artdata); return 0; }
1604
1605   LIST_REMOVE(art->ipf->queue, art);
1606   art->missing= 1;
1607   art->ipf->count_nooffer_missing++;
1608   article_done(art,-1);
1609   return 1;
1610 }
1611
1612 static void inputfile_queue_check_expired(InputFile *ipf) {
1613   if (!ipf) return;
1614
1615   for (;;) {
1616     Article *art= LIST_HEAD(ipf->queue);
1617     int exp= article_check_expired(art);
1618     if (!exp) break;
1619   }
1620   check_reading_pause_resume(ipf);
1621 }
1622
1623 static void article_autodefer(InputFile *ipf, Article *art) {
1624   ipf->autodefer++;
1625   article_defer(art,-1);
1626 }
1627
1628 static int has_article_in(const ArticleList *al, InputFile *ipf) {
1629   Article *art;
1630   for (art=LIST_HEAD(*al); art; art=LIST_NEXT(art))
1631     if (art->ipf == ipf) return 1;
1632   return 0;
1633 }
1634
1635 static void autodefer_input_file_articles(InputFile *ipf) {
1636   Article *art;
1637   while ((art= LIST_REMHEAD(ipf->queue)))
1638     article_autodefer(ipf, art);
1639 }
1640
1641 static void autodefer_input_file(InputFile *ipf) {
1642   ipf->autodefer= 0;
1643
1644   autodefer_input_file_articles(ipf);
1645
1646   if (ipf->inprogress) {
1647     Conn *walk;
1648     FOR_CONN(walk) {
1649       if (has_article_in(&walk->waiting,  ipf) ||
1650           has_article_in(&walk->priority, ipf) ||
1651           has_article_in(&walk->sent,     ipf))
1652         walk->quitting= -1;
1653     }
1654     while (ipf->inprogress) {
1655       FOR_CONN(walk)
1656         if (walk->quitting < 0) goto found;
1657       abort(); /* where are they ?? */
1658
1659     found:
1660       connfail(walk, "connection is stuck or crawling,"
1661                " and we need to finish flush");
1662       autodefer_input_file_articles(ipf);
1663     }
1664   }
1665
1666   check_reading_pause_resume(ipf);
1667 }
1668
1669 /*========== article transmission ==========*/
1670
1671 static XmitDetails *xmit_core(Conn *conn, const char *data, int len,
1672                   XmitKind kind) { /* caller must then fill in details */
1673   struct iovec *v= &conn->xmit[conn->xmitu];
1674   XmitDetails *d= &conn->xmitd[conn->xmitu++];
1675   v->iov_base= (char*)data;
1676   v->iov_len= len;
1677   d->kind= kind;
1678   return d;
1679 }
1680
1681 static void xmit_noalloc(Conn *conn, const char *data, int len) {
1682   xmit_core(conn,data,len, xk_Const);
1683 }
1684 #define XMIT_LITERAL(lit) (xmit_noalloc(conn, (lit), sizeof(lit)-1))
1685
1686 static void xmit_artbody(Conn *conn, ARTHANDLE *ah /* consumed */) {
1687   XmitDetails *d= xmit_core(conn, ah->data, ah->len, xk_Artdata);
1688   d->info.sm_art= ah;
1689 }
1690
1691 static void xmit_free(XmitDetails *d) {
1692   switch (d->kind) {
1693   case xk_Artdata: SMfreearticle(d->info.sm_art); break;
1694   case xk_Const:                                  break;
1695   default: abort();
1696   }
1697 }
1698
1699 static void *conn_write_some_xmits(Conn *conn) {
1700   /* return values:
1701    *      0:            nothing more to write, no need to call us again
1702    *      OOP_CONTINUE: more to write but fd not writeable
1703    *      OOP_HALT:     disaster, have destroyed conn
1704    */
1705   for (;;) {
1706     int count= conn->xmitu;
1707     if (!count) return 0;
1708
1709     if (count > IOV_MAX) count= IOV_MAX;
1710     ssize_t rs= writev(conn->fd, conn->xmit, count);
1711     if (rs < 0) {
1712       if (isewouldblock(errno)) return OOP_CONTINUE;
1713       connfail(conn, "write failed: %s", strerror(errno));
1714       return OOP_HALT;
1715     }
1716     assert(rs > 0);
1717
1718     int done;
1719     for (done=0; rs; ) {
1720       assert(done<conn->xmitu);
1721       struct iovec *vp= &conn->xmit[done];
1722       XmitDetails *dp= &conn->xmitd[done];
1723       if (rs >= vp->iov_len) {
1724         rs -= vp->iov_len;
1725         xmit_free(dp); /* vp->iov_len -= vp->iov_len, etc. */
1726         done++;
1727       } else {
1728         vp->iov_base= (char*)vp->iov_base + rs;
1729         vp->iov_len -= rs;
1730         break; /* rs -= rs */
1731       }
1732     }
1733     int newu= conn->xmitu - done;
1734     memmove(conn->xmit,  conn->xmit  + done, newu * sizeof(*conn->xmit));
1735     memmove(conn->xmitd, conn->xmitd + done, newu * sizeof(*conn->xmitd));
1736     conn->xmitu= newu;
1737   }
1738 }
1739
1740 static void conn_make_some_xmits(Conn *conn) {
1741   for (;;) {
1742     if (conn->xmitu+5 > CONNIOVS)
1743       break;
1744
1745     Article *art= LIST_REMHEAD(conn->priority);
1746     if (!art) art= LIST_REMHEAD(conn->waiting);
1747     if (!art) break;
1748
1749     if (art->state >= art_Wanted || (conn->stream && nocheck)) {
1750       /* actually send it */
1751
1752       ARTHANDLE *artdata= SMretrieve(art->token, RETR_ALL);
1753
1754       art->state=
1755         art->state == art_Unchecked ? art_Unsolicited :
1756         art->state == art_Wanted    ? art_Wanted      :
1757         (abort(),-1);
1758
1759       if (!artdata) art->missing= 1;
1760       art->ipf->counts[art->state][ artdata ? RC_sent : RC_missing ]++;
1761
1762       if (conn->stream) {
1763         if (artdata) {
1764           XMIT_LITERAL("TAKETHIS ");
1765           xmit_noalloc(conn, art->messageid, art->midlen);
1766           XMIT_LITERAL("\r\n");
1767           xmit_artbody(conn, artdata);
1768         } else {
1769           article_done(art, -1);
1770           continue;
1771         }
1772       } else {
1773         /* we got 235 from IHAVE */
1774         if (artdata) {
1775           xmit_artbody(conn, artdata);
1776         } else {
1777           XMIT_LITERAL(".\r\n");
1778         }
1779       }
1780
1781       LIST_ADDTAIL(conn->sent, art);
1782
1783     } else {
1784       /* check it */
1785
1786       if (conn->stream)
1787         XMIT_LITERAL("CHECK ");
1788       else
1789         XMIT_LITERAL("IHAVE ");
1790       xmit_noalloc(conn, art->messageid, art->midlen);
1791       XMIT_LITERAL("\r\n");
1792
1793       assert(art->state == art_Unchecked);
1794       art->ipf->counts[art->state][RC_sent]++;
1795       LIST_ADDTAIL(conn->sent, art);
1796     }
1797   }
1798 }
1799
1800 /*========== handling responses from peer ==========*/
1801
1802 static const oop_rd_style peer_rd_style= {
1803   OOP_RD_DELIM_STRIP, '\n',
1804   OOP_RD_NUL_FORBID,
1805   OOP_RD_SHORTREC_FORBID
1806 };
1807
1808 static void *peer_rd_err(oop_source *lp, oop_read *oread, oop_rd_event ev,
1809                          const char *errmsg, int errnoval,
1810                          const char *data, size_t recsz, void *conn_v) {
1811   Conn *conn= conn_v;
1812   connfail(conn, "error receiving from peer: %s", errmsg);
1813   return OOP_CONTINUE;
1814 }
1815
1816 static Article *article_reply_check(Conn *conn, const char *response,
1817                                     int code_indicates_streaming,
1818                                     int must_have_sent
1819                                         /* 1:yes, -1:no, 0:dontcare */,
1820                                     const char *sanitised_response) {
1821   Article *art= LIST_HEAD(conn->sent);
1822
1823   if (!art) {
1824     connfail(conn,
1825              "peer gave unexpected response when no commands outstanding: %s",
1826              sanitised_response);
1827     return 0;
1828   }
1829
1830   if (code_indicates_streaming) {
1831     assert(!memchr(response, 0, 4)); /* ensured by peer_rd_ok */
1832     if (!conn->stream) {
1833       connfail(conn, "peer gave streaming response code "
1834                " to IHAVE or subsequent body: %s", sanitised_response);
1835       return 0;
1836     }
1837     const char *got_mid= response+4;
1838     int got_midlen= strcspn(got_mid, " \n\r");
1839     if (got_midlen<3 || got_mid[0]!='<' || got_mid[got_midlen-1]!='>') {
1840       connfail(conn, "peer gave streaming response with syntactically invalid"
1841                " messageid: %s", sanitised_response);
1842       return 0;
1843     }
1844     if (got_midlen != art->midlen ||
1845         memcmp(got_mid, art->messageid, got_midlen)) {
1846       connfail(conn, "peer gave streaming response code to wrong article -"
1847                " probable synchronisation problem; we offered: %s;"
1848                " peer said: %s",
1849                art->messageid, sanitised_response);
1850       return 0;
1851     }
1852   } else {
1853     if (conn->stream) {
1854       connfail(conn, "peer gave non-streaming response code to"
1855                " CHECK/TAKETHIS: %s", sanitised_response);
1856       return 0;
1857     }
1858   }
1859
1860   if (must_have_sent>0 && art->state < art_Wanted) {
1861     connfail(conn, "peer says article accepted but"
1862              " we had not sent the body: %s", sanitised_response);
1863     return 0;
1864   }
1865   if (must_have_sent<0 && art->state >= art_Wanted) {
1866     connfail(conn, "peer says please sent the article but we just did: %s",
1867              sanitised_response);
1868     return 0;
1869   }
1870
1871   Article *art_again= LIST_REMHEAD(conn->sent);
1872   assert(art_again == art);
1873   return art;
1874 }
1875
1876 static void update_nocheck(int accepted) {
1877   accept_proportion *= nocheck_decay;
1878   accept_proportion += accepted * (1.0 - nocheck_decay);
1879   int new_nocheck= accept_proportion >= nocheck_thresh;
1880   if (new_nocheck && !nocheck_reported) {
1881     notice("entering nocheck mode for the first time");
1882     nocheck_reported= 1;
1883   } else if (new_nocheck != nocheck) {
1884     debug("nocheck mode %s", new_nocheck ? "start" : "stop");
1885   }
1886   nocheck= new_nocheck;
1887 }
1888
1889 static void article_done(Article *art, int whichcount) {
1890   if (whichcount>=0 && !art->missing)
1891     art->ipf->counts[art->state][whichcount]++;
1892
1893   if (whichcount == RC_accepted) update_nocheck(1);
1894   else if (whichcount == RC_unwanted) update_nocheck(0);
1895
1896   InputFile *ipf= art->ipf;
1897
1898   while (art->blanklen) {
1899     static const char spaces[]=
1900       "                                                                "
1901       "                                                                "
1902       "                                                                "
1903       "                                                                "
1904       "                                                                "
1905       "                                                                "
1906       "                                                                "
1907       "                                                                "
1908       "                                                                ";
1909     int w= art->blanklen;  if (w >= sizeof(spaces)) w= sizeof(spaces)-1;
1910     int r= pwrite(ipf->fd, spaces, w, art->offset);
1911     if (r==-1) {
1912       if (errno==EINTR) continue;
1913       sysdie("failed to blank entry for %s (length %d at offset %lu) in %s",
1914              art->messageid, art->blanklen,
1915              (unsigned long)art->offset, ipf->path);
1916     }
1917     assert(r>=0 && r<=w);
1918     art->blanklen -= w;
1919     art->offset += w;
1920   }
1921
1922   ipf->inprogress--;
1923   assert(ipf->inprogress >= 0);
1924   free(art);
1925
1926   if (!ipf->inprogress && ipf != main_input_file)
1927     queue_check_input_done();
1928 }
1929
1930 static void *peer_rd_ok(oop_source *lp, oop_read *oread, oop_rd_event ev,
1931                         const char *errmsg, int errnoval,
1932                         const char *data, size_t recsz, void *conn_v) {
1933   Conn *conn= conn_v;
1934
1935   if (ev == OOP_RD_EOF) {
1936     connfail(conn, "unexpected EOF from peer");
1937     return OOP_CONTINUE;
1938   }
1939   assert(ev == OOP_RD_OK);
1940
1941   char *sani= sanitise(data,-1);
1942
1943   char *ep;
1944   unsigned long code= strtoul(data, &ep, 10);
1945   if (ep != data+3 || *ep != ' ' || data[0]=='0') {
1946     connfail(conn, "badly formatted response from peer: %s", sani);
1947     return OOP_CONTINUE;
1948   }
1949
1950   int busy= conn_busy(conn);
1951
1952   if (conn->quitting) {
1953     if (code!=205 && code!=400) {
1954       connfail(conn, "peer gave unexpected response to QUIT: %s", sani);
1955     } else {
1956       LIST_REMOVE(conns,conn);
1957       notice("C%d (now %d) idle connection closed by us",
1958              conn->fd, conns.count);
1959       assert(!busy);
1960       conn_dispose(conn);
1961     }
1962     return OOP_CONTINUE;
1963   }
1964
1965   conn->since_activity= 0;
1966   Article *art;
1967
1968 #define GET_ARTICLE(musthavesent) do{                                         \
1969     art= article_reply_check(conn, data, code_streaming, musthavesent, sani); \
1970     if (!art) return OOP_CONTINUE; /* reply_check has failed the conn */      \
1971   }while(0) 
1972
1973 #define ARTICLE_DEALTWITH(streaming,musthavesent,how) do{       \
1974     code_streaming= (streaming);                                \
1975     GET_ARTICLE(musthavesent);                                  \
1976     article_done(art, RC_##how);                                \
1977     goto dealtwith;                                             \
1978   }while(0)
1979
1980 #define PEERBADMSG(m) do {                                      \
1981     connfail(conn, m ": %s", sani);  return OOP_CONTINUE;       \
1982   }while(0)
1983
1984   int code_streaming= 0;
1985
1986   switch (code) {
1987
1988   default:  PEERBADMSG("peer sent unexpected message");
1989
1990   case 400:
1991     if (busy)
1992       PEERBADMSG("peer timed us out or stopped accepting articles");
1993
1994     LIST_REMOVE(conns,conn);
1995     notice("C%d (now %d) idle connection closed by peer",
1996            conns.count, conn->fd);
1997     conn_dispose(conn);
1998     return OOP_CONTINUE;
1999
2000   case 435: ARTICLE_DEALTWITH(0,0,unwanted); /* IHAVE says they have it */
2001   case 438: ARTICLE_DEALTWITH(1,0,unwanted); /* CHECK/TAKETHIS: they have it */
2002
2003   case 235: ARTICLE_DEALTWITH(0,1,accepted); /* IHAVE says thanks */
2004   case 239: ARTICLE_DEALTWITH(1,1,accepted); /* TAKETHIS says thanks */
2005
2006   case 437: ARTICLE_DEALTWITH(0,0,rejected); /* IHAVE says rejected */
2007   case 439: ARTICLE_DEALTWITH(1,0,rejected); /* TAKETHIS says rejected */
2008
2009   case 238: /* CHECK says send it */
2010     code_streaming= 1;
2011   case 335: /* IHAVE says send it */
2012     GET_ARTICLE(-1);
2013     assert(art->state == art_Unchecked);
2014     art->ipf->counts[art->state][RC_accepted]++;
2015     art->state= art_Wanted;
2016     LIST_ADDTAIL(conn->priority, art);
2017     break;
2018
2019   case 431: /* CHECK or TAKETHIS says try later */
2020     code_streaming= 1;
2021   case 436: /* IHAVE says try later */
2022     GET_ARTICLE(0);
2023     article_defer(art, RC_deferred);
2024     break;
2025
2026   }
2027 dealtwith:
2028
2029   conn_maybe_write(conn);
2030   check_assign_articles();
2031   return OOP_CONTINUE;
2032 }
2033
2034
2035 /*========== monitoring of input files ==========*/
2036
2037 static void feedfile_eof(InputFile *ipf) {
2038   assert(ipf != main_input_file); /* promised by tailing_try_read */
2039   inputfile_reading_stop(ipf);
2040
2041   if (ipf == flushing_input_file) {
2042     assert(sms==sm_SEPARATED || sms==sm_DROPPING);
2043     if (main_input_file) inputfile_reading_start(main_input_file);
2044     statemc_check_flushing_done();
2045   } else if (ipf == backlog_input_file) {
2046     statemc_check_backlog_done();
2047   } else {
2048     abort(); /* supposed to wait rather than get EOF on main input file */
2049   }
2050 }
2051
2052 static InputFile *open_input_file(const char *path) {
2053   int fd= open(path, O_RDWR);
2054   if (fd<0) {
2055     if (errno==ENOENT) return 0;
2056     sysfatal("unable to open input file %s", path);
2057   }
2058   assert(fd>0);
2059
2060   InputFile *ipf= xmalloc(sizeof(*ipf) + strlen(path) + 1);
2061   memset(ipf,0,sizeof(*ipf));
2062
2063   ipf->fd= fd;
2064   ipf->autodefer= -1;
2065   LIST_INIT(ipf->queue);
2066   strcpy(ipf->path, path);
2067
2068   return ipf;
2069 }
2070
2071 static void close_input_file(InputFile *ipf) { /* does not free */
2072   assert(!ipf->readable_callback); /* must have had ->on_cancel */
2073   assert(!ipf->filemon); /* must have had inputfile_reading_stop */
2074   assert(!ipf->rd); /* must have had inputfile_reading_stop */
2075   assert(!ipf->inprogress); /* no dangling pointers pointing here */
2076   xclose_perhaps(&ipf->fd, "input file ", ipf->path);
2077 }
2078
2079
2080 /*---------- dealing with articles read in the input file ----------*/
2081
2082 static void *feedfile_got_bad_data(InputFile *ipf, off_t offset,
2083                                    const char *data, const char *how) {
2084   warn("corrupted file: %s, offset %lu: %s: in %s",
2085        ipf->path, (unsigned long)offset, how, sanitise(data,-1));
2086   ipf->readcount_err++;
2087   if (ipf->readcount_err > max_bad_data_initial +
2088       (ipf->readcount_ok+ipf->readcount_blank) / max_bad_data_ratio)
2089     die("too much garbage in input file!  (%d errs, %d ok, %d blank)",
2090         ipf->readcount_err, ipf->readcount_ok, ipf->readcount_blank);
2091   return OOP_CONTINUE;
2092 }
2093
2094 static void *feedfile_read_err(oop_source *lp, oop_read *rd,
2095                                oop_rd_event ev, const char *errmsg,
2096                                int errnoval, const char *data, size_t recsz,
2097                                void *ipf_v) {
2098   InputFile *ipf= ipf_v;
2099   assert(ev == OOP_RD_SYSTEM);
2100   errno= errnoval;
2101   sysdie("error reading input file: %s, offset %lu",
2102          ipf->path, (unsigned long)ipf->offset);
2103 }
2104
2105 static void *feedfile_got_article(oop_source *lp, oop_read *rd,
2106                                   oop_rd_event ev, const char *errmsg,
2107                                   int errnoval, const char *data, size_t recsz,
2108                                   void *ipf_v) {
2109   InputFile *ipf= ipf_v;
2110   Article *art;
2111   char tokentextbuf[sizeof(TOKEN)*2+3];
2112
2113   if (!data) { feedfile_eof(ipf); return OOP_CONTINUE; }
2114
2115   off_t old_offset= ipf->offset;
2116   ipf->offset += recsz + !!(ev == OOP_RD_OK);
2117
2118 #define X_BAD_DATA(m) return feedfile_got_bad_data(ipf,old_offset,data,m);
2119
2120   if (ev==OOP_RD_PARTREC)
2121     feedfile_got_bad_data(ipf,old_offset,data,"missing final newline");
2122     /* but process it anyway */
2123
2124   if (ipf->skippinglong) {
2125     if (ev==OOP_RD_OK) ipf->skippinglong= 0; /* fine now */
2126     return OOP_CONTINUE;
2127   }
2128   if (ev==OOP_RD_LONG) {
2129     ipf->skippinglong= 1;
2130     X_BAD_DATA("overly long line");
2131   }
2132
2133   if (memchr(data,'\0',recsz)) X_BAD_DATA("nul byte");
2134   if (!recsz) X_BAD_DATA("empty line");
2135
2136   if (data[0]==' ') {
2137     if (strspn(data," ") != recsz) X_BAD_DATA("line partially blanked");
2138     ipf->readcount_blank++;
2139     return OOP_CONTINUE;
2140   }
2141
2142   char *space= strchr(data,' ');
2143   int tokenlen= space-data;
2144   int midlen= (int)recsz-tokenlen-1;
2145   if (midlen <= 2) X_BAD_DATA("no room for messageid");
2146   if (space[1]!='<' || space[midlen]!='>') X_BAD_DATA("invalid messageid");
2147
2148   if (tokenlen != sizeof(TOKEN)*2+2) X_BAD_DATA("token wrong length");
2149   memcpy(tokentextbuf, data, tokenlen);
2150   tokentextbuf[tokenlen]= 0;
2151   if (!IsToken(tokentextbuf)) X_BAD_DATA("token wrong syntax");
2152
2153   ipf->readcount_ok++;
2154
2155   art= xmalloc(sizeof(*art) - 1 + midlen + 1);
2156   memset(art,0,sizeof(*art));
2157   art->state= art_Unchecked;
2158   art->midlen= midlen;
2159   art->ipf= ipf;  ipf->inprogress++;
2160   art->token= TextToToken(tokentextbuf);
2161   art->offset= old_offset;
2162   art->blanklen= recsz;
2163   strcpy(art->messageid, space+1);
2164   LIST_ADDTAIL(ipf->queue, art);
2165
2166   if (ipf->autodefer >= 0)
2167     article_autodefer(ipf, art);
2168   else if (ipf==backlog_input_file)
2169     article_check_expired(art);
2170
2171   if (sms==sm_NORMAL && ipf==main_input_file &&
2172       ipf->offset >= target_max_feedfile_size)
2173     statemc_start_flush("feed file size");
2174
2175   check_assign_articles(); /* may destroy conn but that's OK */
2176   check_reading_pause_resume(ipf);
2177   return OOP_CONTINUE;
2178 }
2179
2180 /*========== tailing input file ==========*/
2181
2182 static void *tailing_rable_call_time(oop_source *loop, struct timeval tv,
2183                                      void *user) {
2184   /* lifetime of ipf here is OK because destruction will cause
2185    * on_cancel which will cancel this callback */
2186   InputFile *ipf= user;
2187
2188   if (!ipf->fake_readable) return OOP_CONTINUE;
2189
2190   /* we just keep calling readable until our caller (oop_rd)
2191    * has called try_read, and try_read has found EOF so given EAGAIN */
2192   loop->on_time(loop, OOP_TIME_NOW, tailing_rable_call_time, ipf);
2193
2194   return ipf->readable_callback(loop, &ipf->readable,
2195                                 ipf->readable_callback_user);
2196 }
2197
2198 static void tailing_on_cancel(struct oop_readable *rable) {
2199   InputFile *ipf= (void*)rable;
2200
2201   if (ipf->filemon) filemon_stop(ipf);
2202   loop->cancel_time(loop, OOP_TIME_NOW, tailing_rable_call_time, ipf);
2203   ipf->readable_callback= 0;
2204 }
2205
2206 static void tailing_make_readable(InputFile *ipf) {
2207   if (!ipf || !ipf->readable_callback) /* so callers can be naive */
2208     return;
2209   ipf->fake_readable= 1;
2210   loop->on_time(loop, OOP_TIME_NOW, tailing_rable_call_time, ipf);
2211 }
2212
2213 static int tailing_on_readable(struct oop_readable *rable,
2214                                 oop_readable_call *cb, void *user) {
2215   InputFile *ipf= (void*)rable;
2216
2217   tailing_on_cancel(rable);
2218   ipf->readable_callback= cb;
2219   ipf->readable_callback_user= user;
2220   filemon_start(ipf);
2221   tailing_make_readable(ipf);
2222   return 0;
2223 }
2224
2225 static ssize_t tailing_try_read(struct oop_readable *rable, void *buffer,
2226                                 size_t length) {
2227   InputFile *ipf= (void*)rable;
2228   for (;;) {
2229     ssize_t r= read(ipf->fd, buffer, length);
2230     if (r==-1) {
2231       if (errno==EINTR) continue;
2232       ipf->fake_readable= 0;
2233       return r;
2234     }
2235     if (!r) {
2236       if (ipf==main_input_file) {
2237         errno=EAGAIN;
2238         ipf->fake_readable= 0;
2239         return -1;
2240       } else if (ipf==flushing_input_file) {
2241         assert(ipf->rd);
2242         assert(sms==sm_SEPARATED || sms==sm_DROPPING);
2243       } else if (ipf==backlog_input_file) {
2244         assert(ipf->rd);
2245       } else {
2246         abort();
2247       }
2248     }
2249     return r;
2250   }
2251 }
2252
2253 /*---------- filemon implemented with inotify ----------*/
2254
2255 #if defined(HAVE_SYS_INOTIFY_H) && !defined(HAVE_FILEMON)
2256 #define HAVE_FILEMON
2257
2258 #include <sys/inotify.h>
2259
2260 static int filemon_inotify_fd;
2261 static int filemon_inotify_wdmax;
2262 static InputFile **filemon_inotify_wd2ipf;
2263
2264 struct Filemon_Perfile {
2265   int wd;
2266 };
2267
2268 static void filemon_method_startfile(InputFile *ipf, Filemon_Perfile *pf) {
2269   int wd= inotify_add_watch(filemon_inotify_fd, ipf->path, IN_MODIFY);
2270   if (wd < 0) sysfatal("inotify_add_watch %s", ipf->path);
2271
2272   if (wd >= filemon_inotify_wdmax) {
2273     int newmax= wd+2;
2274     filemon_inotify_wd2ipf= xrealloc(filemon_inotify_wd2ipf,
2275                                  sizeof(*filemon_inotify_wd2ipf) * newmax);
2276     memset(filemon_inotify_wd2ipf + filemon_inotify_wdmax, 0,
2277            sizeof(*filemon_inotify_wd2ipf) * (newmax - filemon_inotify_wdmax));
2278     filemon_inotify_wdmax= newmax;
2279   }
2280
2281   assert(!filemon_inotify_wd2ipf[wd]);
2282   filemon_inotify_wd2ipf[wd]= ipf;
2283
2284   debug("filemon inotify startfile %p wd=%d wdmax=%d",
2285         ipf, wd, filemon_inotify_wdmax);
2286
2287   pf->wd= wd;
2288 }
2289
2290 static void filemon_method_stopfile(InputFile *ipf, Filemon_Perfile *pf) {
2291   int wd= pf->wd;
2292   debug("filemon inotify stopfile %p wd=%d", ipf, wd);
2293   int r= inotify_rm_watch(filemon_inotify_fd, wd);
2294   if (r) sysdie("inotify_rm_watch");
2295   filemon_inotify_wd2ipf[wd]= 0;
2296 }
2297
2298 static void *filemon_inotify_readable(oop_source *lp, int fd,
2299                                       oop_event e, void *u) {
2300   struct inotify_event iev;
2301   for (;;) {
2302     int r= read(filemon_inotify_fd, &iev, sizeof(iev));
2303     if (r==-1) {
2304       if (isewouldblock(errno)) break;
2305       sysdie("read from inotify master");
2306     } else if (r==sizeof(iev)) {
2307       assert(iev.wd >= 0 && iev.wd < filemon_inotify_wdmax);
2308     } else {
2309       die("inotify read %d bytes wanted struct of %d", r, (int)sizeof(iev));
2310     }
2311     InputFile *ipf= filemon_inotify_wd2ipf[iev.wd];
2312     /*debug("filemon inotify readable read %p wd=%d", ipf, iev.wd);*/
2313     tailing_make_readable(ipf);
2314   }
2315   return OOP_CONTINUE;
2316 }
2317
2318 static int filemon_method_init(void) {
2319   filemon_inotify_fd= inotify_init();
2320   if (filemon_inotify_fd<0) {
2321     syswarn("filemon/inotify: inotify_init failed");
2322     return 0;
2323   }
2324   xsetnonblock(filemon_inotify_fd, 1);
2325   loop->on_fd(loop, filemon_inotify_fd, OOP_READ, filemon_inotify_readable, 0);
2326
2327   debug("filemon inotify init filemon_inotify_fd=%d", filemon_inotify_fd);
2328   return 1;
2329 }
2330
2331 static void filemon_method_dump_info(FILE *f) {
2332   int i;
2333   fprintf(f,"inotify");
2334   DUMPV("%d",,filemon_inotify_fd);
2335   DUMPV("%d",,filemon_inotify_wdmax);
2336   for (i=0; i<filemon_inotify_wdmax; i++)
2337     fprintf(f," wd2ipf[%d]=%p\n", i, filemon_inotify_wd2ipf[i]);
2338 }
2339
2340 #endif /* HAVE_INOTIFY && !HAVE_FILEMON */
2341
2342 /*---------- filemon dummy implementation ----------*/
2343
2344 #if !defined(HAVE_FILEMON)
2345
2346 struct Filemon_Perfile { int dummy; };
2347
2348 static int filemon_method_init(void) {
2349   warn("filemon/dummy: no filemon method compiled in");
2350   return 0;
2351 }
2352 static void filemon_method_startfile(InputFile *ipf, Filemon_Perfile *pf) { }
2353 static void filemon_method_stopfile(InputFile *ipf, Filemon_Perfile *pf) { }
2354 static void filemon_method_dump_info(FILE *f) { fprintf(f,"dummy\n"); }
2355
2356 #endif /* !HAVE_FILEMON */
2357
2358 /*---------- filemon generic interface ----------*/
2359
2360 static void filemon_start(InputFile *ipf) {
2361   assert(!ipf->filemon);
2362
2363   NEW(ipf->filemon);
2364   filemon_method_startfile(ipf, ipf->filemon);
2365 }
2366
2367 static void filemon_stop(InputFile *ipf) {
2368   if (!ipf->filemon) return;
2369   filemon_method_stopfile(ipf, ipf->filemon);
2370   free(ipf->filemon);
2371   ipf->filemon= 0;
2372 }
2373
2374 /*---------- interface to start and stop an input file ----------*/
2375
2376 static const oop_rd_style feedfile_rdstyle= {
2377   OOP_RD_DELIM_STRIP, '\n',
2378   OOP_RD_NUL_PERMIT,
2379   OOP_RD_SHORTREC_LONG,
2380 };
2381
2382 static void inputfile_reading_resume(InputFile *ipf) {
2383   if (!ipf->rd) return;
2384   if (!ipf->paused) return;
2385
2386   int r= oop_rd_read(ipf->rd, &feedfile_rdstyle, MAX_LINE_FEEDFILE,
2387                      feedfile_got_article,ipf, feedfile_read_err, ipf);
2388   if (r) sysdie("unable start reading feedfile %s",ipf->path);
2389
2390   ipf->paused= 0;
2391 }
2392
2393 static void inputfile_reading_pause(InputFile *ipf) {
2394   if (!ipf->rd) return;
2395   if (ipf->paused) return;
2396   oop_rd_cancel(ipf->rd);
2397   ipf->paused= 1;
2398 }
2399
2400 static void inputfile_reading_start(InputFile *ipf) {
2401   assert(!ipf->rd);
2402   ipf->readable.on_readable= tailing_on_readable;
2403   ipf->readable.on_cancel=   tailing_on_cancel;
2404   ipf->readable.try_read=    tailing_try_read;
2405   ipf->readable.delete_tidy= 0; /* we never call oop_rd_delete_{tidy,kill} */
2406   ipf->readable.delete_kill= 0;
2407
2408   ipf->readable_callback= 0;
2409   ipf->readable_callback_user= 0;
2410
2411   ipf->rd= oop_rd_new(loop, &ipf->readable, 0,0);
2412   assert(ipf->rd);
2413
2414   ipf->paused= 1;
2415   inputfile_reading_resume(ipf);
2416 }
2417
2418 static void inputfile_reading_stop(InputFile *ipf) {
2419   assert(ipf->rd);
2420   inputfile_reading_pause(ipf);
2421   oop_rd_delete(ipf->rd);
2422   ipf->rd= 0;
2423   assert(!ipf->filemon); /* we shouldn't be monitoring it now */
2424 }
2425
2426
2427 /*========== interaction with innd - state machine ==========*/
2428
2429 /* See official state diagram at top of file.  We implement
2430  * this as follows:
2431  * -8<-
2432
2433             .=======.
2434             ||START||
2435             `======='
2436                 |
2437                 | open F
2438                 |
2439                 |    F ENOENT
2440                 |`---------------------------------------------------.
2441       F OPEN OK |                                                    |
2442                 |`---------------- - - -                             |
2443        D ENOENT |       D EXISTS   see OVERALL STATES diagram        |
2444                 |                  for full startup logic            |
2445      ,--------->|                                                    |
2446      |          V                                                    |
2447      |     ============                                       try to |
2448      |      NORMAL                                            open D |
2449      |     [Normal]                                                  |
2450      |      main F tail                                              |
2451      |     ============                                              V
2452      |          |                                                    |
2453      |          | F IS SO BIG WE SHOULD FLUSH, OR TIMEOUT            |
2454      ^          | hardlink F to D                                    |
2455      |     [Hardlinked]                                              |
2456      |          | unlink F                                           |
2457      |          | our handle onto F is now onto D                    |
2458      |     [Moved]                                                   |
2459      |          |                                                    |
2460      |          |<-------------------<---------------------<---------+
2461      |          |                                                    |
2462      |          | spawn inndcomm flush                               |
2463      |          V                                                    |
2464      |     ==================                                        |
2465      |      FLUSHING[-ABSENT]                                        |
2466      |     [Flushing]                                                |
2467      |     main D tail/none                                          |
2468      |     ==================                                        |
2469      |          |                                                    |
2470      |          |   INNDCOMM FLUSH FAILS                             ^
2471      |          |`----------------------->----------.                |
2472      |          |                                   |                |
2473      |          |   NO SUCH SITE                    V                |
2474      ^          |`--------------->----.         ==================== |
2475      |          |                      \        FLUSHFAILED[-ABSENT] |
2476      |          |                       \         [Moved]            |
2477      |          | FLUSH OK               \       main D tail/none    |
2478      |          | open F                  \     ==================== |
2479      |          |                          \        |                |
2480      |          |                           \       | TIME TO RETRY  |
2481      |          |`------->----.     ,---<---'\      `----------------'
2482      |          |    D NONE   |     | D NONE  `----.
2483      |          V             |     |              V
2484      |     =============      V     V             ============
2485      |      SEPARATED-1       |     |              DROPPING-1
2486      |      flsh->rd!=0       |     |              flsh->rd!=0
2487      |     [Separated]        |     |             [Dropping]
2488      |      main F idle       |     |              main none
2489      |      flsh D tail       |     |              flsh D tail
2490      |     =============      |     |             ============
2491      |          |             |     | install       |
2492      ^          | EOF ON D    |     |  defer        | EOF ON D
2493      |          V             |     |               V
2494      |     ===============    |     |             ===============
2495      |      SEPARATED-2       |     |              DROPPING-2
2496      |      flsh->rd==0       |     V              flsh->rd==0
2497      |     [Finishing]        |     |             [Dropping]
2498      |      main F tail       |     `.             main none
2499      |      flsh D closed     |       `.           flsh D closed
2500      |     ===============    V         `.        ===============
2501      |          |                         `.          |
2502      |          | ALL D PROCESSED           `.        | ALL D PROCESSED
2503      |          V install defer as backlog    `.      | install defer
2504      ^          | close D                       `.    | close D
2505      |          | unlink D                        `.  | unlink D
2506      |          |                                  |  |
2507      |          |                                  V  V
2508      `----------'                               ==============
2509                                                  DROPPED
2510                                                 [Dropped]
2511                                                  main none
2512                                                  flsh none
2513                                                  some backlog
2514                                                 ==============
2515                                                       |
2516                                                       | ALL BACKLOG DONE
2517                                                       |
2518                                                       | unlink lock
2519                                                       | exit
2520                                                       V
2521                                                   ==========
2522                                                    (ESRCH)
2523                                                   [Droppped]
2524                                                   ==========
2525  * ->8-
2526  */
2527
2528 static void startup_set_input_file(InputFile *f) {
2529   assert(!main_input_file);
2530   main_input_file= f;
2531   inputfile_reading_start(f);
2532 }
2533
2534 static void statemc_lock(void) {
2535   int lockfd;
2536   struct stat stab, stabf;
2537   
2538   for (;;) {
2539     lockfd= open(path_lock, O_CREAT|O_RDWR, 0600);
2540     if (lockfd<0) sysfatal("open lockfile %s", path_lock);
2541
2542     struct flock fl;
2543     memset(&fl,0,sizeof(fl));
2544     fl.l_type= F_WRLCK;
2545     fl.l_whence= SEEK_SET;
2546     int r= fcntl(lockfd, F_SETLK, &fl);
2547     if (r==-1) {
2548       if (errno==EACCES || isewouldblock(errno)) {
2549         if (quiet_multiple) exit(0);
2550         fatal("another duct holds the lockfile");
2551       }
2552       sysfatal("fcntl F_SETLK lockfile %s", path_lock);
2553     }
2554
2555     xfstat_isreg(lockfd, &stabf, path_lock, "lockfile");
2556     int lock_noent;
2557     xlstat_isreg(path_lock, &stab, &lock_noent, "lockfile");
2558
2559     if (!lock_noent && samefile(&stab, &stabf))
2560       break;
2561
2562     xclose(lockfd, "stale lockfile ", path_lock);
2563   }
2564
2565   FILE *lockfile= fdopen(lockfd, "w");
2566   if (!lockfile) sysdie("fdopen lockfile");
2567
2568   int r= ftruncate(lockfd, 0);
2569   if (r) sysdie("truncate lockfile to write new info");
2570
2571   if (fprintf(lockfile, "pid %ld\nsite %s\nfeedfile %s\nfqdn %s\n",
2572               (unsigned long)self_pid,
2573               sitename, feedfile, remote_host) == EOF ||
2574       fflush(lockfile))
2575     sysfatal("write info to lockfile %s", path_lock);
2576
2577   debug("startup: locked");
2578 }
2579
2580 static void statemc_init(void) {
2581   struct stat stabdefer;
2582
2583   search_backlog_file();
2584
2585   int defer_noent;
2586   xlstat_isreg(path_defer, &stabdefer, &defer_noent, "defer file");
2587   if (defer_noent) {
2588     debug("startup: ductdefer ENOENT");
2589   } else {
2590     debug("startup: ductdefer nlink=%ld", (long)stabdefer.st_nlink);
2591     switch (stabdefer.st_nlink==1) {
2592     case 1:
2593       open_defer(); /* so that we will later close it and rename it */
2594       break;
2595     case 2:
2596       xunlink(path_defer, "stale defer file link"
2597               " (presumably hardlink to backlog file)");
2598       break;
2599     default:
2600       die("defer file %s has unexpected link count %d",
2601           path_defer, stabdefer.st_nlink);
2602     }
2603   }
2604
2605   struct stat stab_f, stab_d;
2606   int noent_f;
2607
2608   InputFile *file_d= open_input_file(path_flushing);
2609   if (file_d) xfstat_isreg(file_d->fd, &stab_d, path_flushing,"flushing file");
2610
2611   xlstat_isreg(feedfile, &stab_f, &noent_f, "feedfile");
2612
2613   if (!noent_f && file_d && samefile(&stab_f, &stab_d)) {
2614     debug("startup: F==D => Hardlinked");
2615     xunlink(feedfile, "feed file (during startup)"); /* => Moved */
2616     noent_f= 1;
2617   }
2618
2619   if (noent_f) {
2620     debug("startup: F ENOENT => Moved");
2621     if (file_d) startup_set_input_file(file_d);
2622     spawn_inndcomm_flush("feedfile missing at startup");
2623     /* => Flushing, sms:=FLUSHING */
2624   } else {
2625     if (file_d) {
2626       debug("startup: F!=D => Separated");
2627       startup_set_input_file(file_d);
2628       flushing_input_file= main_input_file;
2629       main_input_file= open_input_file(feedfile);
2630       if (!main_input_file) die("feedfile vanished during startup");
2631       SMS(SEPARATED, max_separated_periods,
2632           "found both old and current feed files");
2633     } else {
2634       debug("startup: F exists, D ENOENT => Normal");
2635       InputFile *file_f= open_input_file(feedfile);
2636       if (!file_f) die("feed file vanished during startup");
2637       startup_set_input_file(file_f);
2638       SMS(NORMAL, spontaneous_flush_periods, "normal startup");
2639     }
2640   }
2641 }
2642
2643 static void statemc_start_flush(const char *why) { /* Normal => Flushing */
2644   assert(sms == sm_NORMAL);
2645
2646   debug("starting flush (%s) (%lu >?= %lu) (%d)",
2647         why,
2648         (unsigned long)(main_input_file ? main_input_file->offset : 0),
2649         (unsigned long)target_max_feedfile_size,
2650         until_flush);
2651
2652   int r= link(feedfile, path_flushing);
2653   if (r) sysfatal("link feedfile %s to flushing file %s",
2654                   feedfile, path_flushing);
2655   /* => Hardlinked */
2656
2657   xunlink(feedfile, "old feedfile link");
2658   /* => Moved */
2659
2660   spawn_inndcomm_flush(why); /* => Flushing FLUSHING */
2661 }
2662
2663 static int trigger_flush_ok(const char *why) {
2664   switch (sms) {
2665
2666   case sm_NORMAL:
2667     statemc_start_flush(why ? why : "periodic");
2668     return 1;                           /* Normal => Flushing; => FLUSHING */
2669
2670   case sm_FLUSHFAILED:
2671     spawn_inndcomm_flush(why ? why : "retry");
2672     return 1;                            /* Moved => Flushing; => FLUSHING */
2673
2674   case sm_SEPARATED:
2675   case sm_DROPPING:
2676     warn("abandoning old feedfile after flush (%s), autodeferring",
2677          why ? why : "took too long to complete");
2678     assert(flushing_input_file);
2679     autodefer_input_file(flushing_input_file);
2680     return 1;
2681
2682   default:
2683     return 0;
2684   }
2685 }
2686
2687 static void statemc_period_poll(void) {
2688   if (!until_flush) return;
2689   until_flush--;
2690   assert(until_flush>=0);
2691
2692   if (until_flush) return;
2693   int ok= trigger_flush_ok(0);
2694   assert(ok);
2695 }
2696
2697 static int inputfile_is_done(InputFile *ipf) {
2698   if (!ipf) return 0;
2699   if (ipf->inprogress) return 0; /* new article in the meantime */
2700   if (ipf->rd) return 0; /* not had EOF */
2701   return 1;
2702 }
2703
2704 static void notice_processed(InputFile *ipf, int completed,
2705                              const char *what, const char *spec) {
2706   if (!ipf) return; /* allows preterminate to be lazy */
2707
2708 #define RCI_NOTHING(x) /* nothing */
2709 #define RCI_TRIPLE_FMT(x) " " #x "=" RCI_TRIPLE_FMT_BASE
2710 #define RCI_TRIPLE_VALS(x) , RCI_TRIPLE_VALS_BASE(ipf->counts, [RC_##x])
2711
2712 #define CNT(art,rc) (ipf->counts[art_##art][RC_##rc])
2713
2714   char *inprog= completed
2715     ? xasprintf("%s","") /* GCC produces a stupid warning for printf("") ! */
2716     : xasprintf(" inprogress=%ld", ipf->inprogress);
2717   char *autodefer= ipf->autodefer >= 0
2718     ? xasprintf(" autodeferred=%ld", ipf->autodefer)
2719     : xasprintf("%s","");
2720
2721   info("%s %s%s read=%d (+bl=%d,+err=%d)%s%s"
2722        " missing=%d offered=%d (ch=%d,nc=%d) accepted=%d (ch=%d,nc=%d)"
2723        RESULT_COUNTS(RCI_NOTHING, RCI_TRIPLE_FMT)
2724        ,
2725        completed?"completed":"processed", what, spec,
2726        ipf->readcount_ok, ipf->readcount_blank, ipf->readcount_err,
2727        inprog, autodefer, ipf->count_nooffer_missing,
2728        CNT(Unchecked,sent) + CNT(Unsolicited,sent)
2729        , CNT(Unchecked,sent), CNT(Unsolicited,sent),
2730        CNT(Wanted,accepted) + CNT(Unsolicited,accepted)
2731        , CNT(Wanted,accepted), CNT(Unsolicited,accepted)
2732        RESULT_COUNTS(RCI_NOTHING,  RCI_TRIPLE_VALS)
2733        );
2734
2735   free(inprog);
2736   free(autodefer);
2737
2738 #undef CNT
2739 }
2740
2741 static void statemc_check_backlog_done(void) {
2742   InputFile *ipf= backlog_input_file;
2743   if (!inputfile_is_done(ipf)) return;
2744
2745   const char *slash= strrchr(ipf->path, '/');
2746   const char *leaf= slash ? slash+1 : ipf->path;
2747   const char *under= strchr(slash, '_');
2748   const char *rest= under ? under+1 : leaf;
2749   if (!strncmp(rest,"backlog",7)) rest += 7;
2750   notice_processed(ipf,1,"backlog ",rest);
2751
2752   close_input_file(ipf);
2753   if (unlink(ipf->path)) {
2754     if (errno != ENOENT)
2755       sysdie("could not unlink processed backlog file %s", ipf->path);
2756     warn("backlog file %s vanished while we were reading it"
2757          " so we couldn't remove it (but it's done now, anyway)",
2758          ipf->path);
2759   }
2760   free(ipf);
2761   backlog_input_file= 0;
2762   search_backlog_file();
2763   return;
2764 }
2765
2766 static void statemc_check_flushing_done(void) {
2767   InputFile *ipf= flushing_input_file;
2768   if (!inputfile_is_done(ipf)) return;
2769
2770   assert(sms==sm_SEPARATED || sms==sm_DROPPING);
2771
2772   notice_processed(ipf,1,"feedfile","");
2773
2774   close_defer();
2775
2776   xunlink(path_flushing, "old flushing file");
2777
2778   close_input_file(flushing_input_file);
2779   free(flushing_input_file);
2780   flushing_input_file= 0;
2781
2782   if (sms==sm_SEPARATED) {
2783     notice("flush complete");
2784     SMS(NORMAL, spontaneous_flush_periods, "flush complete");
2785   } else if (sms==sm_DROPPING) {
2786     SMS(DROPPED, max_separated_periods, "old flush complete");
2787     search_backlog_file();
2788     notice("feed dropped, but will continue until backlog is finished");
2789   }
2790 }
2791
2792 static void *statemc_check_input_done(oop_source *lp, struct timeval now,
2793                                       void *u) {
2794   assert(!inputfile_is_done(main_input_file));
2795   statemc_check_flushing_done();
2796   statemc_check_backlog_done();
2797   return OOP_CONTINUE;
2798 }
2799
2800 static void queue_check_input_done(void) {
2801   loop->on_time(loop, OOP_TIME_NOW, statemc_check_input_done, 0);
2802 }
2803
2804 static void statemc_setstate(StateMachineState newsms, int periods,
2805                              const char *forlog, const char *why) {
2806   sms= newsms;
2807   until_flush= periods;
2808
2809   const char *xtra= "";
2810   switch (sms) {
2811   case sm_FLUSHING:
2812   case sm_FLUSHFAILED:
2813     if (!main_input_file) xtra= "-ABSENT";
2814     break;
2815   case sm_SEPARATED:
2816   case sm_DROPPING:
2817     xtra= flushing_input_file->rd ? "-1" : "-2";
2818     break;
2819   default:;
2820   }
2821
2822   if (periods) {
2823     info("state %s%s[%d] %s",forlog,xtra,periods,why);
2824   } else {
2825     info("state %s%s %s",forlog,xtra,why);
2826   }
2827 }
2828
2829 /*---------- defer and backlog files ----------*/
2830
2831 static void open_defer(void) {
2832   struct stat stab;
2833
2834   if (defer) return;
2835
2836   defer= fopen(path_defer, "a+");
2837   if (!defer) sysfatal("could not open defer file %s", path_defer);
2838
2839   /* truncate away any half-written records */
2840
2841   xfstat_isreg(fileno(defer), &stab, path_defer, "newly opened defer file");
2842
2843   if (stab.st_size > LONG_MAX)
2844     die("defer file %s size is far too large", path_defer);
2845
2846   if (!stab.st_size)
2847     return;
2848
2849   long orgsize= stab.st_size;
2850   long truncto= stab.st_size;
2851   for (;;) {
2852     if (!truncto) break; /* was only (if anything) one half-truncated record */
2853     if (fseek(defer, truncto-1, SEEK_SET) < 0)
2854       sysdie("seek in defer file %s while truncating partial", path_defer);
2855
2856     int r= getc(defer);
2857     if (r==EOF) {
2858       if (ferror(defer))
2859         sysdie("failed read from defer file %s", path_defer);
2860       else
2861         die("defer file %s shrank while we were checking it!", path_defer);
2862     }
2863     if (r=='\n') break;
2864     truncto--;
2865   }
2866
2867   if (stab.st_size != truncto) {
2868     warn("truncating half-record at end of defer file %s -"
2869          " shrinking by %ld bytes from %ld to %ld",
2870          path_defer, orgsize - truncto, orgsize, truncto);
2871
2872     if (fflush(defer))
2873       sysfatal("could not flush defer file %s", path_defer);
2874     if (ftruncate(fileno(defer), truncto))
2875       sysdie("could not truncate defer file %s", path_defer);
2876
2877   } else {
2878     info("continuing existing defer file %s (%ld bytes)",
2879          path_defer, orgsize);
2880   }
2881   if (fseek(defer, truncto, SEEK_SET))
2882     sysdie("could not seek to new end of defer file %s", path_defer);
2883 }
2884
2885 static void close_defer(void) {
2886   if (!defer)
2887     return;
2888
2889   struct stat stab;
2890   xfstat_isreg(fileno(defer), &stab, path_defer, "defer file");
2891
2892   if (fclose(defer)) sysfatal("could not close defer file %s", path_defer);
2893   defer= 0;
2894
2895   time_t now= xtime();
2896
2897   char *backlog= xasprintf("%s_backlog_%lu.%lu", feedfile,
2898                            (unsigned long)now,
2899                            (unsigned long)stab.st_ino);
2900   if (link(path_defer, backlog))
2901     sysfatal("could not install defer file %s as backlog file %s",
2902            path_defer, backlog);
2903   if (unlink(path_defer))
2904     sysdie("could not unlink old defer link %s to backlog file %s",
2905            path_defer, backlog);
2906
2907   free(backlog);
2908
2909   if (until_backlog_nextscan < 0 ||
2910       until_backlog_nextscan > backlog_retry_minperiods + 1)
2911     until_backlog_nextscan= backlog_retry_minperiods + 1;
2912 }
2913
2914 static void poll_backlog_file(void) {
2915   if (until_backlog_nextscan < 0) return;
2916   if (until_backlog_nextscan-- > 0) return;
2917   search_backlog_file();
2918 }
2919
2920 static void search_backlog_file(void) {
2921   /* returns non-0 iff there are any backlog files */
2922
2923   glob_t gl;
2924   int r, i;
2925   struct stat stab;
2926   const char *oldest_path=0;
2927   time_t oldest_mtime=0, now;
2928
2929   if (backlog_input_file) return;
2930
2931  try_again:
2932
2933   r= glob(globpat_backlog, GLOB_ERR|GLOB_MARK|GLOB_NOSORT, 0, &gl);
2934
2935   switch (r) {
2936   case GLOB_ABORTED:
2937     sysfatal("failed to expand backlog pattern %s", globpat_backlog);
2938   case GLOB_NOSPACE:
2939     fatal("out of memory expanding backlog pattern %s", globpat_backlog);
2940   case 0:
2941     for (i=0; i<gl.gl_pathc; i++) {
2942       const char *path= gl.gl_pathv[i];
2943
2944       if (strchr(path,'#') || strchr(path,'~')) {
2945         debug("backlog file search skipping %s", path);
2946         continue;
2947       }
2948       r= stat(path, &stab);
2949       if (r) {
2950         syswarn("failed to stat backlog file %s", path);
2951         continue;
2952       }
2953       if (!S_ISREG(stab.st_mode)) {
2954         warn("backlog file %s is not a plain file (or link to one)", path);
2955         continue;
2956       }
2957       if (!oldest_path || stab.st_mtime < oldest_mtime) {
2958         oldest_path= path;
2959         oldest_mtime= stab.st_mtime;
2960       }
2961     }
2962   case GLOB_NOMATCH: /* fall through */
2963     break;
2964   default:
2965     sysdie("glob expansion of backlog pattern %s gave unexpected"
2966            " nonzero (error?) return value %d", globpat_backlog, r);
2967   }
2968
2969   if (!oldest_path) {
2970     debug("backlog scan: none");
2971
2972     if (sms==sm_DROPPED) {
2973       preterminate();
2974       notice("feed dropped and our work is complete");
2975
2976       int r= unlink(path_cli);
2977       if (r && errno!=ENOENT)
2978         syswarn("failed to unlink cli socket for old feed");
2979
2980       xunlink(path_lock, "lockfile for old feed");
2981       exit(4);
2982     }
2983     until_backlog_nextscan= backlog_spontrescan_periods;
2984     goto xfree;
2985   }
2986
2987   now= xtime();
2988   double age= difftime(now, oldest_mtime);
2989   long age_deficiency= (backlog_retry_minperiods * period_seconds) - age;
2990
2991   if (age_deficiency <= 0) {
2992     debug("backlog scan: found age=%f deficiency=%ld oldest=%s",
2993           age, age_deficiency, oldest_path);
2994
2995     backlog_input_file= open_input_file(oldest_path);
2996     if (!backlog_input_file) {
2997       warn("backlog file %s vanished as we opened it", oldest_path);
2998       globfree(&gl);
2999       goto try_again;
3000     }
3001     inputfile_reading_start(backlog_input_file);
3002     until_backlog_nextscan= -1;
3003     goto xfree;
3004   }
3005
3006   until_backlog_nextscan= age_deficiency / period_seconds;
3007
3008   if (backlog_spontrescan_periods >= 0 &&
3009       until_backlog_nextscan > backlog_spontrescan_periods)
3010     until_backlog_nextscan= backlog_spontrescan_periods;
3011
3012   debug("backlog scan: young age=%f deficiency=%ld nextscan=%d oldest=%s",
3013         age, age_deficiency, until_backlog_nextscan, oldest_path);
3014
3015  xfree:
3016   globfree(&gl);
3017   return;
3018 }
3019
3020 /*---------- shutdown and signal handling ----------*/
3021
3022 static void preterminate(void) {
3023   if (in_child) return;
3024   notice_processed(main_input_file,0,"feedfile","");
3025   notice_processed(flushing_input_file,0,"flushing","");
3026   if (backlog_input_file)
3027     notice_processed(backlog_input_file,0, "backlog file ",
3028                      backlog_input_file->path);
3029 }
3030
3031 static int signal_self_pipe[2];
3032 static sig_atomic_t terminate_sig_flag;
3033
3034 static void raise_default(int signo) {
3035   xsigsetdefault(signo);
3036   raise(signo);
3037   abort();
3038 }
3039
3040 static void *sigarrived_event(oop_source *lp, int fd, oop_event e, void *u) {
3041   assert(fd=signal_self_pipe[0]);
3042   char buf[PIPE_BUF];
3043   int r= read(signal_self_pipe[0], buf, sizeof(buf));
3044   if (r<0 && !isewouldblock(errno)) sysdie("failed to read signal self pipe");
3045   if (r==0) die("eof on signal self pipe");
3046   if (terminate_sig_flag) {
3047     preterminate();
3048     notice("terminating (%s)", strsignal(terminate_sig_flag));
3049     raise_default(terminate_sig_flag);
3050   }
3051   return OOP_CONTINUE;
3052 }
3053
3054 static void sigarrived_handler(int signum) {
3055   static char x;
3056   switch (signum) {
3057   case SIGTERM:
3058   case SIGINT:
3059     if (!terminate_sig_flag) terminate_sig_flag= signum;
3060     break;
3061   default:
3062     abort();
3063   }
3064   write(signal_self_pipe[1],&x,1);
3065 }
3066
3067 static void init_signals(void) {
3068   if (signal(SIGPIPE, SIG_IGN) == SIG_ERR)
3069     sysdie("could not ignore SIGPIPE");
3070
3071   if (pipe(signal_self_pipe)) sysfatal("create self-pipe for signals");
3072
3073   xsetnonblock(signal_self_pipe[0],1);
3074   xsetnonblock(signal_self_pipe[1],1);
3075
3076   struct sigaction sa;
3077   memset(&sa,0,sizeof(sa));
3078   sa.sa_handler= sigarrived_handler;
3079   sa.sa_flags= SA_RESTART;
3080   xsigaction(SIGTERM,&sa);
3081   xsigaction(SIGINT,&sa);
3082
3083   on_fd_read_except(signal_self_pipe[0], sigarrived_event);
3084 }
3085
3086 /*========== flushing the feed ==========*/
3087
3088 static pid_t inndcomm_child;
3089 static int inndcomm_sentinel_fd;
3090
3091 static void *inndcomm_event(oop_source *lp, int fd, oop_event e, void *u) {
3092   assert(inndcomm_child);
3093   assert(fd == inndcomm_sentinel_fd);
3094   int status= xwaitpid(&inndcomm_child, "inndcomm");
3095   inndcomm_child= 0;
3096   
3097   cancel_fd_read_except(fd);
3098   xclose_perhaps(&fd, "inndcomm sentinel pipe",0);
3099   inndcomm_sentinel_fd= 0;
3100
3101   assert(!flushing_input_file);
3102
3103   if (WIFEXITED(status)) {
3104     switch (WEXITSTATUS(status)) {
3105
3106     case INNDCOMMCHILD_ESTATUS_FAIL:
3107       goto failed;
3108
3109     case INNDCOMMCHILD_ESTATUS_NONESUCH:
3110       notice("feed has been dropped by innd, finishing up");
3111       flushing_input_file= main_input_file;
3112       tailing_make_readable(flushing_input_file);
3113         /* we probably previously returned EAGAIN from our fake read method
3114          * when in fact we were at EOF, so signal another readable event
3115          * so we actually see the EOF */
3116
3117       main_input_file= 0;
3118
3119       if (flushing_input_file) {
3120         SMS(DROPPING, max_separated_periods,
3121             "feed dropped by innd, but must finish last flush");
3122       } else {
3123         close_defer();
3124         SMS(DROPPED, 0, "feed dropped by innd");
3125         search_backlog_file();
3126       }
3127       return OOP_CONTINUE;
3128
3129     case 0:
3130       /* as above */
3131       flushing_input_file= main_input_file;
3132       tailing_make_readable(flushing_input_file);
3133
3134       main_input_file= open_input_file(feedfile);
3135       if (!main_input_file)
3136         die("flush succeeded but feedfile %s does not exist!"
3137             " (this probably means feedfile does not correspond"
3138             " to site %s in newsfeeds)", feedfile, sitename);
3139
3140       if (flushing_input_file) {
3141         SMS(SEPARATED, max_separated_periods, "flush complete");
3142       } else {
3143         close_defer();
3144         SMS(NORMAL, spontaneous_flush_periods, "recovery flush complete");
3145       }
3146       return OOP_CONTINUE;
3147
3148     default:
3149       goto unexpected_exitstatus;
3150
3151     }
3152   } else if (WIFSIGNALED(status) && WTERMSIG(status) == SIGALRM) {
3153     warn("flush timed out trying to talk to innd");
3154     goto failed;
3155   } else {
3156   unexpected_exitstatus:
3157     report_child_status("inndcomm child", status);
3158   }
3159
3160  failed:
3161   SMS(FLUSHFAILED, flushfail_retry_periods, "flush failed, will retry");
3162   return OOP_CONTINUE;
3163 }
3164
3165 static void inndcommfail(const char *what) {
3166   syswarn("error communicating with innd: %s failed: %s", what, ICCfailure);
3167   exit(INNDCOMMCHILD_ESTATUS_FAIL);
3168 }
3169
3170 void spawn_inndcomm_flush(const char *why) { /* Moved => Flushing */
3171   int pipefds[2];
3172
3173   notice("flushing %s",why);
3174
3175   assert(sms==sm_NORMAL || sms==sm_FLUSHFAILED);
3176   assert(!inndcomm_child);
3177   assert(!inndcomm_sentinel_fd);
3178
3179   if (pipe(pipefds)) sysfatal("create pipe for inndcomm child sentinel");
3180
3181   inndcomm_child= xfork("inndcomm child");
3182
3183   if (!inndcomm_child) {
3184     const char *flushargv[2]= { sitename, 0 };
3185     char *reply;
3186     int r;
3187
3188     xclose(pipefds[0], "(in child) inndcomm sentinel parent's end",0);
3189     /* parent spots the autoclose of pipefds[1] when we die or exit */
3190
3191     if (simulate_flush>=0) {
3192       warn("SIMULATING flush child status %d", simulate_flush);
3193       if (simulate_flush>128) raise(simulate_flush-128);
3194       else exit(simulate_flush);
3195     }
3196
3197     alarm(inndcomm_flush_timeout);
3198     r= ICCopen();                         if (r)   inndcommfail("connect");
3199     r= ICCcommand('f',flushargv,&reply);  if (r<0) inndcommfail("transmit");
3200     if (!r) exit(0); /* yay! */
3201
3202     if (!strcmp(reply, "1 No such site")) exit(INNDCOMMCHILD_ESTATUS_NONESUCH);
3203     syswarn("innd ctlinnd flush failed: innd said %s", reply);
3204     exit(INNDCOMMCHILD_ESTATUS_FAIL);
3205   }
3206
3207   simulate_flush= -1;
3208
3209   xclose(pipefds[1], "inndcomm sentinel child's end",0);
3210   inndcomm_sentinel_fd= pipefds[0];
3211   assert(inndcomm_sentinel_fd);
3212   on_fd_read_except(inndcomm_sentinel_fd, inndcomm_event);
3213
3214   SMS(FLUSHING, 0, why);
3215 }
3216
3217 /*========== main program ==========*/
3218
3219 static void postfork_inputfile(InputFile *ipf) {
3220   if (!ipf) return;
3221   xclose(ipf->fd, "(in child) input file ", ipf->path);
3222 }
3223
3224 static void postfork_stdio(FILE *f, const char *what, const char *what2) {
3225   /* we have no stdio streams that are buffered long-term */
3226   if (!f) return;
3227   if (fclose(f)) sysdie("(in child) close %s%s", what, what2?what2:0);
3228 }
3229
3230 static void postfork(void) {
3231   in_child= 1;
3232
3233   xsigsetdefault(SIGTERM);
3234   xsigsetdefault(SIGINT);
3235   xsigsetdefault(SIGPIPE);
3236   if (terminate_sig_flag) raise(terminate_sig_flag);
3237
3238   postfork_inputfile(main_input_file);
3239   postfork_inputfile(flushing_input_file);
3240
3241   Conn *conn;
3242   FOR_CONN(conn)
3243     conn_closefd(conn,"(in child) ");
3244
3245   postfork_stdio(defer, "defer file ", path_defer);
3246 }
3247
3248 typedef struct Every Every;
3249 struct Every {
3250   struct timeval interval;
3251   int fixed_rate;
3252   void (*f)(void);
3253 };
3254
3255 static void every_schedule(Every *e, struct timeval base);
3256
3257 static void *every_happens(oop_source *lp, struct timeval base, void *e_v) {
3258   Every *e= e_v;
3259   e->f();
3260   if (!e->fixed_rate) xgettimeofday(&base);
3261   every_schedule(e, base);
3262   return OOP_CONTINUE;
3263 }
3264
3265 static void every_schedule(Every *e, struct timeval base) {
3266   struct timeval when;
3267   timeradd(&base, &e->interval, &when);
3268   loop->on_time(loop, when, every_happens, e);
3269 }
3270
3271 static void every(int interval, int fixed_rate, void (*f)(void)) {
3272   NEW_DECL(Every *,e);
3273   e->interval.tv_sec= interval;
3274   e->interval.tv_usec= 0;
3275   e->fixed_rate= fixed_rate;
3276   e->f= f;
3277   struct timeval now;
3278   xgettimeofday(&now);
3279   every_schedule(e, now);
3280 }
3281
3282 static void filepoll(void) {
3283   tailing_make_readable(main_input_file);
3284   tailing_make_readable(flushing_input_file);
3285 }
3286
3287 static char *debug_report_ipf(InputFile *ipf) {
3288   if (!ipf) return xasprintf("none");
3289
3290   const char *slash= strrchr(ipf->path,'/');
3291   const char *path= slash ? slash+1 : ipf->path;
3292
3293   return xasprintf("%p/%s:queue=%d,ip=%ld,autodef=%ld,off=%ld,fd=%d%s%s%s",
3294                    ipf, path,
3295                    ipf->queue.count, ipf->inprogress, ipf->autodefer,
3296                    (long)ipf->offset, ipf->fd,
3297                    ipf->rd ? "" : ",!rd",
3298                    ipf->skippinglong ? "*skiplong" : "",
3299                    ipf->rd && ipf->paused ? "*paused" : "");
3300 }
3301
3302 static void period(void) {
3303   char *dipf_main=     debug_report_ipf(main_input_file);
3304   char *dipf_flushing= debug_report_ipf(flushing_input_file);
3305   char *dipf_backlog=  debug_report_ipf(backlog_input_file);
3306
3307   debug("PERIOD"
3308         " sms=%s[%d] conns=%d until_connect=%d"
3309         " input_files main:%s flushing:%s backlog:%s[%d]"
3310         " children connecting=%ld inndcomm=%ld"
3311         ,
3312         sms_names[sms], until_flush, conns.count, until_connect,
3313         dipf_main, dipf_flushing, dipf_backlog, until_backlog_nextscan,
3314         (long)connecting_child, (long)inndcomm_child
3315         );
3316
3317   free(dipf_main);
3318   free(dipf_flushing);
3319   free(dipf_backlog);
3320
3321   if (until_connect) until_connect--;
3322
3323   inputfile_queue_check_expired(backlog_input_file);
3324   poll_backlog_file();
3325   if (!backlog_input_file) close_defer(); /* want to start on a new backlog */
3326   statemc_period_poll();
3327   check_assign_articles();
3328   check_idle_conns();
3329 }
3330
3331
3332 /*========== dumping state ==========*/
3333
3334 static void dump_article_list(FILE *f, const CliCommand *c,
3335                               const ArticleList *al) {
3336   fprintf(f, " count=%d\n", al->count);
3337   if (!c->xval) return;
3338   
3339   int i; Article *art;
3340   for (i=0, art=LIST_HEAD(*al); art; i++, art=LIST_NEXT(art)) {
3341     fprintf(f," #%05d %-11s", i, artstate_names[art->state]);
3342     DUMPV("%p", art->,ipf);
3343     DUMPV("%d", art->,missing);
3344     DUMPV("%lu", (unsigned long)art->,offset);
3345     DUMPV("%d", art->,blanklen);
3346     DUMPV("%d", art->,midlen);
3347     fprintf(f, " %s %s\n", TokenToText(art->token), art->messageid);
3348   }
3349 }
3350   
3351 static void dump_input_file(FILE *f, const CliCommand *c,
3352                             InputFile *ipf, const char *wh) {
3353   char *dipf= debug_report_ipf(ipf);
3354   fprintf(f,"input %s %s", wh, dipf);
3355   free(dipf);
3356   
3357   if (ipf) {
3358     DUMPV("%d", ipf->,readcount_ok);
3359     DUMPV("%d", ipf->,readcount_blank);
3360     DUMPV("%d", ipf->,readcount_err);
3361     DUMPV("%d", ipf->,count_nooffer_missing);
3362   }
3363   fprintf(f,"\n");
3364   if (ipf) {
3365     ArtState state; const char *const *statename; 
3366     for (state=0, statename=artstate_names; *statename; state++,statename++) {
3367 #define RC_DUMP_FMT(x) " " #x "=%d"
3368 #define RC_DUMP_VAL(x) ,ipf->counts[state][RC_##x]
3369       fprintf(f,"input %s counts %-11s"
3370               RESULT_COUNTS(RC_DUMP_FMT,RC_DUMP_FMT) "\n",
3371               wh, *statename
3372               RESULT_COUNTS(RC_DUMP_VAL,RC_DUMP_VAL));
3373     }
3374     fprintf(f,"input %s queue", wh);
3375     dump_article_list(f,c,&ipf->queue);
3376   }
3377 }
3378
3379 CCMD(dump) {
3380   int i;
3381   fprintf(cc->out, "dumping state to %s\n", path_dump);
3382   FILE *f= fopen(path_dump, "w");
3383   if (!f) { fprintf(cc->out, "failed: open: %s\n", strerror(errno)); return; }
3384
3385   fprintf(f,"general");
3386   DUMPV("%s", sms_names,[sms]);
3387   DUMPV("%d", ,until_flush);
3388   DUMPV("%ld", (long),self_pid);
3389   DUMPV("%p", , defer);
3390   DUMPV("%d", , until_connect);
3391   DUMPV("%d", , until_backlog_nextscan);
3392   DUMPV("%d", , simulate_flush);
3393   fprintf(f,"\nnocheck");
3394   DUMPV("%#.10f", , accept_proportion);
3395   DUMPV("%d", , nocheck);
3396   DUMPV("%d", , nocheck_reported);
3397   fprintf(f,"\n");
3398
3399   fprintf(f,"special");
3400   DUMPV("%ld", (long),connecting_child);
3401   DUMPV("%d", , connecting_fdpass_sock);
3402   DUMPV("%d", , cli_master);
3403   fprintf(f,"\n");
3404
3405   fprintf(f,"filemon ");
3406   filemon_method_dump_info(f);
3407
3408   dump_input_file(f,c, main_input_file,     "main"    );
3409   dump_input_file(f,c, flushing_input_file, "flushing");
3410   dump_input_file(f,c, backlog_input_file,  "backlog" );
3411
3412   fprintf(f,"conns count=%d\n", conns.count);
3413
3414   Conn *conn;
3415   FOR_CONN(conn) {
3416
3417     fprintf(f,"C%d",conn->fd);
3418     DUMPV("%p",conn->,rd);             DUMPV("%d",conn->,max_queue);
3419     DUMPV("%d",conn->,stream);         DUMPV("%d",conn->,quitting);
3420     DUMPV("%d",conn->,since_activity);
3421     fprintf(f,"\n");
3422
3423     fprintf(f,"C%d waiting", conn->fd); dump_article_list(f,c,&conn->waiting);
3424     fprintf(f,"C%d priority",conn->fd); dump_article_list(f,c,&conn->priority);
3425     fprintf(f,"C%d sent",    conn->fd); dump_article_list(f,c,&conn->sent);
3426
3427     fprintf(f,"C%d xmit xmitu=%d\n", conn->fd, conn->xmitu);
3428     for (i=0; i<conn->xmitu; i++) {
3429       const struct iovec *iv= &conn->xmit[i];
3430       const XmitDetails *xd= &conn->xmitd[i];
3431       char *dinfo;
3432       switch (xd->kind) {
3433       case xk_Const:    dinfo= xasprintf("Const");                 break;
3434       case xk_Artdata:  dinfo= xasprintf("A%p", xd->info.sm_art);  break;
3435       default:
3436         abort();
3437       }
3438       fprintf(f," #%03d %-11s l=%d %s\n", i, dinfo, iv->iov_len,
3439               sanitise(iv->iov_base, iv->iov_len));
3440       free(dinfo);
3441     }
3442   }
3443
3444   fprintf(f,"paths");
3445   DUMPV("%s", , feedfile);
3446   DUMPV("%s", , path_cli);
3447   DUMPV("%s", , path_lock);
3448   DUMPV("%s", , path_flushing);
3449   DUMPV("%s", , path_defer);
3450   DUMPV("%s", , path_dump);
3451   DUMPV("%s", , globpat_backlog);
3452   fprintf(f,"\n");
3453
3454   if (!!ferror(f) + !!fclose(f)) {
3455     fprintf(cc->out, "failed: write: %s\n", strerror(errno));
3456     return;
3457   }
3458 }
3459
3460 /*========== option parsing ==========*/
3461
3462 static void vbadusage(const char *fmt, va_list al) NORET_PRINTF(1,0);
3463 static void vbadusage(const char *fmt, va_list al) {
3464   char *m= xvasprintf(fmt,al);
3465   fprintf(stderr, "bad usage: %s\n"
3466           "say --help for help, or read the manpage\n",
3467           m);
3468   if (become_daemon)
3469     syslog(LOG_CRIT,"innduct: invoked with bad usage: %s",m);
3470   exit(8);
3471 }
3472
3473 /*---------- generic option parser ----------*/
3474
3475 static void badusage(const char *fmt, ...) NORET_PRINTF(1,2);
3476 static void badusage(const char *fmt, ...) {
3477   va_list al;
3478   va_start(al,fmt);
3479   vbadusage(fmt,al);
3480 }
3481
3482 enum OptFlags {
3483   of_seconds= 001000u,
3484   of_boolean= 002000u,
3485 };
3486
3487 typedef struct Option Option;
3488 typedef void OptionParser(const Option*, const char *val);
3489
3490 struct Option {
3491   int shrt;
3492   const char *lng, *formarg;
3493   void *store;
3494   OptionParser *fn;
3495   int intval;
3496 };
3497
3498 static void parse_options(const Option *options, char ***argvp) {
3499   /* on return *argvp is first non-option arg; argc is not updated */
3500
3501   for (;;) {
3502     const char *arg= *++(*argvp);
3503     if (!arg) break;
3504     if (*arg != '-') break;
3505     if (!strcmp(arg,"--")) { arg= *++(*argvp); break; }
3506     int a;
3507     while ((a= *++arg)) {
3508       const Option *o;
3509       if (a=='-') {
3510         arg++;
3511         char *equals= strchr(arg,'=');
3512         int len= equals ? (equals - arg) : strlen(arg);
3513         for (o=options; o->shrt || o->lng; o++)
3514           if (strlen(o->lng) == len && !memcmp(o->lng,arg,len))
3515             goto found_long;
3516         badusage("unknown long option --%s",arg);
3517       found_long:
3518         if (!o->formarg) {
3519           if (equals) badusage("option --%s does not take a value",o->lng);
3520           arg= 0;
3521         } else if (equals) {
3522           arg= equals+1;
3523         } else {
3524           arg= *++(*argvp);
3525           if (!arg) badusage("option --%s needs a value for %s",
3526                              o->lng, o->formarg);
3527         }
3528         o->fn(o, arg);
3529         break; /* eaten the whole argument now */
3530       }
3531       for (o=options; o->shrt || o->lng; o++)
3532         if (a == o->shrt)
3533           goto found_short;
3534       badusage("unknown short option -%c",a);
3535     found_short:
3536       if (!o->formarg) {
3537         o->fn(o,0);
3538       } else {
3539         if (!*++arg) {
3540           arg= *++(*argvp);
3541           if (!arg) badusage("option -%c needs a value for %s",
3542                              o->shrt, o->formarg);
3543         }
3544         o->fn(o,arg);
3545         break; /* eaten the whole argument now */
3546       }
3547     }
3548   }
3549 }
3550
3551 #define DELIMPERHAPS(delim,str)  (str) ? (delim) : "", (str) ? (str) : ""
3552
3553 static void print_options(const Option *options, FILE *f) {
3554   const Option *o;
3555   for (o=options; o->shrt || o->lng; o++) {
3556     char shrt[2] = { o->shrt, 0 };
3557     char *optspec= xasprintf("%s%s%s%s%s",
3558                              o->shrt ? "-" : "", shrt,
3559                              o->shrt && o->lng ? "|" : "",
3560                              DELIMPERHAPS("--", o->lng));
3561     fprintf(f, "  %s%s%s\n", optspec, DELIMPERHAPS(" ", o->formarg));
3562     free(optspec);
3563   }
3564 }
3565
3566 /*---------- specific option types ----------*/
3567
3568 static void op_integer(const Option *o, const char *val) {
3569   char *ep;
3570   errno= 0;
3571   unsigned long ul= strtoul(val,&ep,10);
3572   if (*ep || ep==val || errno || ul>INT_MAX)
3573     badusage("bad integer value for %s",o->lng);
3574   int *store= o->store;
3575   *store= ul;
3576 }
3577
3578 static void op_double(const Option *o, const char *val) {
3579   int *store= o->store;
3580   char *ep;
3581   errno= 0;
3582   *store= strtod(val, &ep);
3583   if (*ep || ep==val || errno)
3584     badusage("bad floating point value for %s",o->lng);
3585 }
3586
3587 static void op_string(const Option *o, const char *val) {
3588   const char **store= o->store;
3589   *store= val;
3590 }
3591
3592 static void op_seconds(const Option *o, const char *val) {
3593   int *store= o->store;
3594   char *ep;
3595   int unit;
3596
3597   double v= strtod(val,&ep);
3598   if (ep==val) badusage("bad time/duration value for %s",o->lng);
3599
3600   if (!*ep || !strcmp(ep,"s") || !strcmp(ep,"sec")) unit= 1;
3601   else if (!strcmp(ep,"m") || !strcmp(ep,"min"))    unit= 60;
3602   else if (!strcmp(ep,"h") || !strcmp(ep,"hour"))   unit= 3600;
3603   else if (!strcmp(ep,"d") || !strcmp(ep,"day"))    unit= 86400;
3604   else if (!strcmp(ep,"das")) unit= 10;
3605   else if (!strcmp(ep,"hs"))  unit= 100;
3606   else if (!strcmp(ep,"ks"))  unit= 1000;
3607   else if (!strcmp(ep,"Ms"))  unit= 1000000;
3608   else badusage("bad units %s for time/duration value for %s",ep,o->lng);
3609
3610   v *= unit;
3611   v= ceil(v);
3612   if (v > INT_MAX) badusage("time/duration value for %s out of range",o->lng);
3613   *store= v;
3614 }
3615
3616 static void op_setint(const Option *o, const char *val) {
3617   int *store= o->store;
3618   *store= o->intval;
3619 }
3620
3621 /*---------- specific options ----------*/
3622
3623 static void help(const Option *o, const char *val);
3624
3625 static const Option innduct_options[]= {
3626 {'f',"feedfile",         "F",     &feedfile,                 op_string      },
3627 {'q',"quiet-multiple",   0,       &quiet_multiple,           op_setint, 1   },
3628 {0,"no-daemon",          0,       &become_daemon,            op_setint, 0   },
3629 {0,"no-streaming",       0,       &try_stream,               op_setint, 0   },
3630 {0,"no-filemon",         0,       &try_filemon,              op_setint, 0   },
3631 {'C',"inndconf",         "F",     &inndconffile,             op_string      },
3632 {'P',"port",             "PORT",  &port,                     op_integer     },
3633 {0,"chdir",              "DIR",   &path_run,                 op_string      },
3634 {0,"cli",            "DIR/|PATH", &path_cli,                 op_string      },
3635 {0,"help",               0,       0,                         help           },
3636
3637 {0,"max-connections",    "N",     &max_connections,          op_integer     },
3638 {0,"max-queue-per-conn", "N",     &max_queue_per_conn,       op_integer     },
3639 {0,"max-queue-per-file", "N",     &max_queue_per_ipf,        op_integer     },
3640 {0,"feedfile-flush-size","BYTES", &target_max_feedfile_size, op_integer     },
3641 {0,"period-interval",    "TIME",  &period_seconds,           op_seconds     },
3642
3643 {0,"connection-timeout",   "TIME",  &connection_setup_timeout, op_seconds   },
3644 {0,"stuck-flush-timeout",  "TIME",  &inndcomm_flush_timeout,   op_seconds   },
3645 {0,"feedfile-poll",        "TIME",  &filepoll_seconds,         op_seconds   },
3646
3647 {0,"no-check-proportion",   "PERCENT",   &nocheck_thresh,       op_double   },
3648 {0,"no-check-response-time","ARTICLES",  &nocheck_decay,        op_double   },
3649
3650 {0,"reconnect-interval",     "PERIOD", &reconnect_delay_periods,  op_seconds },
3651 {0,"flush-retry-interval",   "PERIOD", &flushfail_retry_periods,  op_seconds },
3652 {0,"earliest-deferred-retry","PERIOD", &backlog_retry_minperiods, op_seconds },
3653 {0,"backlog-rescan-interval","PERIOD",&backlog_spontrescan_periods,op_seconds},
3654 {0,"max-flush-interval",     "PERIOD", &spontaneous_flush_periods,op_seconds },
3655 {0,"flush-finish-timeout",   "PERIOD", &max_separated_periods,    op_seconds },
3656 {0,"idle-timeout",           "PERIOD", &need_activity_periods,    op_seconds },
3657 {0,"low-volume-thresh",      "PERIOD", &recentact_thresh,         op_integer },
3658 {0,"low-volume-window",      "PERIOD", &recentact_periods,        op_seconds },
3659
3660 {0,"max-bad-input-data-ratio","PERCENT", &max_bad_data_ratio,   op_double    },
3661 {0,"max-bad-input-data-init", "PERCENT", &max_bad_data_initial, op_integer   },
3662
3663 {0,0}
3664 };
3665
3666 static void printusage(FILE *f) {
3667   fputs("usage: innduct [options] site [fqdn]\n"
3668         "available options are:\n", f);
3669   print_options(innduct_options, f);
3670 }
3671
3672 static void help(const Option *o, const char *val) {
3673   printusage(stdout);
3674   if (ferror(stdout) || fflush(stdout)) {
3675     perror("innduct: writing help");
3676     exit(12);
3677   }
3678   exit(0);
3679 }
3680
3681 static void convert_to_periods_rndup(int *store) {
3682   *store += period_seconds-1;
3683   *store /= period_seconds;
3684 }
3685
3686 static int path_ends_slash(const char *specified) {
3687   int l= strlen(specified);
3688   assert(l);
3689   return specified[l-1] == '/';
3690 }
3691
3692 int main(int argc, char **argv) {
3693   if (!argv[1]) {
3694     printusage(stderr);
3695     exit(8);
3696   }
3697
3698   parse_options(innduct_options, &argv);
3699
3700   /* arguments */
3701
3702   sitename= *argv++;
3703   if (!sitename) badusage("need site name argument");
3704
3705   if (*argv) remote_host= *argv++;
3706   else remote_host= sitename;
3707   
3708   if (*argv) badusage("too many non-option arguments");
3709
3710   /* defaults */
3711
3712   int r= innconf_read(inndconffile);
3713   if (!r) badusage("could not read inn.conf (more info on stderr)");
3714
3715   if (!remote_host) remote_host= sitename;
3716
3717   if (nocheck_thresh < 0 || nocheck_thresh > 100)
3718     badusage("nocheck threshold percentage must be between 0..100");
3719   nocheck_thresh *= 0.01;
3720
3721   if (nocheck_decay < 0.1)
3722     badusage("nocheck decay articles must be at least 0.1");
3723   nocheck_decay= pow(0.5, 1.0/nocheck_decay);
3724
3725   convert_to_periods_rndup(&reconnect_delay_periods);
3726   convert_to_periods_rndup(&flushfail_retry_periods);
3727   convert_to_periods_rndup(&backlog_retry_minperiods);
3728   convert_to_periods_rndup(&backlog_spontrescan_periods);
3729   convert_to_periods_rndup(&spontaneous_flush_periods);
3730   convert_to_periods_rndup(&max_separated_periods);
3731   convert_to_periods_rndup(&need_activity_periods);
3732   convert_to_periods_rndup(&recentact_periods);
3733
3734   if (max_bad_data_ratio < 0 || max_bad_data_ratio > 100)
3735     badusage("bad input data ratio must be between 0..100");
3736   max_bad_data_ratio *= 0.01;
3737
3738   if (!path_run)
3739     path_run= innconf->pathrun;
3740
3741   if (!feedfile) feedfile= sitename;
3742   if (!feedfile[0]) badusage("feed filename, if specified, must be nonempty");
3743   if (path_ends_slash(feedfile))
3744     feedfile= xasprintf("%s%s", feedfile, sitename);
3745   if (feedfile[0] != '/')
3746     feedfile= xasprintf("%s/%s", innconf->pathoutgoing, feedfile);
3747
3748   if (!path_cli) {
3749     path_cli_dir= "innduct";
3750   } else if (!path_cli[0] || !strcmp(path_cli,"none")) {
3751     path_cli= 0; /* ok, don't then */
3752   } else if (path_ends_slash(path_cli)) {
3753     path_cli_dir= xasprintf("%.*s", strlen(path_cli)-1, path_cli);
3754   }
3755   if (path_cli_dir)
3756     path_cli= xasprintf("%s/%s", path_cli_dir, sitename);
3757
3758   if (max_queue_per_ipf<0)
3759     max_queue_per_ipf= max_queue_per_conn * 2;
3760
3761   const char *feedfile_forbidden= "?*[~#";
3762   int c;
3763   while ((c= *feedfile_forbidden++))
3764     if (strchr(feedfile, c))
3765       badusage("feed filename may not contain metacharacter %c",c);
3766
3767   int i;
3768   recentact_perperiod= xcalloc(sizeof(*recentact_perperiod),recentact_periods);
3769   for (i=0; i<recentact_periods; i++) {
3770     recentact_perperiod[i]= recentact_thresh;
3771     recentact_total += recentact_thresh;
3772   }
3773
3774   /* set things up */
3775
3776   path_lock=        xasprintf("%s_lock",      feedfile);
3777   path_flushing=    xasprintf("%s_flushing",  feedfile);
3778   path_defer=       xasprintf("%s_defer",     feedfile);
3779   path_dump=        xasprintf("%s_dump",      feedfile);
3780   globpat_backlog=  xasprintf("%s_backlog*",  feedfile);
3781
3782   oop_source_sys *sysloop= oop_sys_new();
3783   if (!sysloop) sysdie("could not create liboop event loop");
3784   loop= (oop_source*)sysloop;
3785
3786   LIST_INIT(conns);
3787
3788   if (become_daemon) {
3789     int i;
3790     for (i=3; i<255; i++)
3791       /* do this now before we open syslog, etc. */
3792       close(i);
3793     openlog("innduct",LOG_NDELAY|LOG_PID,LOG_NEWS);
3794
3795     int null= open("/dev/null",O_RDWR);
3796     if (null<0) sysfatal("failed to open /dev/null");
3797     dup2(null,0);
3798     dup2(null,1);
3799     dup2(null,2);
3800     xclose(null, "/dev/null original fd",0);
3801
3802     pid_t child1= xfork("daemonise first fork");
3803     if (child1) _exit(0);
3804
3805     pid_t sid= setsid();
3806     if (sid == -1) sysfatal("setsid failed");
3807
3808     pid_t child2= xfork("daemonise second fork");
3809     if (child2) _exit(0);
3810   }
3811
3812   self_pid= getpid();
3813   if (self_pid==-1) sysdie("getpid");
3814
3815   r= chdir(path_run);
3816   if (r) sysdie("could not chdir to pathrun %s", path_run);
3817
3818   statemc_lock();
3819
3820   init_signals();
3821
3822   notice("starting");
3823
3824   int val= 1;
3825   r= SMsetup(SM_PREOPEN, &val); if (!r) warn("SMsetup SM_PREOPEN failed");
3826   r= SMinit(); if (!r) die("storage manager initialisation (SMinit) failed");
3827
3828   if (!become_daemon)
3829     cli_stdio();
3830
3831   cli_init();
3832
3833   int filemon_ok= 0;
3834   if (!try_filemon) {
3835     notice("filemon: suppressed by command line option, polling");
3836   } else {
3837     filemon_ok= filemon_method_init();
3838     if (!filemon_ok)
3839       warn("filemon: no file monitoring available, polling");
3840   }
3841   if (!filemon_ok)
3842     every(filepoll_seconds,0,filepoll);
3843
3844   every(period_seconds,1,period);
3845
3846   statemc_init();
3847
3848   /* let's go */
3849
3850   void *run= oop_sys_run(sysloop);
3851   assert(run == OOP_ERROR);
3852   sysdie("event loop failed");
3853 }