Daily Usenet report for news.niel.me: Aug 15 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Aug 15 17:00:06 rpi-studio pgpverify[12149]: pgpverify: verification failed
Aug 15 17:00:16 rpi-studio pgpverify[12166]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2620	29.5%	499.9 KB	35.6%
nnrpd	2219	25.0%	241.8 KB	17.2%
innd	2041	23.0%	357.8 KB	25.5%
innfeed	1973	22.2%	300.3 KB	21.4%
controlchan	13	0.1%	2.3 KB	0.2%
pgpverify	2	0.0%	0.5 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 7	8869	100.0%	1.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	11352	59.1%
Negative hits	4960	25.8%
Do not exist	2569	13.4%
Cache misses	326	1.7%
TOTAL: 4	19207	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.023	0.0%	20	0.000	1.150	2.000
article cancel	00:00:00.004	0.0%	20	0.000	0.200	1.000
article cleanup	00:00:00.061	0.0%	2570	0.000	0.024	0.286
article logging	00:00:00.193	0.0%	2570	0.000	0.075	0.400
article parse	00:00:00.384	0.0%	7259	0.000	0.053	0.250
article write	00:00:01.231	0.0%	2411	0.077	0.511	1.333
artlog/artcncl	00:00:00.001	0.0%	20	0.000	0.050	1.000
artlog/artcncl/perl	00:00:00.000	0.0%	20	0.000	0.000	0.000
artlog/artwrite	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.127	0.0%	21442	0.000	0.006	0.032
hisgrep/artcncl	00:00:00.000	0.0%	20	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.002	0.0%	20	0.000	0.100	1.000
hisgrep/perl	00:00:00.000	0.0%	34	0.000	0.000	0.000
hishave/artcncl	00:00:00.001	0.0%	20	0.000	0.050	0.500
hishave/artcncl/perl	00:00:00.000	0.0%	20	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.339	0.0%	19172	0.000	0.018	0.059
history sync	00:00:00.054	0.0%	392	0.000	0.138	1.000
history write	00:00:00.365	0.0%	2570	0.000	0.142	0.417
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:50:42.203	100.0%	23746	521.867	3615.017	24019.800
nntp read	00:00:00.604	0.0%	22799	0.000	0.026	0.087
overview write	00:00:00.786	0.0%	2411	0.000	0.326	5.222
perl filter	00:00:09.195	0.0%	2570	1.018	3.578	7.333
python filter	00:00:00.009	0.0%	2570	0.000	0.004	0.143
site send	00:00:00.258	0.0%	4892	0.000	0.053	0.333
TOTAL: 23:51:03.341	23:50:55.840	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:02:04.867	0.1%	18562522	0.003	0.007	0.012
article prepare	00:00:00.008	0.0%	1448	0.000	0.006	0.250
article read	00:00:00.066	0.0%	346	0.000	0.191	1.000
backlog stats	00:00:51.969	0.1%	9980699	0.002	0.005	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:02:42.851	0.2%	7150951	0.008	0.023	0.036
data write	00:02:20.211	0.2%	7130471	0.012	0.020	0.029
idle	23:31:02.171	98.6%	9980699	7.542	8.483	9.818
status file	00:00:00.575	0.0%	281	0.000	2.046	5.500
TOTAL: 23:51:29.213	23:39:02.718	99.1%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:18:41.010	91.7%	7500	3.500	149.468	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.058	0.1%	26724	0.000	0.040	0.500
readart	00:00:01.104	0.1%	5682	0.113	0.194	7.000
TOTAL: 00:20:22.022	00:18:43.172	91.9%	-	-	-	-

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	feed-out.gegeweb.org	3	2304	1505	799	0	65%	23:59:34
2	gegeweb-out.news.tnetconsulting.net	2	2142	457	1643	42	21%	25:32:59
3	news.glou.org	2	3483	208	3121	154	5%	47:57:53
4	i2pn.org	1	2008	137	1871	0	6%	23:59:57
5	usenet.pasdenom.info	7	954	106	829	19	11%	20:43:08
6	nntp.terraraq.uk	2	1997	41	1954	2	2%	25:33:12
7	news.samoylyk.net	38	1952	5	1947	0	0%	13:03:12
8	news.nntp4.net	1	0	0	0	0	0%	00:10:03
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		81	14840	2459	12164	217	16%	180:59:58

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	6.1 MB	0.0 KB	6.1 MB	100%	4.2 KB
2	gegeweb-out.news.tnetconsulting.net	1.7 MB	201.4 KB	1.9 MB	89%	4.0 KB
3	news.glou.org	845.8 KB	869.5 KB	1.7 MB	49%	4.7 KB
4	news.samoylyk.net	777.0 KB	0.0 KB	777.0 KB	100%	155.4 KB
5	i2pn.org	410.8 KB	0.0 KB	410.8 KB	100%	3.0 KB
6	usenet.pasdenom.info	240.5 KB	26.1 KB	266.7 KB	90%	2.1 KB
7	nntp.terraraq.uk	219.4 KB	13.9 KB	233.4 KB	94%	5.4 KB
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0%	0
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		10.3 MB	1.1 MB	11.4 MB	90%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 15 04:15:01 - 04:59:59	37	1.5%	0.01	118.9 KB	1.1%	0.04
Aug 15 05:00:00 - 05:59:59	59	2.4%	0.02	239.5 KB	2.2%	0.07
Aug 15 06:00:00 - 06:59:59	40	1.7%	0.01	211.6 KB	2.0%	0.06
Aug 15 07:00:00 - 07:59:59	138	5.7%	0.04	686.6 KB	6.4%	0.19
Aug 15 08:00:00 - 08:59:59	50	2.1%	0.01	211.4 KB	2.0%	0.06
Aug 15 09:00:00 - 09:59:59	71	2.9%	0.02	273.9 KB	2.6%	0.08
Aug 15 10:00:00 - 10:59:59	97	4.0%	0.03	321.2 KB	3.0%	0.09
Aug 15 11:00:00 - 11:59:59	74	3.1%	0.02	235.0 KB	2.2%	0.07
Aug 15 12:00:00 - 12:59:59	89	3.7%	0.02	316.1 KB	2.9%	0.09
Aug 15 13:00:00 - 13:59:59	96	4.0%	0.03	384.6 KB	3.6%	0.11
Aug 15 14:00:00 - 14:59:59	115	4.8%	0.03	481.2 KB	4.5%	0.13
Aug 15 15:00:00 - 15:59:59	97	4.0%	0.03	394.9 KB	3.7%	0.11
Aug 15 16:00:00 - 16:59:59	92	3.8%	0.03	270.2 KB	2.5%	0.08
Aug 15 17:00:00 - 17:59:59	174	7.2%	0.05	1.2 MB	11.8%	0.35
Aug 15 18:00:00 - 18:59:59	174	7.2%	0.05	809.2 KB	7.5%	0.22
Aug 15 19:00:00 - 19:59:59	144	6.0%	0.04	527.0 KB	4.9%	0.15
Aug 15 20:00:00 - 20:59:59	81	3.3%	0.02	280.2 KB	2.6%	0.08
Aug 15 21:00:00 - 21:59:59	118	4.9%	0.03	486.8 KB	4.5%	0.14
Aug 15 22:00:00 - 22:59:59	129	5.3%	0.04	597.2 KB	5.6%	0.17
Aug 15 23:00:00 - 23:59:59	155	6.4%	0.04	548.7 KB	5.1%	0.15
Aug 16 00:00:00 - 00:59:59	100	4.1%	0.03	934.8 KB	8.7%	0.26
Aug 16 01:00:00 - 01:59:59	91	3.8%	0.03	325.2 KB	3.0%	0.09
Aug 16 02:00:00 - 02:59:59	119	4.9%	0.03	503.4 KB	4.7%	0.14
Aug 16 03:00:00 - 03:59:59	62	2.6%	0.02	259.9 KB	2.4%	0.07
Aug 16 04:00:00 - 04:15:01	17	0.7%	0.02	40.6 KB	0.4%	0.05
TOTAL: 24:00:00	2419	100.0%	0.03	10.5 MB	100.0%	0.12

Sites sending bad articles:

Server		Total	Other
1	news.glou.org	82	82
2	gegeweb-out.news.tnetconsulting.net	29	29
3	usenet.pasdenom.info	28	28
4	i2pn.org	18	18
5	nntp.terraraq.uk	4	4
TOTAL: 5		161	161

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	67
EMP (md5)	43
Bad path (news.giganews.com.POSTED)	33
Cancels abusifs	3
Cancel of <625396609264540933c7ca851d72b5ea943830d9@i2pn2.org> without Cancel-Key	1
Cancel for rejected article	1
Cancel of <MPG.41289d84e83ca7f198a50c@news.individual.net> without Cancel-Key	1
Cancel of <536729fb51f2711701a9026a2ea4af4a410561af@i2pn2.org> without Cancel-Key	1
Cancel of <6edd7e9bfe20c943f93688fb4c428500aa2e929e@i2pn2.org> without Cancel-Key	1
Cancel of <li5ikrFlmjdU1@mid.individual.net> without Cancel-Key	1
Cancel of <80432b7e396e2e6294cb90f83e518b069f8ac2e1@i2pn2.org> without Cancel-Key	1
Cancel of <46d9beff5765b80f173ab4a95c162fb12d5d7060@i2pn2.org> without Cancel-Key	1
Cancel of <0d7079d792a6a2be5395a192b8895b7268b5f645@i2pn2.org> without Cancel-Key	1
Cancel of <c66607328eb5440018fc549df5679cde02a63626@i2pn2.org> without Cancel-Key	1
Cancel of <1ff43cfd168243c0350fa4e3a0aaa0fb39c3c101@i2pn2.org> without Cancel-Key	1
Cancel of <li6faiFpratU1@mid.individual.net> without Cancel-Key	1
Cancel of <li6f2tFpq4dU1@mid.individual.net> without Cancel-Key	1
Cancel of <c0bea02802466a72330764b4e476ca862f4cd633@i2pn2.org> without Cancel-Key	1
Cancel of <fb21de67865613b7ce55bfa45abc0c44e17d9972@i2pn2.org> without Cancel-Key	1
TOTAL: 19	161

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.gegeweb.org	1003	141	805	0	11	14%	23:36:29
2	i2pn.org	3671	135	2117	14	75	3%	23:59:57
3	news.samoylyk.net	2935	11	2542	13	2373	0%	23:54:03
4	news.tnetconsulting.net	3788	11	2398	5	28	0%	23:57:30
5	nntp.terraraq.uk	1403	2	1383	0	0	0%	23:58:35
6	news.pasdenom.info	1919	1	1750	0	0	0%	23:59:57
7	news.nntp4.net	18728005	0	0	0	18680252	0%	23:59:56
8	news.aioe.org	0	0	0	0	1997	0%	24:00:00
TOTAL: 8		18742724	301	10995	32	18684736	0%	191:26:27

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	509.1 KB	0.0 KB	509.1 KB	3.6 KB	23:36:29
2	i2pn.org	356.2 KB	130.0 KB	486.2 KB	3.3 KB	23:59:57
3	news.samoylyk.net	40.6 KB	53.3 KB	93.9 KB	3.9 KB	23:54:03
4	news.pasdenom.info	32.2 KB	0.0 KB	32.2 KB	32.2 KB	23:59:57
5	news.tnetconsulting.net	21.9 KB	18.5 KB	40.4 KB	2.5 KB	23:57:30
6	nntp.terraraq.uk	4.5 KB	0.0 KB	4.5 KB	2.3 KB	23:58:35
7	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:56
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
TOTAL: 8		964.5 KB	201.8 KB	1.1 MB	3.5 KB	191:26:27

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	69.10.48.174	30	5682	12.2 MB	123	0	0	00:17:57
TOTAL: 1		30	5682	12.2 MB	123	0	0	00:20:21

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	38	5682	12.2 MB	123	00:18:24
2	*.stretchoid.com	1	0	0.0 KB	0	00:00:00
3	*.gegeweb.eu	288	0	0.0 KB	0	00:01:45
4	*.monitoring.internet-measurement.com	5	0	0.0 KB	0	00:00:08
5	*.211.203.35.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:01
6	*.210.203.35.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:00
TOTAL: 6		334	5682	12.2 MB	123	00:20:21

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
69.10.48.174	1.803	2.918	0.000	00:17:57
mail.gegeweb.eu	4.708	3.912	1.604	00:01:45
205.210.31.158	0.006	0.016	0.000	00:00:11
147.185.132.228	0.005	0.018	0.000	00:00:10
glamorous.monitoring.internet-measurement.com	0.065	0.019	0.000	00:00:05
cheerful.monitoring.internet-measurement.com	0.015	0.007	0.000	00:00:03
206.168.34.207	0.030	0.030	0.000	00:00:01
99.211.203.35.bc.googleusercontent.com	0.060	0.019	0.000	00:00:01
88.214.25.65	0.013	0.010	0.000	00:00:01
185.242.226.41	0.023	0.027	0.000	00:00:00
190.210.203.35.bc.googleusercontent.com	0.047	0.032	0.000	00:00:00
91.238.181.22	0.029	0.025	0.000	00:00:00
91.238.181.32	0.014	0.009	0.000	00:00:00
194.165.16.10	0.023	0.005	0.000	00:00:00
azpdcg58.stretchoid.com	0.017	0.004	0.000	00:00:00
evocative.monitoring.internet-measurement.com	0.014	0.014	0.000	00:00:00
legendary.monitoring.internet-measurement.com	0.041	0.021	0.000	00:00:00
passionate.monitoring.internet-measurement.com	0.038	0.017	0.000	00:00:00
TOTAL: 18	6.951	7.103	1.604	00:20:21

Curious NNRP server explorers [Top 20]:

System	Conn
mail.gegeweb.eu	288
passionate.monitoring.internet-measurement.com	1
legendary.monitoring.internet-measurement.com	1
194.165.16.10	1
190.210.203.35.bc.googleusercontent.com	1
205.210.31.158	1
azpdcg58.stretchoid.com	1
88.214.25.65	1
99.211.203.35.bc.googleusercontent.com	1
91.238.181.22	1
evocative.monitoring.internet-measurement.com	1
147.185.132.228	1
206.168.34.207	1
cheerful.monitoring.internet-measurement.com	1
91.238.181.32	1
185.242.226.41	1
glamorous.monitoring.internet-measurement.com	1
TOTAL: 17	304

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
185.242.226.41	5
190.210.203.35.bc.googleusercontent.com	4
99.211.203.35.bc.googleusercontent.com	4
91.238.181.32	1
206.168.34.207	1
88.214.25.65	1
azpdcg58.stretchoid.com	1
TOTAL: 7	17

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	3
Accept-Encoding: gzip	3
Host: 45.13.105.36:563	2
User-Agent: Expanse, a Palo Alto Network...	2
#003	2
Accept: /	1
MGLNDD_45.13.105.36_119	1
Host: 45.13.105.36:119	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
EHLO www.censys.io	1
TOTAL: 10	17

NNRP client timeouts [Top 20]:

System	Conn	Peer
91.238.181.32	1	1
88.214.25.65	1	1
TOTAL: 2	2	2

Newsgroup request counts (by category):

Category		Count	Pct
1	grisbi	5391	94.9%
2	local	291	5.1%
TOTAL: 2		5682	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	grisbi.bugsreports	4088
2	grisbi.devel	410
3	grisbi.user.french	299
4	grisbi.test	299
5	grisbi.cvs	192
6	local.test	167
7	local.gegeweb.support	124
8	grisbi.user	99
9	grisbi.admin	4
TOTAL: 9		5682

Daily Usenet report for news.niel.me

Aug 15 04:15:01 -- Aug 16 04:15:01