Daily Usenet report: Sep 18 03:30:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	16087	34.5%	2.1 MB	36.6%
inn	15059	32.3%	1.9 MB	34.3%
nnrpd	11368	24.4%	1.2 MB	21.1%
innfeed	3358	7.2%	395.9 KB	6.8%
authmysql	538	1.2%	49.7 KB	0.9%
batcher	134	0.3%	10.5 KB	0.2%
send-uucp	96	0.2%	7.9 KB	0.1%
TOTAL: 7	46640	100.0%	5.6 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	15488	45.1%
Do not exist	15037	43.8%
Positive hits	3838	11.2%
Cache misses	1	0.0%
TOTAL: 4	34364	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.000	0.0%	3	0.000	0.000	0.000
article cleanup	00:00:00.062	0.0%	15042	0.000	0.004	0.200
article logging	00:00:00.102	0.0%	15058	0.000	0.007	0.200
article parse	00:00:00.425	0.0%	58480	0.000	0.007	0.143
article write	00:00:00.207	0.0%	1776	0.000	0.117	1.000
artlog/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.043	0.0%	66407	0.000	0.001	0.034
hisgrep/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.150	0.0%	34371	0.000	0.004	0.059
history sync	00:00:00.131	0.0%	551	0.000	0.238	2.000
history write	00:00:00.780	0.0%	15042	0.000	0.052	0.444
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:02:15.430	100.0%	78955	371.246	1096.009	18788.688
nntp read	00:00:00.386	0.0%	76426	0.000	0.005	0.061
overview write	00:00:00.006	0.0%	1776	0.000	0.003	0.200
perl filter	00:00:04.838	0.0%	15042	0.000	0.322	1.333
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.030	0.0%	3379	0.000	0.009	0.250
TOTAL: 24:02:25.946	24:02:22.590	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.002	0.0%	1370	0.000	0.001	0.333
article prepare	00:00:00.001	0.0%	5912	0.000	0.000	0.011
article read	00:00:00.076	0.0%	955	0.000	0.080	1.000
backlog stats	00:00:00.017	0.0%	27716	0.000	0.001	0.023
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.047	0.0%	12126	0.000	0.004	1.000
data write	00:00:00.097	0.0%	10800	0.000	0.009	0.067
idle	24:02:11.780	100.0%	27716	710.738	3122.088	13649.091
status file	00:00:00.266	0.0%	1003	0.000	0.265	1.000
TOTAL: 24:02:14.115	24:02:12.286	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.212	0.0%	8886	0.014	0.024	0.035
idle	27:04:50.322	99.7%	30899	8.500	3155.129	150020.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:03:14.945	0.2%	1690919	0.000	0.115	1.000
TOTAL: 27:08:58.482	27:08:05.479	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	96
flushlogs	2
go	2
logmode	2
mode	5
name	2
pause	2
paused	2
renumber	1
reserve	2
TOTAL: 10	116

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feeder1-2.proxad.net	288	14271	950	790	12531	6%	23:51:56
2	feed-out.gegeweb.org	8	1063	470	574	19	44%	23:33:31
3	news.fdn.fr	4	1473	139	763	571	9%	18:38:41
4	news.trigofacile.com	32	276	130	145	1	47%	15:47:55
5	pasdenom.info	15	766	50	674	42	6%	23:15:27
6	news.glou.org	23	558	1	557	0	0%	22:04:14
7	localhost	97	0	0	0	0	0%	00:00:00
8	feed.agneau.org	1	0	0	0	0	0%	00:10:00
TOTAL: 8		468	18407	1740	3503	13164	9%	127:21:44

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder1-2.proxad.net	3.1 MB	121.1 MB	124.2 MB	2%	9.4 KB
2	feed-out.gegeweb.org	1.5 MB	50.0 KB	1.6 MB	96%	3.3 KB
3	news.fdn.fr	424.1 KB	3.1 MB	3.6 MB	11%	5.1 KB
4	news.trigofacile.com	283.0 KB	2.7 KB	285.7 KB	99%	2.2 KB
5	pasdenom.info	148.0 KB	119.4 KB	267.4 KB	55%	2.9 KB
6	news.glou.org	2.2 KB	0.0 KB	2.2 KB	100%	2.2 KB
7	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
8	feed.agneau.org	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		5.5 MB	124.4 MB	129.9 MB	4%	8.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 18 03:30:00 - 03:59:59	37	2.1%	0.02	139.1 KB	2.4%	0.08
Sep 18 04:00:00 - 04:59:59	74	4.2%	0.02	220.8 KB	3.9%	0.06
Sep 18 05:00:00 - 05:59:59	37	2.1%	0.01	110.0 KB	1.9%	0.03
Sep 18 06:00:00 - 06:59:59	35	2.0%	0.01	84.8 KB	1.5%	0.02
Sep 18 07:00:00 - 07:59:59	34	1.9%	0.01	103.2 KB	1.8%	0.03
Sep 18 08:00:00 - 08:59:59	54	3.0%	0.01	145.2 KB	2.5%	0.04
Sep 18 09:00:00 - 09:59:59	69	3.9%	0.02	196.4 KB	3.4%	0.05
Sep 18 10:00:00 - 10:59:59	88	5.0%	0.02	228.5 KB	4.0%	0.06
Sep 18 11:00:00 - 11:59:59	195	11.0%	0.05	1.1 MB	19.6%	0.31
Sep 18 12:00:00 - 12:59:59	61	3.4%	0.02	142.2 KB	2.5%	0.04
Sep 18 13:00:00 - 13:59:59	52	2.9%	0.01	142.5 KB	2.5%	0.04
Sep 18 14:00:00 - 14:59:59	54	3.0%	0.01	140.5 KB	2.5%	0.04
Sep 18 15:00:00 - 15:59:59	130	7.3%	0.04	408.1 KB	7.2%	0.11
Sep 18 16:00:00 - 16:59:59	59	3.3%	0.02	154.2 KB	2.7%	0.04
Sep 18 17:00:00 - 17:59:59	125	7.0%	0.03	398.0 KB	7.0%	0.11
Sep 18 18:00:00 - 18:59:59	75	4.2%	0.02	240.3 KB	4.2%	0.07
Sep 18 19:00:00 - 19:59:59	51	2.9%	0.01	129.3 KB	2.3%	0.04
Sep 18 20:00:00 - 20:59:59	56	3.2%	0.02	133.5 KB	2.3%	0.04
Sep 18 21:00:00 - 21:59:59	77	4.3%	0.02	238.8 KB	4.2%	0.07
Sep 18 22:00:00 - 22:59:59	83	4.7%	0.02	258.5 KB	4.5%	0.07
Sep 18 23:00:00 - 23:59:59	71	4.0%	0.02	214.2 KB	3.8%	0.06
Sep 19 00:00:00 - 00:59:59	128	7.2%	0.04	365.9 KB	6.4%	0.10
Sep 19 01:00:00 - 01:59:59	54	3.0%	0.01	180.1 KB	3.2%	0.05
Sep 19 02:00:00 - 02:59:59	54	3.0%	0.01	163.0 KB	2.9%	0.05
Sep 19 03:00:00 - 03:30:00	23	1.3%	0.01	47.8 KB	0.8%	0.03
TOTAL: 24:00:00	1776	100.0%	0.02	5.6 MB	100.0%	0.07

Sites sending bad articles:

Server		Total	Group	Other
1	feeder1-2.proxad.net	12543	986	11557
2	news.fdn.fr	675	644	31
3	pasdenom.info	42	0	42
4	feed-out.gegeweb.org	19	2	17
5	news.trigofacile.com	1	0	1
TOTAL: 5		13280	1632	11648

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.test.ping	288
linux.debian.changes.devel	261
linux.debian.bugs.dist	172
linux.debian.bugs.rc	138
alt.fan.rush-limbaugh	121
alt.arts.poetry.comments	94
alt.buddha.short.fat.guy	84
alt.usage.english	69
alt.russian.z1	41
alt.computer.workshop	21
alt.food.fast-food	20
alt.bestjobsusa.computer.jobs	20
linux.debian.user	19
alt.checkmate	19
alt.prophecies.nostradamus	13
alt.slack	13
alt.recovery.aa	13
linux.debian.kernel	12
linux.debian.maint.ocaml.maint	10
alt.comp.software.thunderbird	10
TOTAL: 87	1632

INND Perl filter [Top 20]:

Reason	Count
EMP (fsl)	11411
Too many newsgroups	95
Binary in non-binary group	46
badword in subject & alt	28
Too many newsgroups2	25
Bad path (news.theremailer.net)	13
badword in From & alt	5
HTML post	5
Scoring filter (8)	3
Scoring filter (9)	1
TOTAL: 10	11632

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	glou.org	1641	735	498	33	1	44%	23:20:05
2	agneau.org	238	238	0	0	0	100%	15:04:48
3	news.gegeweb.org	1610	221	984	59	0	13%	23:21:09
4	proxad.net	1235	71	750	0	1	5%	22:41:30
5	fdn.fr	1551	67	1025	1	0	4%	23:21:25
6	usenet.pasdenom.info	2196	18	1223	25	0	0%	23:20:26
7	news.trigofacile.com	156	11	99	0	0	7%	11:09:26
8	feed.ac-versailles.fr	0	0	0	0	1370	0%	24:00:04
9	snof.org	0	0	0	0	55	0%	24:00:04
10	delepine.info	0	0	0	0	237	0%	24:00:04
TOTAL: 10		8627	1361	4579	118	1664	15%	214:19:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	glou.org	2.2 MB	105.7 KB	2.3 MB	3.1 KB	23:20:05
2	news.gegeweb.org	753.3 KB	203.9 KB	957.2 KB	3.4 KB	23:21:09
3	agneau.org	579.6 KB	0.0 KB	579.6 KB	2.4 KB	15:04:48
4	proxad.net	210.0 KB	0.0 KB	210.0 KB	3.0 KB	22:41:30
5	fdn.fr	205.5 KB	1.2 KB	206.7 KB	3.0 KB	23:21:25
6	usenet.pasdenom.info	51.5 KB	70.7 KB	122.1 KB	2.8 KB	23:20:26
7	news.trigofacile.com	25.4 KB	0.0 KB	25.4 KB	2.3 KB	11:09:26
8	feed.ac-versailles.fr	0.0 KB	0.0 KB	0.0 KB	0	24:00:04
9	snof.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:04
10	delepine.info	0.0 KB	0.0 KB	0.0 KB	0	24:00:04
TOTAL: 10		4.0 MB	381.5 KB	4.4 MB	3.0 KB	214:19:01

Backlog files shrunk by innfeed:

Server	Size
feed.ac-versailles.fr	100.1 KB
TOTAL: 1	100.1 KB

UUCP batches created:

Server	Offered	Articles	Size	Elapsed
lolonet	67	237	562.3 KB	00:00:31
TOTAL: 1	67	237	562.3 KB	00:00:31

NNRP readership statistics:

System		Conn	Rej	Elapsed
1	052559474.box.freepro.com	23	0	00:00:11
2	45-56-79-53.ip.linodeusercontent.com	1	0	00:00:03
3	52.195.132.66.censys-scanner.com	3	0	00:00:00
4	173-255-212-137.ip.linodeusercontent.com	1	0	00:00:00
5	120.154.45.199.censys-scanner.com	3	0	00:00:05
6	o030.scanner.modat.io	1	0	00:00:00
7	azpdsgvdfoed.stretchoid.com	2	0	00:00:20
8	2a01:4020:1:1:103::5db	1	0	00:00:00
9	172-236-228-227.ip.linodeusercontent.com	2	0	00:00:00
10	ipservice-092-209-004-054.092.209.pools.vodafone-ip.de	9	0	03:44:15
11	216.25.126.1	1	0	00:00:00
12	147.185.132.22	1	0	00:00:00
13	nyc1-12.tennessine.do.prod.binaryedge.ninja	1	0	00:00:01
14	91.196.222.222	1	2	00:01:31
15	45-79-211-97.ip.linodeusercontent.com	1	0	00:00:02
16	static-176-182-254-212.ncc.abo.bbox.fr	2	0	00:00:26
17	toma-03.stehlik.co.uk	504	0	23:20:56
18	69-5-169-2.infrawat.ch	1	0	00:00:00
19	2a01:4020:1:1:102::48c	1	0	00:00:00
20	cabale.usenet-fr.net	28	0	00:00:58
21	193-124-20-227.infrawat.ch	1	0	00:00:00
22	r4-131-83.monitoring.internet-measurement.com	1	0	00:00:01
TOTAL: 22		589	2	27:08:58

NNRP readership statistics (by domain):

System		Conn	Rej	Elapsed
1	*.tennessine.do.prod.binaryedge.ninja	1	0	00:00:01
2	*.092.209.pools.vodafone-ip.de	9	0	03:44:15
3	*.ip.linodeusercontent.com	5	0	00:00:06
4	*.monitoring.internet-measurement.com	1	0	00:00:01
5	unresolved	3	2	00:01:31
6	*.154.45.199.censys-scanner.com	3	0	00:00:05
7	*.195.132.66.censys-scanner.com	3	0	00:00:00
8	*.scanner.modat.io	1	0	00:00:00
9	?	2	0	00:00:00
10	*.usenet-fr.net	28	0	00:00:58
11	*.ncc.abo.bbox.fr	2	0	00:00:26
12	*.infrawat.ch	2	0	00:00:00
13	*.box.freepro.com	23	0	00:00:11
14	*.stretchoid.com	2	0	00:00:20
15	*.stehlik.co.uk	504	0	23:20:56
TOTAL: 15		589	2	27:08:58

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
toma-03.stehlik.co.uk	2.591	5.205	22.477	23:20:56
ipservice-092-209-004-054.092.209.pools.vodafone-ip.de	0.424	0.684	0.491	03:44:15
91.196.222.222	0.000	0.007	0.000	00:01:31
cabale.usenet-fr.net	0.016	0.094	0.000	00:00:58
static-176-182-254-212.ncc.abo.bbox.fr	0.000	0.010	0.089	00:00:26
azpdsgvdfoed.stretchoid.com	0.000	0.008	0.000	00:00:20
052559474.box.freepro.com	0.025	0.090	1.025	00:00:11
120.154.45.199.censys-scanner.com	0.000	0.012	0.000	00:00:05
45-56-79-53.ip.linodeusercontent.com	0.000	0.004	0.000	00:00:03
45-79-211-97.ip.linodeusercontent.com	0.002	0.002	0.000	00:00:02
r4-131-83.monitoring.internet-measurement.com	0.000	0.004	0.000	00:00:01
nyc1-12.tennessine.do.prod.binaryedge.ninja	0.004	0.000	0.000	00:00:01
52.195.132.66.censys-scanner.com	0.000	0.012	0.000	00:00:00
o030.scanner.modat.io	0.000	0.004	0.000	00:00:00
193-124-20-227.infrawat.ch	0.004	0.000	0.000	00:00:00
172-236-228-227.ip.linodeusercontent.com	0.000	0.008	0.000	00:00:00
147.185.132.22	0.000	0.004	0.000	00:00:00
173-255-212-137.ip.linodeusercontent.com	0.004	0.000	0.000	00:00:00
?	0.061	0.441	0.000	00:00:00
216.25.126.1	0.003	0.000	0.000	00:00:00
TOTAL: 23	3.134	6.601	24.082	27:08:58

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	2
TOTAL: 1	2

NNRP unrecognized commands (by host) [Top 100]:

System	Conn
cabale.usenet-fr.net	12
172-236-228-227.ip.linodeusercontent.com	7
120.154.45.199.censys-scanner.com	2
52.195.132.66.censys-scanner.com	2
173-255-212-137.ip.linodeusercontent.com	1
azpdsgvdfoed.stretchoid.com	1
TOTAL: 6	25

NNRP unrecognized commands (by command) [Top 100]:

Command	Count
GET / HTTP/1.1	4
Host: 213.36.253.122:563	3
Accept: /	3
EHLO www.censys.io	2
STARTTLS	2
User-Agent: curl/7.68.0	2
Accept-Encoding: gzip	2
Host: 213.36.253.122:119	1
User-Agent: Hello from Palo Alto Network...	1
^V^C^A	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
^C	1
^A	1
MGLNDD_213.36.253.122_119	1
TOTAL: 14	25

NNRP client timeouts [Top 20]:

System	Conn	Peer
ipservice-092-209-004-054.092.209.pools.vodafone-ip.de	5	0
cabale.usenet-fr.net	2	4
52.195.132.66.censys-scanner.com	1	2
91.196.222.222	1	1
173-255-212-137.ip.linodeusercontent.com	1	1
120.154.45.199.censys-scanner.com	1	2
69-5-169-2.infrawat.ch	1	1
2a01:4020:1:1:102::48c	1	1
TOTAL: 8	13	19

Daily Usenet report

Sep 18 03:30:00 -- Sep 19 03:30:00