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

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Oct 13 09:41:54 rpi-studio innfeed[26976]: news.gegeweb.org:0 connect: Network is unreachable
Oct 13 09:42:15 rpi-studio innfeed[26976]: news.nntp4.net:0 connect: Network is unreachable
Oct 13 09:50:07 rpi-studio innfeed[26976]: news.gegeweb.org:0 connect: Network is unreachable
Oct 13 09:50:27 rpi-studio innfeed[26976]: news.nntp4.net:0 connect: Network is unreachable
Oct 13 10:16:16 rpi-studio innfeed[26976]: news.gegeweb.org:0 connect: Network is unreachable
Oct 13 10:16:37 rpi-studio innfeed[26976]: news.nntp4.net:0 connect: Network is unreachable

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4723	40.7%	800.9 KB	44.7%
innd	3529	30.4%	537.2 KB	30.0%
nnrpd	1742	15.0%	192.3 KB	10.7%
innfeed	1609	13.9%	260.7 KB	14.5%
nocem	11	0.1%	1.1 KB	0.1%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	11615	100.0%	1.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	20998	64.5%
Negative hits	6937	21.3%
Do not exist	4630	14.2%
Cache misses	15	0.0%
TOTAL: 4	32580	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.042	0.0%	18	0.000	2.333	7.000
article cancel	00:00:00.003	0.0%	33	0.000	0.091	0.500
article cleanup	00:00:00.073	0.0%	4626	0.000	0.016	0.125
article logging	00:00:00.361	0.0%	4651	0.000	0.078	0.273
article parse	00:00:00.830	0.0%	7062	0.000	0.118	0.361
article write	00:00:02.721	0.0%	4017	0.105	0.677	9.478
artlog/artcncl	00:00:00.001	0.0%	28	0.000	0.036	0.250
artlog/artcncl/perl	00:00:00.002	0.0%	18	0.000	0.111	0.500
data move	00:00:00.102	0.0%	34780	0.000	0.003	0.019
hisgrep/artcncl	00:00:00.000	0.0%	25	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	18	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	30	0.000	0.033	0.500
hishave/artcncl	00:00:00.000	0.0%	33	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	18	0.000	0.056	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.444	0.0%	32556	0.000	0.014	0.044
history sync	00:00:00.052	0.0%	406	0.000	0.128	0.667
history write	00:00:01.044	0.0%	4626	0.000	0.226	0.667
hiswrite/artcncl	00:00:00.001	0.0%	8	0.000	0.125	0.200
idle	23:50:33.486	99.9%	35488	1012.671	2418.662	8960.149
nntp read	00:00:01.187	0.0%	34822	0.000	0.034	0.081
overview write	00:00:02.723	0.0%	4017	0.000	0.678	6.957
perl filter	00:00:20.694	0.0%	4626	2.049	4.473	7.500
python filter	00:00:00.013	0.0%	4626	0.000	0.003	0.083
site send	00:00:01.302	0.0%	8046	0.000	0.162	0.475
TOTAL: 23:51:20.864	23:51:05.083	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	4691	0.000	0.007	0.062
article prepare	00:00:00.001	0.0%	1188	0.000	0.001	0.250
article read	00:00:00.046	0.0%	277	0.000	0.166	3.000
backlog stats	00:00:00.117	0.0%	59857	0.000	0.002	0.012
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.790	0.0%	33591	0.000	0.024	0.056
data write	00:00:02.180	0.0%	29542	0.026	0.074	0.139
idle	23:49:55.857	100.0%	59857	705.043	1433.347	4444.422
status file	00:00:00.493	0.0%	184	0.000	2.679	43.500
TOTAL: 23:50:02.915	23:49:59.516	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:24.571	14.9%	1139	13.500	21.572	797.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.082	0.0%	2637	0.000	0.031	0.500
readart	00:00:00.017	0.0%	1	17.000	17.000	17.000
TOTAL: 00:02:44.369	00:00:24.670	15.0%	-	-	-	-

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-out.aioe.org	3	4111	2021	2008	82	49%	23:54:30
2	i2pn.org	1	4373	1064	3258	51	24%	24:10:45
3	feed-out.gegeweb.org	280	2697	404	2278	15	14%	22:45:21
4	nntp.terraraq.uk	1	3524	225	2980	319	6%	23:02:35
5	news.nntp4.net	2	3989	203	3641	145	5%	20:27:22
6	gegeweb-out.news.tnetconsulting.net	1	4565	8	4554	3	0%	23:57:14
7	usenet.pasdenom.info	1	0	0	0	0	0%	00:00:00
8	localhost	28	0	0	0	0	0%	00:00:00
TOTAL: 8		317	23259	3925	18719	615	16%	138:17:47

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	6.0 MB	183.9 KB	6.2 MB	97%	3.0 KB
2	i2pn.org	4.0 MB	174.6 KB	4.1 MB	95%	3.8 KB
3	nntp.terraraq.uk	3.6 MB	1.4 MB	5.0 MB	71%	9.5 KB
4	news.nntp4.net	1.8 MB	566.4 KB	2.4 MB	76%	7.0 KB
5	feed-out.gegeweb.org	930.3 KB	16.4 KB	946.7 KB	98%	2.3 KB
6	gegeweb-out.news.tnetconsulting.net	198.4 KB	6.7 KB	205.0 KB	96%	18.6 KB
7	usenet.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0%	0
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		16.5 MB	2.4 MB	18.9 MB	87%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 13 04:15:02 - 04:59:59	80	2.0%	0.03	556.2 KB	3.4%	0.21
Oct 13 05:00:00 - 05:59:59	87	2.2%	0.02	279.3 KB	1.7%	0.08
Oct 13 06:00:00 - 06:59:59	112	2.8%	0.03	646.3 KB	3.9%	0.18
Oct 13 07:00:00 - 07:59:59	110	2.7%	0.03	437.7 KB	2.7%	0.12
Oct 13 08:00:00 - 08:59:59	93	2.3%	0.03	829.8 KB	5.1%	0.23
Oct 13 09:00:00 - 09:59:59	164	4.1%	0.05	674.3 KB	4.1%	0.19
Oct 13 10:00:00 - 10:59:59	185	4.6%	0.05	529.9 KB	3.2%	0.15
Oct 13 11:00:00 - 11:59:59	138	3.4%	0.04	581.5 KB	3.5%	0.16
Oct 13 12:00:00 - 12:59:59	144	3.6%	0.04	478.6 KB	2.9%	0.13
Oct 13 13:00:00 - 13:59:59	168	4.2%	0.05	1.0 MB	6.3%	0.29
Oct 13 14:00:00 - 14:59:59	243	6.0%	0.07	815.7 KB	5.0%	0.23
Oct 13 15:00:00 - 15:59:59	192	4.8%	0.05	850.6 KB	5.2%	0.24
Oct 13 16:00:00 - 16:59:59	220	5.4%	0.06	675.8 KB	4.1%	0.19
Oct 13 17:00:00 - 17:59:59	193	4.8%	0.05	706.8 KB	4.3%	0.20
Oct 13 18:00:00 - 18:59:59	234	5.8%	0.07	1.2 MB	7.4%	0.34
Oct 13 19:00:00 - 19:59:59	249	6.2%	0.07	763.3 KB	4.7%	0.21
Oct 13 20:00:00 - 20:59:59	189	4.7%	0.05	584.3 KB	3.6%	0.16
Oct 13 21:00:00 - 21:59:59	208	5.1%	0.06	791.2 KB	4.8%	0.22
Oct 13 22:00:00 - 22:59:59	224	5.5%	0.06	887.5 KB	5.4%	0.25
Oct 13 23:00:00 - 23:59:59	192	4.8%	0.05	777.2 KB	4.7%	0.22
Oct 14 00:00:00 - 00:59:59	204	5.0%	0.06	768.2 KB	4.7%	0.21
Oct 14 01:00:00 - 01:59:59	154	3.8%	0.04	504.0 KB	3.1%	0.14
Oct 14 02:00:00 - 02:59:59	117	2.9%	0.03	392.7 KB	2.4%	0.11
Oct 14 03:00:00 - 03:59:59	109	2.7%	0.03	538.5 KB	3.3%	0.15
Oct 14 04:00:00 - 04:15:01	32	0.8%	0.04	78.0 KB	0.5%	0.09
TOTAL: 23:59:59	4041	100.0%	0.05	16.0 MB	100.0%	0.19

Sites sending bad articles:

Server		Total	Group	Other
1	nntp.terraraq.uk	293	0	293
2	news.nntp4.net	163	0	163
3	news-out.aioe.org	106	1	105
4	i2pn.org	54	0	54
5	feed-out.gegeweb.org	17	0	17
6	gegeweb-out.news.tnetconsulting.net	2	0	2
7	usenet.pasdenom.info	1	0	1
TOTAL: 7		636	1	635

Unwanted newsgroups [Top 20]:

Newsgroup	Count
news.test	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	207
EMP (phn nph)	178
EMP (md5)	89
Bad path (news.giganews.com.POSTED)	71
User-issued spam cancel	31
EMP (phl)	28
Excessive Supersedes (77.129.239.29)	1
Cancel of non-existing ID <61674814$0$6453$426a74cc@news.free.fr>	1
Cancel of non-existing ID <M5d9J.34233$dI3.26876@fx10.iad>	1
Cancel of <sk7htd$4l0$1@dont-email.me> without Cancel-Key	1
Cancel of non-existing ID <6166d714$0$8893$426a74cc@news.free.fr>	1
TOTAL: 11	609

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	8	0	8	8
TOTAL: 1	8	0	8	8

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	24
	feed-out.gegeweb.org	2
	TOTAL: 2	26
TOTAL: 1		26

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.gegeweb.org	3781	50	3482	97	277	1%	23:59:56
2	i2pn.org	5622	38	2913	12	67	0%	23:59:38
3	news.tnetconsulting.net	6771	36	3988	16	54	0%	23:59:56
4	nntp.terraraq.uk	2959	12	2533	0	0	0%	23:58:04
5	news.pasdenom.info	4536	9	3332	17	0	0%	23:59:56
6	news.aioe.org	1970	6	1552	0	0	0%	23:47:59
7	news.nntp4.net	4662	5	3790	0	279	0%	23:59:56
TOTAL: 7		30301	156	21590	142	677	0%	167:45:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	199.9 KB	44.4 KB	244.3 KB	4.7 KB	23:59:56
2	news.gegeweb.org	163.9 KB	352.0 KB	515.9 KB	3.5 KB	23:59:56
3	i2pn.org	115.3 KB	22.7 KB	138.0 KB	2.8 KB	23:59:38
4	nntp.terraraq.uk	44.6 KB	0.0 KB	44.6 KB	3.7 KB	23:58:04
5	news.pasdenom.info	32.6 KB	1.2 MB	1.2 MB	47.7 KB	23:59:56
6	news.nntp4.net	24.6 KB	0.0 KB	24.6 KB	4.9 KB	23:59:56
7	news.aioe.org	19.8 KB	0.0 KB	19.8 KB	3.3 KB	23:47:59
TOTAL: 7		600.7 KB	1.6 MB	2.2 MB	7.5 KB	167:45:25

NNRP readership statistics:

System		Conn	Elapsed
1	212.90.61.180	1	00:00:01
2	218.94.99.102	1	00:00:02
3	185.193.88.51	3	00:00:30
4	wine.census.shodan.io	1	00:00:01
5	sys.gegeweb.eu	277	00:02:01
6	89.248.165.23	1	00:00:00
7	221.226.241.26	1	00:00:02
8	88.165.5.23	5	00:00:03
TOTAL: 8		290	00:02:43

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.census.shodan.io	1	00:00:01
2	*.gegeweb.eu	277	00:02:01
3	unresolved	12	00:00:40
TOTAL: 3		290	00:02:43

NNRP auth users [Top 20]:

User	Conn
mailman	277
TOTAL: 1	277

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
sys.gegeweb.eu	7.838	8.407	3.049	00:02:01
185.193.88.51	0.051	0.071	0.000	00:00:30
88.165.5.23	0.169	0.137	0.000	00:00:03
221.226.241.26	0.076	0.033	0.000	00:00:02
218.94.99.102	0.054	0.036	0.000	00:00:02
212.90.61.180	0.024	0.049	0.000	00:00:01
wine.census.shodan.io	0.010	0.041	0.000	00:00:01
89.248.165.23	0.022	0.032	0.000	00:00:00
TOTAL: 8	8.244	8.806	3.049	00:02:43

NNRP unrecognized commands (by host):

System	Conn
185.193.88.51	3
89.248.165.23	1
TOTAL: 2	4

NNRP unrecognized commands (by command):

Command	Count
#003	4
TOTAL: 1	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
185.193.88.51	3	3
89.248.165.23	1	1
TOTAL: 2	4	4

Daily Usenet report for news.niel.me

Oct 13 04:15:02 -- Oct 14 04:15:01