Daily Usenet report for news.niel.me: Oct 10 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2335	27.8%	384.0 KB	31.0%
innd	2274	27.1%	383.9 KB	31.0%
nnrpd	1912	22.8%	215.0 KB	17.4%
innfeed	1878	22.4%	254.8 KB	20.6%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8401	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	5502	45.4%
Negative hits	4311	35.6%
Do not exist	2309	19.0%
Cache misses	2	0.0%
TOTAL: 4	12124	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.013	0.0%	10	0.000	1.300	5.000
article cancel	00:00:00.002	0.0%	10	0.000	0.200	1.000
article cleanup	00:00:00.041	0.0%	2328	0.000	0.018	0.167
article logging	00:00:00.175	0.0%	2328	0.000	0.075	0.333
article parse	00:00:00.685	0.0%	8912	0.000	0.077	0.333
article write	00:00:00.768	0.0%	1560	0.000	0.492	1.600
artlog/artcncl	00:00:00.000	0.0%	10	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	10	0.000	0.200	1.000
data move	00:00:00.106	0.0%	19799	0.000	0.005	0.049
hisgrep/artcncl	00:00:00.001	0.0%	10	0.000	0.100	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	10	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	10	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	10	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.234	0.0%	12165	0.000	0.019	0.067
history sync	00:00:00.033	0.0%	324	0.000	0.102	1.000
history write	00:00:00.429	0.0%	2328	0.000	0.184	0.667
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:33.849	100.0%	19200	530.594	4501.763	33356.500
nntp read	00:00:00.591	0.0%	18518	0.000	0.032	0.107
overview write	00:00:00.522	0.0%	1560	0.000	0.335	8.000
perl filter	00:00:14.566	0.0%	2328	1.333	6.257	65.000
python filter	00:00:00.008	0.0%	2328	0.000	0.003	0.167
site send	00:00:00.454	0.0%	3175	0.000	0.143	0.600
TOTAL: 24:01:02.315	24:00:52.479	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.012	0.0%	1583	0.000	0.008	0.143
article prepare	00:00:00.000	0.0%	556	0.000	0.000	0.000
article read	00:00:00.029	0.0%	137	0.000	0.212	7.000
backlog stats	00:00:00.103	0.0%	18418	0.000	0.006	0.031
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.248	0.0%	7992	0.000	0.031	0.125
data write	00:00:00.466	0.0%	6512	0.000	0.072	0.500
idle	23:58:25.459	100.0%	18418	1422.964	4685.930	10193.508
status file	00:00:13.458	0.0%	343	1.000	39.236	103.000
TOTAL: 23:59:00.839	23:58:39.775	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:42.321	27.5%	1455	10.400	29.087	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.119	0.1%	3271	0.000	0.036	0.500
TOTAL: 00:02:34.020	00:00:42.440	27.6%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	171

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	1	2253	714	807	732	31%	23:59:57
2	feed-out.gegeweb.org	2	1581	673	908	0	42%	23:59:14
3	gegeweb-out.news.tnetconsulting.net	3	1610	93	1517	0	5%	32:51:02
4	news.glou.org	4	977	80	882	15	8%	20:28:29
5	nntp.terraraq.uk	5	1667	59	1607	1	3%	32:47:23
6	localhost	25	0	0	0	0	0%	00:00:00
7	usenet.pasdenom.info	8	1171	0	1171	0	0%	32:08:05
TOTAL: 7		48	9259	1619	6892	748	17%	166:14:10

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	3.5 MB	14.6 MB	18.1 MB	19%	12.8 KB
2	feed-out.gegeweb.org	2.8 MB	0.0 KB	2.8 MB	100%	4.3 KB
3	nntp.terraraq.uk	355.5 KB	2.3 KB	357.8 KB	99%	6.0 KB
4	gegeweb-out.news.tnetconsulting.net	251.6 KB	0.0 KB	251.6 KB	100%	2.7 KB
5	news.glou.org	245.6 KB	44.3 KB	289.9 KB	84%	3.1 KB
6	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
7	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 7		7.2 MB	14.6 MB	21.8 MB	32%	9.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 10 04:15:02 - 04:59:59	22	1.4%	0.01	71.4 KB	1.0%	0.03
Oct 10 05:00:00 - 05:59:59	36	2.3%	0.01	191.4 KB	2.7%	0.05
Oct 10 06:00:00 - 06:59:59	30	1.9%	0.01	109.9 KB	1.5%	0.03
Oct 10 07:00:00 - 07:59:59	36	2.3%	0.01	189.7 KB	2.7%	0.05
Oct 10 08:00:00 - 08:59:59	50	3.2%	0.01	211.6 KB	3.0%	0.06
Oct 10 09:00:00 - 09:59:59	68	4.4%	0.02	267.8 KB	3.8%	0.07
Oct 10 10:00:00 - 10:59:59	91	5.8%	0.03	372.6 KB	5.2%	0.10
Oct 10 11:00:00 - 11:59:59	94	6.0%	0.03	426.5 KB	6.0%	0.12
Oct 10 12:00:00 - 12:59:59	71	4.5%	0.02	336.0 KB	4.7%	0.09
Oct 10 13:00:00 - 13:59:59	58	3.7%	0.02	217.4 KB	3.1%	0.06
Oct 10 14:00:00 - 14:59:59	44	2.8%	0.01	130.2 KB	1.8%	0.04
Oct 10 15:00:00 - 15:59:59	78	5.0%	0.02	332.7 KB	4.7%	0.09
Oct 10 16:00:00 - 16:59:59	80	5.1%	0.02	477.7 KB	6.7%	0.13
Oct 10 17:00:00 - 17:59:59	85	5.4%	0.02	639.3 KB	9.0%	0.18
Oct 10 18:00:00 - 18:59:59	119	7.6%	0.03	1015.1 KB	14.3%	0.28
Oct 10 19:00:00 - 19:59:59	75	4.8%	0.02	294.2 KB	4.1%	0.08
Oct 10 20:00:00 - 20:59:59	66	4.2%	0.02	289.9 KB	4.1%	0.08
Oct 10 21:00:00 - 21:59:59	83	5.3%	0.02	218.6 KB	3.1%	0.06
Oct 10 22:00:00 - 22:59:59	88	5.6%	0.02	327.4 KB	4.6%	0.09
Oct 10 23:00:00 - 23:59:59	86	5.5%	0.02	303.7 KB	4.3%	0.08
Oct 11 00:00:00 - 00:59:59	42	2.7%	0.01	114.1 KB	1.6%	0.03
Oct 11 01:00:00 - 01:59:59	55	3.5%	0.02	167.6 KB	2.4%	0.05
Oct 11 02:00:00 - 02:59:59	55	3.5%	0.02	212.2 KB	3.0%	0.06
Oct 11 03:00:00 - 03:59:59	40	2.6%	0.01	154.2 KB	2.2%	0.04
Oct 11 04:00:00 - 04:15:01	9	0.6%	0.01	31.3 KB	0.4%	0.03
TOTAL: 23:59:59	1561	100.0%	0.02	6.9 MB	100.0%	0.08

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	732	141	591
2	news.glou.org	21	0	21
3	nntp.terraraq.uk	1	0	1
TOTAL: 3		754	141	613

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	78
linux.kernel.git	62
news.test	1
TOTAL: 3	141

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced binary	412
Too many newsgroups	89
EMP (md5)	57
Bad path (news.giganews.com.POSTED)	45
Cancels abusifs	5
HTML Multipart	4
Cancel of non-existing ID <mkrrsrFnvp1U1@mid.individual.net>	1
TOTAL: 7	613

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2297	33	1428	99	21	1%	23:53:30
2	news.nntp4.net	973	5	823	0	0	0%	23:31:46
3	nntp.terraraq.uk	883	1	833	1	0	0%	23:38:38
4	i2pn.org	0	0	0	0	1559	0%	23:59:59
5	news.gegeweb.org	921	0	899	0	0	0%	23:54:38
6	news.aioe.org	0	0	0	0	1228	0%	23:59:59
7	news.pasdenom.info	1325	0	1070	0	0	0%	23:55:07
8	news.samoylyk.net	0	0	0	0	1561	0%	23:59:57
TOTAL: 8		6399	39	5053	100	4369	0%	190:53:34

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	242.3 KB	611.8 KB	854.1 KB	6.5 KB	23:53:30
2	news.nntp4.net	13.2 KB	0.0 KB	13.2 KB	2.6 KB	23:31:46
3	nntp.terraraq.uk	2.0 KB	6.0 KB	8.0 KB	4.0 KB	23:38:38
4	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
5	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:54:38
6	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
7	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:55:07
8	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 8		257.4 KB	617.8 KB	875.2 KB	6.3 KB	190:53:34

NNRP readership statistics:

System		Conn	Elapsed
1	165.154.12.38	3	00:00:11
2	mail.gegeweb.eu	288	00:01:42
3	198.235.24.192	1	00:00:00
4	2a06:4882:3000::3c	1	00:00:04
5	2a06:4883:1000::a	1	00:00:00
6	147.185.132.179	1	00:00:00
7	205.210.31.43	1	00:00:02
8	198.235.24.172	1	00:00:02
9	185.242.226.126	1	00:00:02
10	2a06:4883:3000::3f	1	00:00:03
11	azpdcgvlil1y.stretchoid.com	2	00:00:10
12	68.211.203.35.bc.googleusercontent.com	2	00:00:03
13	66.132.153.127	3	00:00:00
14	2a06:4882:1000::18	1	00:00:00
15	2a06:4883:1000::3	1	00:00:00
16	2607:ff10:c8:594::6	1	00:00:03
17	66.132.153.116	1	00:00:02
18	60.210.203.35.bc.googleusercontent.com	1	00:00:00
19	165.210.203.35.bc.googleusercontent.com	2	00:00:04
TOTAL: 19		313	00:02:37

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:01:42
2	*.211.203.35.bc.googleusercontent.com	2	00:00:03
3	*.stretchoid.com	2	00:00:10
4	unresolved	12	00:00:23
5	*.210.203.35.bc.googleusercontent.com	3	00:00:05
6	?	6	00:00:11
TOTAL: 6		313	00:02:37

NNRP auth users [Top 20]:

User	Conn
mailman	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mail.gegeweb.eu	4.800	4.490	1.829	00:01:42
165.154.12.38	0.073	0.040	0.000	00:00:11
azpdcgvlil1y.stretchoid.com	0.050	0.054	0.000	00:00:10
165.210.203.35.bc.googleusercontent.com	0.118	0.044	0.000	00:00:04
2a06:4882:3000::3c	0.055	0.020	0.000	00:00:04
68.211.203.35.bc.googleusercontent.com	0.120	0.048	0.000	00:00:03
2607:ff10:c8:594::6	0.023	0.023	0.000	00:00:03
2a06:4883:3000::3f	0.036	0.020	0.000	00:00:03
198.235.24.172	0.018	0.026	0.000	00:00:02
185.242.226.126	0.063	0.012	0.000	00:00:02
205.210.31.43	0.007	0.016	0.000	00:00:02
66.132.153.116	0.030	0.026	0.000	00:00:02
66.132.153.127	0.061	0.021	0.000	00:00:00
60.210.203.35.bc.googleusercontent.com	0.063	0.024	0.000	00:00:00
147.185.132.179	0.062	0.012	0.000	00:00:00
198.235.24.192	0.024	0.027	0.000	00:00:00
2a06:4882:1000::18	0.018	0.009	0.000	00:00:00
2a06:4883:1000::a	0.041	0.017	0.000	00:00:00
TOTAL: 18	5.662	4.929	1.829	00:02:37

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
185.242.226.126	5
68.211.203.35.bc.googleusercontent.com	4
147.185.132.179	4
60.210.203.35.bc.googleusercontent.com	4
165.210.203.35.bc.googleusercontent.com	4
165.154.12.38	2
azpdcgvlil1y.stretchoid.com	1
66.132.153.116	1
TOTAL: 8	25

NNRP unrecognized commands (by command):

Command	Count
Host: 45.13.105.36:563	5
GET / HTTP/1.1	5
Accept: /	3
Accept-Encoding: gzip	3
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.68.0	2
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
MGLNDD_45.13.105.36_119	1
À#024	1
#026#003#001#001#027#001	1
EHLO www.censys.io	1
TOTAL: 11	25

NNRP client timeouts [Top 20]:

System	Conn	Peer
165.210.203.35.bc.googleusercontent.com	1	2
68.211.203.35.bc.googleusercontent.com	1	2
TOTAL: 2	2	7

Daily Usenet report for news.niel.me

Oct 10 04:15:02 -- Oct 11 04:15:01