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