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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 15 17:00:04 rpi-studio pgpverify[18743]: pgpverify: verification failed
Sep 15 17:00:05 rpi-studio pgpverify[18758]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	5306	44.0%	912.7 KB	48.2%
innd	3488	28.9%	497.1 KB	26.2%
nnrpd	1728	14.3%	191.1 KB	10.1%
innfeed	1516	12.6%	290.2 KB	15.3%
controlchan	13	0.1%	2.2 KB	0.1%
pgpverify	2	0.0%	0.4 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 7	12054	100.0%	1.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	24515	65.7%
Negative hits	7514	20.1%
Do not exist	5253	14.1%
Cache misses	10	0.0%
TOTAL: 4	37292	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.043	0.0%	15	1.000	2.867	6.667
article cancel	00:00:00.003	0.0%	16	0.000	0.188	1.000
article cleanup	00:00:00.124	0.0%	5267	0.000	0.024	0.125
article logging	00:00:00.408	0.0%	5284	0.000	0.077	0.231
article parse	00:00:00.864	0.0%	8428	0.000	0.103	0.250
article write	00:00:03.913	0.0%	4693	0.167	0.834	20.078
artlog/artcncl	00:00:00.000	0.0%	16	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	15	0.000	0.067	0.167
data move	00:00:00.131	0.0%	40554	0.000	0.003	0.015
hisgrep/artcncl	00:00:00.000	0.0%	15	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	15	0.000	0.067	0.333
hisgrep/perl	00:00:00.001	0.0%	17	0.000	0.059	0.143
hishave/artcncl	00:00:00.000	0.0%	16	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	15	0.000	0.067	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.550	0.0%	37377	0.000	0.015	0.044
history sync	00:00:00.068	0.0%	412	0.000	0.165	2.833
history write	00:00:01.162	0.0%	5267	0.000	0.221	0.600
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	24:00:21.471	99.9%	41112	863.216	2102.098	6381.766
nntp read	00:00:01.383	0.0%	40474	0.000	0.034	0.080
overview write	00:00:02.842	0.0%	4693	0.125	0.606	4.571
perl filter	00:00:23.539	0.0%	5267	2.039	4.469	9.120
python filter	00:00:00.018	0.0%	8824	0.000	0.002	0.042
site send	00:00:01.000	0.0%	9390	0.000	0.106	0.407
TOTAL: 24:01:11.986	24:00:57.523	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.052	0.0%	4900	0.000	0.011	0.100
article prepare	00:00:00.002	0.0%	1124	0.000	0.002	0.062
article read	00:00:00.045	0.0%	269	0.000	0.167	4.000
backlog stats	00:00:00.134	0.0%	69697	0.000	0.002	0.017
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.928	0.0%	39878	0.000	0.023	0.052
data write	00:00:02.375	0.0%	35039	0.024	0.068	0.129
idle	23:50:54.326	100.0%	69697	621.163	1231.822	4506.022
status file	00:00:00.371	0.0%	157	1.000	2.363	7.000
TOTAL: 23:51:01.652	23:50:58.233	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:22.803	18.7%	1152	19.250	19.794	20.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.092	0.1%	2592	0.000	0.035	0.222
TOTAL: 00:02:01.877	00:00:22.895	18.8%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
group-admin@isc.org	0	0	2	2	0	2
TOTAL	0	0	2	2	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	1	4665	2133	2465	67	45%	22:35:49
2	i2pn.org	1	5424	1552	3745	127	28%	27:08:21
3	feed-out.gegeweb.org	290	3216	441	2775	0	13%	23:55:50
4	news.nntp4.net	4	3279	318	2879	82	9%	16:23:52
5	nntp.terraraq.uk	1	6002	247	5394	361	4%	35:01:56
6	gegeweb-out.news.tnetconsulting.net	1	4119	7	4106	6	0%	23:57:16
7	usenet.pasdenom.info	1	1076	3	1073	0	0%	09:13:14
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		324	27781	4701	22437	643	16%	158:16:18

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	6.6 MB	213.8 KB	6.8 MB	96%	3.2 KB
2	i2pn.org	5.7 MB	534.6 KB	6.2 MB	91%	3.8 KB
3	nntp.terraraq.uk	3.8 MB	2.2 MB	6.0 MB	63%	10.0 KB
4	news.nntp4.net	1.6 MB	466.7 KB	2.0 MB	77%	5.2 KB
5	feed-out.gegeweb.org	1.1 MB	0.0 KB	1.1 MB	100%	2.6 KB
6	gegeweb-out.news.tnetconsulting.net	359.9 KB	16.2 KB	376.2 KB	95%	28.9 KB
7	usenet.pasdenom.info	7.5 KB	0.0 KB	7.5 KB	100%	2.5 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		19.0 MB	3.4 MB	22.4 MB	84%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 15 04:15:02 - 04:59:59	88	1.9%	0.03	362.5 KB	2.0%	0.13
Sep 15 05:00:00 - 05:59:59	147	3.1%	0.04	775.5 KB	4.2%	0.22
Sep 15 06:00:00 - 06:59:59	156	3.3%	0.04	441.4 KB	2.4%	0.12
Sep 15 07:00:00 - 07:59:59	118	2.5%	0.03	527.7 KB	2.9%	0.15
Sep 15 08:00:00 - 08:59:59	129	2.8%	0.04	500.4 KB	2.7%	0.14
Sep 15 09:00:00 - 09:59:59	161	3.4%	0.04	845.6 KB	4.6%	0.23
Sep 15 10:00:00 - 10:59:59	156	3.3%	0.04	799.7 KB	4.4%	0.22
Sep 15 11:00:00 - 11:59:59	104	2.2%	0.03	316.2 KB	1.7%	0.09
Sep 15 12:00:00 - 12:59:59	262	5.6%	0.07	746.2 KB	4.1%	0.21
Sep 15 13:00:00 - 13:59:59	176	3.8%	0.05	564.1 KB	3.1%	0.16
Sep 15 14:00:00 - 14:59:59	203	4.3%	0.06	664.9 KB	3.6%	0.18
Sep 15 15:00:00 - 15:59:59	216	4.6%	0.06	666.8 KB	3.7%	0.19
Sep 15 16:00:00 - 16:59:59	233	5.0%	0.06	797.0 KB	4.4%	0.22
Sep 15 17:00:00 - 17:59:59	290	6.2%	0.08	1.4 MB	7.8%	0.40
Sep 15 18:00:00 - 18:59:59	298	6.4%	0.08	979.4 KB	5.4%	0.27
Sep 15 19:00:00 - 19:59:59	277	5.9%	0.08	1.5 MB	8.3%	0.42
Sep 15 20:00:00 - 20:59:59	260	5.5%	0.07	812.3 KB	4.4%	0.23
Sep 15 21:00:00 - 21:59:59	249	5.3%	0.07	775.7 KB	4.2%	0.22
Sep 15 22:00:00 - 22:59:59	253	5.4%	0.07	912.5 KB	5.0%	0.25
Sep 15 23:00:00 - 23:59:59	252	5.4%	0.07	981.5 KB	5.4%	0.27
Sep 16 00:00:00 - 00:59:59	208	4.4%	0.06	964.4 KB	5.3%	0.27
Sep 16 01:00:00 - 01:59:59	188	4.0%	0.05	720.7 KB	3.9%	0.20
Sep 16 02:00:00 - 02:59:59	138	2.9%	0.04	731.5 KB	4.0%	0.20
Sep 16 03:00:00 - 03:59:59	98	2.1%	0.03	327.5 KB	1.8%	0.09
Sep 16 04:00:00 - 04:15:01	25	0.5%	0.03	112.6 KB	0.6%	0.12
TOTAL: 23:59:59	4685	100.0%	0.05	17.8 MB	100.0%	0.21

Sites sending bad articles:

Server		Total	Group	Other
1	nntp.terraraq.uk	266	0	266
2	news.nntp4.net	128	0	128
3	i2pn.org	105	0	105
4	news-out.aioe.org	81	1	80
5	gegeweb-out.news.tnetconsulting.net	8	0	8
6	usenet.pasdenom.info	1	1	0
7	feed-out.gegeweb.org	1	0	1
TOTAL: 7		590	2	588

Unwanted newsgroups [Top 20]:

Newsgroup	Count
gnu.bash	1
news.test	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	236
EMP (phn nph)	148
Bad path (news.giganews.com.POSTED)	127
EMP (md5)	27
EMP (phl)	16
User-issued spam cancel	15
Cancel of non-existing ID <c5d390b0-b0bc-4b5a-a245-eadd9b7669d8n@googlegroups.com>	1
HTML post	1
TOTAL: 8	571

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	14
	feed-out.gegeweb.org	1
	nntp.terraraq.uk	1
	news.nntp4.net	1
	TOTAL: 4	17
TOTAL: 1		17

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	6218	48	3170	27	118	0%	23:59:56
2	news.tnetconsulting.net	7641	37	4643	4	94	0%	23:59:44
3	news.gegeweb.org	4423	23	4100	118	0	0%	23:59:56
4	nntp.terraraq.uk	3765	16	3061	0	0	0%	23:59:56
5	news.nntp4.net	5330	5	4289	0	0	0%	23:59:56
6	news.aioe.org	2269	3	1927	0	15	0%	23:59:56
7	news.pasdenom.info	5821	1	3954	0	0	0%	23:59:56
TOTAL: 7		35467	133	25144	149	227	0%	167:59:20

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	161.2 KB	498.5 KB	659.7 KB	4.7 KB	23:59:56
2	i2pn.org	146.0 KB	53.9 KB	199.9 KB	2.7 KB	23:59:56
3	news.tnetconsulting.net	134.1 KB	13.0 KB	147.1 KB	3.6 KB	23:59:44
4	nntp.terraraq.uk	72.3 KB	0.0 KB	72.3 KB	4.5 KB	23:59:56
5	news.nntp4.net	21.2 KB	0.0 KB	21.2 KB	4.2 KB	23:59:56
6	news.aioe.org	18.6 KB	0.0 KB	18.6 KB	6.2 KB	23:59:56
7	news.pasdenom.info	4.8 KB	0.0 KB	4.8 KB	4.8 KB	23:59:56
TOTAL: 7		558.2 KB	565.4 KB	1.1 MB	4.0 KB	167:59:20

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	sys.gegeweb.eu	288	0	0.0 KB	0	0	0	00:02:01
TOTAL: 1		288	0	0.0 KB	0	0	0	00:02:01

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.gegeweb.eu	288	0	0.0 KB	0	0	0	00:02:01
TOTAL: 1		288	0	0.0 KB	0	0	0	00:02:01

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
sys.gegeweb.eu	7.742	9.196	3.048	00:02:01
TOTAL: 1	7.742	9.196	3.048	00:02:01

Daily Usenet report for news.niel.me

Sep 15 04:15:02 -- Sep 16 04:15:01