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

Unknown entries from news log file:

First 50 / 12040 lines (0.4%)

Nov 29 12:44:26 rpi-studio nnrpd[1555]: server.samoylyk.net noperm ihave without permission
Nov 29 12:44:32 rpi-studio nnrpd[1556]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:44:41 rpi-studio nnrpd[1557]: server.samoylyk.net noperm ihave without permission
Nov 29 12:44:56 rpi-studio nnrpd[1563]: server.samoylyk.net noperm ihave without permission
Nov 29 12:45:02 rpi-studio nnrpd[1571]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:45:06 rpi-studio nnrpd[1572]: i2pn.org noperm ihave without permission
Nov 29 12:45:11 rpi-studio nnrpd[1574]: server.samoylyk.net noperm ihave without permission
Nov 29 12:45:26 rpi-studio nnrpd[1577]: server.samoylyk.net noperm ihave without permission
Nov 29 12:45:27 rpi-studio nnrpd[1576]: tncsrv06.tnetconsulting.net noperm ihave without permission
Nov 29 12:45:28 rpi-studio nnrpd[1575]: news.glou.org noperm ihave without permission
Nov 29 12:45:28 rpi-studio nnrpd[1578]: news.nntp4.net noperm ihave without permission
Nov 29 12:45:32 rpi-studio nnrpd[1579]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:45:37 rpi-studio nnrpd[1580]: i2pn.org noperm ihave without permission
Nov 29 12:45:41 rpi-studio nnrpd[1581]: server.samoylyk.net noperm ihave without permission
Nov 29 12:45:56 rpi-studio nnrpd[1582]: server.samoylyk.net noperm ihave without permission
Nov 29 12:45:57 rpi-studio nnrpd[1583]: tncsrv06.tnetconsulting.net noperm ihave without permission
Nov 29 12:45:58 rpi-studio nnrpd[1584]: news.glou.org noperm ihave without permission
Nov 29 12:45:58 rpi-studio nnrpd[1585]: news.nntp4.net noperm ihave without permission
Nov 29 12:46:02 rpi-studio nnrpd[1588]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:46:07 rpi-studio nnrpd[1589]: i2pn.org noperm ihave without permission
Nov 29 12:46:11 rpi-studio nnrpd[1591]: server.samoylyk.net noperm ihave without permission
Nov 29 12:46:26 rpi-studio nnrpd[1592]: server.samoylyk.net noperm ihave without permission
Nov 29 12:46:28 rpi-studio nnrpd[1593]: tncsrv06.tnetconsulting.net noperm ihave without permission
Nov 29 12:46:28 rpi-studio nnrpd[1594]: news.glou.org noperm ihave without permission
Nov 29 12:46:28 rpi-studio nnrpd[1595]: news.nntp4.net noperm ihave without permission
Nov 29 12:46:32 rpi-studio nnrpd[1596]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:46:38 rpi-studio nnrpd[1597]: i2pn.org noperm ihave without permission
Nov 29 12:46:41 rpi-studio nnrpd[1598]: server.samoylyk.net noperm ihave without permission
Nov 29 12:46:56 rpi-studio nnrpd[1599]: server.samoylyk.net noperm ihave without permission
Nov 29 12:46:58 rpi-studio nnrpd[1600]: tncsrv06.tnetconsulting.net noperm ihave without permission
Nov 29 12:46:58 rpi-studio nnrpd[1601]: news.glou.org noperm ihave without permission
Nov 29 12:46:59 rpi-studio nnrpd[1602]: news.nntp4.net noperm ihave without permission
Nov 29 12:47:02 rpi-studio nnrpd[1608]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:47:08 rpi-studio nnrpd[1610]: i2pn.org noperm ihave without permission
Nov 29 12:47:11 rpi-studio nnrpd[1611]: server.samoylyk.net noperm ihave without permission
Nov 29 12:47:26 rpi-studio nnrpd[1613]: server.samoylyk.net noperm ihave without permission
Nov 29 12:47:28 rpi-studio nnrpd[1614]: news.glou.org noperm ihave without permission
Nov 29 12:47:28 rpi-studio nnrpd[1615]: tncsrv06.tnetconsulting.net noperm ihave without permission
Nov 29 12:47:29 rpi-studio nnrpd[1617]: news.nntp4.net noperm ihave without permission
Nov 29 12:47:32 rpi-studio nnrpd[1630]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:47:39 rpi-studio nnrpd[1643]: i2pn.org noperm ihave without permission
Nov 29 12:47:42 rpi-studio nnrpd[1644]: server.samoylyk.net noperm ihave without permission
Nov 29 12:47:57 rpi-studio nnrpd[1645]: server.samoylyk.net noperm ihave without permission
Nov 29 12:47:58 rpi-studio nnrpd[1646]: tncsrv06.tnetconsulting.net noperm ihave without permission
Nov 29 12:47:58 rpi-studio nnrpd[1647]: news.glou.org noperm ihave without permission
Nov 29 12:48:00 rpi-studio nnrpd[1649]: news.nntp4.net noperm ihave without permission
Nov 29 12:48:02 rpi-studio nnrpd[1652]: nntp.terraraq.uk noperm ihave without permission
Nov 29 12:48:09 rpi-studio nnrpd[1654]: i2pn.org noperm ihave without permission
Nov 29 12:48:12 rpi-studio nnrpd[1655]: server.samoylyk.net noperm ihave without permission
Nov 29 12:48:27 rpi-studio nnrpd[1656]: server.samoylyk.net noperm ihave without permission

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	54863	87.0%	5.5 MB	79.7%
inn	4289	6.8%	799.0 KB	11.3%
innd	1968	3.1%	304.0 KB	4.3%
innfeed	1958	3.1%	324.6 KB	4.6%
controlchan	8	0.0%	0.9 KB	0.0%
nocem	5	0.0%	0.6 KB	0.0%
TOTAL: 6	63091	100.0%	6.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	25383	64.1%
Negative hits	7788	19.7%
Do not exist	4252	10.7%
Cache misses	2183	5.5%
TOTAL: 4	39606	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.031	0.0%	17	1.000	1.824	3.000
article cancel	00:00:00.002	0.0%	17	0.000	0.118	1.000
article cleanup	00:00:00.128	0.0%	4255	0.000	0.030	0.139
article logging	00:00:00.332	0.0%	4268	0.000	0.078	0.300
article parse	00:00:00.634	0.0%	8537	0.000	0.074	0.278
article write	00:00:10.499	0.0%	3849	0.250	2.728	27.383
artlog/artcncl	00:00:00.000	0.0%	17	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	17	0.000	0.000	0.000
data move	00:00:00.103	0.0%	27764	0.000	0.004	0.031
hisgrep/artcncl	00:00:00.001	0.0%	17	0.000	0.059	0.167
hisgrep/artcncl/perl	00:00:00.001	0.0%	17	0.000	0.059	1.000
hisgrep/perl	00:00:00.005	0.0%	19	0.000	0.263	3.000
hishave/artcncl	00:00:00.000	0.0%	17	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	17	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:05.546	0.0%	39607	0.000	0.140	13.409
history sync	00:00:00.056	0.0%	390	0.000	0.144	1.000
history write	00:00:02.460	0.0%	4255	0.000	0.578	1.517
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:16:08.917	99.9%	52974	142.806	1649.279	796336.000
nntp read	00:00:00.968	0.0%	28457	0.000	0.034	0.128
overview write	00:00:02.605	0.0%	3849	0.067	0.677	7.043
perl filter	00:00:19.350	0.0%	4255	2.705	4.548	11.368
python filter	00:00:00.028	0.0%	4255	0.000	0.007	0.077
site send	00:00:01.448	0.0%	7783	0.000	0.186	0.528
TOTAL: 24:17:40.046	24:16:53.114	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.046	0.0%	4101	0.000	0.011	0.154
article prepare	00:00:00.000	0.0%	144	0.000	0.000	0.000
article read	00:00:00.015	0.0%	27	0.000	0.556	6.000
backlog stats	00:00:00.108	0.0%	52421	0.000	0.002	0.015
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.675	0.0%	32170	0.000	0.021	0.058
data write	00:00:01.726	0.0%	28831	0.000	0.060	0.130
idle	24:03:20.836	100.0%	52421	418.089	1652.026	528826.000
status file	00:00:00.889	0.0%	218	1.000	4.078	12.462
TOTAL: 24:03:36.581	24:03:24.295	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:32:55.190	77.3%	37560	11.600	52.588	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.470	0.1%	75407	0.000	0.033	0.500
TOTAL: 00:42:35.422	00:32:57.660	77.4%	-	-	-	-

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
rmgroup	3
TOTAL: 12	174

Newsgroups removed:

Group
fr.education.entraide.physique-chimie
fr.education.francais.langue-etrangere
fr.education.superieur
TOTAL: 3

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
control@usenet-fr.news.eu.org	0	3	0	0	3	3
TOTAL	0	3	0	0	3	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	46.165.242.75	2	2726	2052	526	148	75%	13:56:43
2	2001:41d0:2:abb2::119	6	1906	570	1336	0	29%	14:15:55
3	news-out.aioe.org	1	981	343	557	81	34%	08:26:55
4	i2pn.org	3	1074	224	812	38	20%	09:09:28
5	news.nntp4.net	3	2988	143	2787	58	4%	01:14:45
6	news.glou.org	3	3018	141	2871	6	4%	06:10:21
7	usenet.pasdenom.info	2	2411	130	2276	5	5%	23:59:52
8	nntp.terraraq.uk	3	3202	83	3109	10	2%	24:02:51
9	gegeweb-out.news.tnetconsulting.net	2	2359	25	2334	0	1%	17:53:04
10	news.samoylyk.net	3	306	0	306	0	0%	03:08:11
11	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 11		53	20971	3711	16914	346	17%	122:18:05

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	46.165.242.75	7.1 MB	573.9 KB	7.6 MB	92%	3.6 KB
2	2001:41d0:2:abb2::119	2.3 MB	0.0 KB	2.3 MB	100%	4.0 KB
3	news-out.aioe.org	1.1 MB	278.3 KB	1.4 MB	79%	3.3 KB
4	i2pn.org	716.3 KB	85.9 KB	802.2 KB	89%	3.1 KB
5	news.glou.org	650.4 KB	57.1 KB	707.4 KB	91%	4.8 KB
6	nntp.terraraq.uk	340.7 KB	25.4 KB	366.1 KB	93%	3.9 KB
7	usenet.pasdenom.info	310.1 KB	8.2 KB	318.4 KB	97%	2.4 KB
8	news.nntp4.net	285.8 KB	159.6 KB	445.3 KB	64%	2.2 KB
9	gegeweb-out.news.tnetconsulting.net	68.4 KB	0.0 KB	68.4 KB	100%	2.7 KB
10	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0%	0
11	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 11		12.7 MB	1.2 MB	13.9 MB	91%	3.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 29 04:15:01 - 04:59:59	50	1.3%	0.02	289.8 KB	2.0%	0.11
Nov 29 05:00:00 - 05:59:59	74	1.9%	0.02	260.5 KB	1.8%	0.07
Nov 29 06:00:00 - 06:59:59	83	2.2%	0.02	234.2 KB	1.6%	0.07
Nov 29 07:00:00 - 07:59:59	110	2.9%	0.03	293.2 KB	2.0%	0.08
Nov 29 08:00:00 - 08:59:59	88	2.3%	0.02	228.9 KB	1.6%	0.06
Nov 29 09:00:00 - 09:59:59	114	3.0%	0.03	505.8 KB	3.5%	0.14
Nov 29 10:00:00 - 10:59:59	174	4.5%	0.05	521.4 KB	3.6%	0.14
Nov 29 11:00:00 - 11:59:59	138	3.6%	0.04	990.2 KB	6.8%	0.28
Nov 29 12:00:00 - 12:59:59	88	2.3%	0.02	285.2 KB	2.0%	0.08
Nov 29 13:00:00 - 13:59:59	149	3.9%	0.04	497.3 KB	3.4%	0.14
Nov 29 14:00:00 - 14:59:59	157	4.1%	0.04	544.7 KB	3.7%	0.15
Nov 29 15:00:00 - 15:59:59	159	4.1%	0.04	681.1 KB	4.7%	0.19
Nov 29 16:00:00 - 16:59:59	212	5.5%	0.06	695.7 KB	4.8%	0.19
Nov 29 17:00:00 - 17:59:59	245	6.4%	0.07	764.8 KB	5.2%	0.21
Nov 29 18:00:00 - 18:59:59	227	5.9%	0.06	699.2 KB	4.8%	0.19
Nov 29 19:00:00 - 19:59:59	183	4.8%	0.05	861.8 KB	5.9%	0.24
Nov 29 20:00:00 - 20:59:59	238	6.2%	0.07	923.3 KB	6.3%	0.26
Nov 29 21:00:00 - 21:59:59	197	5.1%	0.05	682.9 KB	4.7%	0.19
Nov 29 22:00:00 - 22:59:59	246	6.4%	0.07	1.0 MB	7.0%	0.28
Nov 29 23:00:00 - 23:59:59	171	4.5%	0.05	634.0 KB	4.3%	0.18
Nov 30 00:00:00 - 00:59:59	191	5.0%	0.05	630.7 KB	4.3%	0.18
Nov 30 01:00:00 - 01:59:59	127	3.3%	0.04	408.6 KB	2.8%	0.11
Nov 30 02:00:00 - 02:59:59	104	2.7%	0.03	447.0 KB	3.1%	0.12
Nov 30 03:00:00 - 03:59:59	286	7.5%	0.08	1.4 MB	9.5%	0.39
Nov 30 04:00:00 - 04:15:01	25	0.7%	0.03	116.9 KB	0.8%	0.13
TOTAL: 24:00:00	3836	100.0%	0.04	14.3 MB	100.0%	0.17

Sites sending bad articles:

Server		Total	Group	Other
1	46.165.242.75	162	3	159
2	news-out.aioe.org	84	1	83
3	news.nntp4.net	80	0	80
4	i2pn.org	53	0	53
5	news.glou.org	26	0	26
6	news.samoylyk.net	10	0	10
7	2001:41d0:2:abb2::119	1	0	1
8	feed-out.gegeweb.org	1	0	1
9	usenet.pasdenom.info	1	0	1
10	nntp.terraraq.uk	1	0	1
TOTAL: 10		419	4	415

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	1
soc.culture.uk	1
fr.petites-annonces.divers	1
news.test	1
TOTAL: 4	4

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	151
Bad path (news.giganews.com.POSTED)	146
EMP (phl)	75
EMP (phn path)	11
EMP (phn nph)	8
Too many newsgroups	7
Cancels abusifs	2
Cancel of non-existing ID <4c982562-6787-49fb-b37f-250dba205229n@googlegroups.com>	1
Cancel of non-existing ID <d7676379-daa2-4470-a826-5a501402ee89n@googlegroups.com>	1
TOTAL: 9	402

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	46.165.242.75	10
	news-out.aioe.org	2
	2001:41d0:2:abb2::119	1
	TOTAL: 3	13
TOTAL: 1		13

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	4985	8	2955	0	127	0%	24:17:41
2	news.nntp4.net	3833	6	3586	0	10	0%	24:17:42
3	news.tnetconsulting.net	5917	6	3838	1	123	0%	24:17:41
4	nntp.terraraq.uk	2785	6	2461	6	3	0%	24:17:42
5	news.samoylyk.net	4314	2	3834	0	14	0%	24:17:42
6	news.gegeweb.org	3202	1	3149	0	0	0%	24:17:42
7	news.pasdenom.info	3440	0	3174	0	6	0%	24:17:09
8	news.aioe.org	1138	0	1058	0	3	0%	24:04:04
TOTAL: 8		29614	29	24055	7	286	0%	194:07:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	156.0 KB	0.0 KB	156.0 KB	26.0 KB	24:17:42
2	nntp.terraraq.uk	26.2 KB	584.6 KB	610.8 KB	50.9 KB	24:17:42
3	i2pn.org	24.1 KB	0.0 KB	24.1 KB	3.0 KB	24:17:41
4	news.tnetconsulting.net	20.4 KB	4.2 KB	24.6 KB	3.5 KB	24:17:41
5	news.samoylyk.net	7.9 KB	0.0 KB	7.9 KB	4.0 KB	24:17:42
6	news.gegeweb.org	1.9 KB	0.0 KB	1.9 KB	1.9 KB	24:17:42
7	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	24:17:09
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:04:04
TOTAL: 8		236.6 KB	588.8 KB	825.4 KB	22.9 KB	194:07:23

NNRP readership statistics:

System		Conn	Elapsed
1	tncsrv06.tnetconsulting.net	1682	00:11:36
2	soulful.monitoring.internet-measurement.com	1	00:00:01
3	104.152.52.244	1	00:00:10
4	mail.gegeweb.eu	287	00:00:44
5	i2pn.org	1694	00:08:28
6	104.152.52.124	1	00:00:00
7	2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4	173	00:00:20
8	news.nntp4.net	1700	00:05:38
9	92.255.85.231	1	00:00:00
10	server.samoylyk.net	3378	00:09:18
11	news.glou.org	1706	00:02:26
12	nntp.terraraq.uk	1707	00:03:30
TOTAL: 12		12331	00:42:16

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	287	00:00:44
2	unresolved	3	00:00:10
3	*.tnetconsulting.net	1682	00:11:36
4	*.glou.org	1706	00:02:26
5	*.samoylyk.net	3378	00:09:18
6	*.monitoring.internet-measurement.com	1	00:00:01
7	*.nntp4.net	1700	00:05:38
8	*.terraraq.uk	1707	00:03:30
9	?	173	00:00:20
10	*.org	1694	00:08:28
TOTAL: 10		12331	00:42:16

NNRP auth users [Top 20]:

User	Conn
mailman	287
TOTAL: 1	287

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tncsrv06.tnetconsulting.net	44.221	38.591	0.000	00:11:36
server.samoylyk.net	89.637	76.437	0.000	00:09:18
i2pn.org	45.053	37.925	0.000	00:08:28
news.nntp4.net	45.650	39.241	0.000	00:05:38
nntp.terraraq.uk	45.814	39.363	0.000	00:03:30
news.glou.org	44.659	39.474	0.000	00:02:26
mail.gegeweb.eu	7.713	7.736	2.393	00:00:44
2a01:e0a:21:ea80:e65f:1ff:fe14:e7a4	4.603	4.323	0.000	00:00:20
104.152.52.244	0.031	0.021	0.000	00:00:10
soulful.monitoring.internet-measurement.com	0.032	0.021	0.000	00:00:01
92.255.85.231	0.027	0.027	0.000	00:00:00
104.152.52.124	0.032	0.021	0.000	00:00:00
TOTAL: 12	327.472	283.180	2.393	00:42:16

NNRP unrecognized commands (by host):

System	Conn
92.255.85.231	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
#003	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
92.255.85.231	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Nov 29 04:15:01 -- Nov 30 04:15:01