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