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

Unknown entries from news log file:

First 50 / 1491 lines (3.4%)

Nov 6 15:44:19 rpi-studio nnrpd[5102]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:44:54 rpi-studio nnrpd[5112]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:45:25 rpi-studio nnrpd[5134]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:45:55 rpi-studio nnrpd[5150]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:46:25 rpi-studio nnrpd[5154]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:46:55 rpi-studio nnrpd[5157]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:47:25 rpi-studio nnrpd[5164]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:47:56 rpi-studio nnrpd[5167]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:48:26 rpi-studio nnrpd[5312]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:48:56 rpi-studio nnrpd[5332]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:49:26 rpi-studio nnrpd[5343]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:49:56 rpi-studio nnrpd[5346]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:50:28 rpi-studio nnrpd[5352]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:50:58 rpi-studio nnrpd[5361]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:51:28 rpi-studio nnrpd[5366]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:51:58 rpi-studio nnrpd[5379]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:52:28 rpi-studio nnrpd[5389]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:52:58 rpi-studio nnrpd[5392]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:53:28 rpi-studio nnrpd[5396]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:53:58 rpi-studio nnrpd[5413]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:54:28 rpi-studio nnrpd[5428]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:54:59 rpi-studio nnrpd[5453]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:55:29 rpi-studio nnrpd[5462]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:55:59 rpi-studio nnrpd[5465]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:56:30 rpi-studio nnrpd[5486]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:57:00 rpi-studio nnrpd[5490]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:57:31 rpi-studio nnrpd[5495]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:58:02 rpi-studio nnrpd[5501]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:58:33 rpi-studio nnrpd[5644]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:59:03 rpi-studio nnrpd[5661]: mx.terraraq.uk noperm ihave without permission
Nov 6 15:59:33 rpi-studio nnrpd[5669]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:00:03 rpi-studio nnrpd[5685]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:00:33 rpi-studio nnrpd[5692]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:01:03 rpi-studio nnrpd[5700]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:01:33 rpi-studio nnrpd[5703]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:02:03 rpi-studio nnrpd[5715]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:02:33 rpi-studio nnrpd[5718]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:03:03 rpi-studio nnrpd[5724]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:03:33 rpi-studio nnrpd[5743]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:04:03 rpi-studio nnrpd[5749]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:04:33 rpi-studio nnrpd[5756]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:05:04 rpi-studio nnrpd[5776]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:05:35 rpi-studio nnrpd[5779]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:06:05 rpi-studio nnrpd[5803]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:06:35 rpi-studio nnrpd[5818]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:07:06 rpi-studio nnrpd[5822]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:07:36 rpi-studio nnrpd[5827]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:08:06 rpi-studio nnrpd[5836]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:08:36 rpi-studio nnrpd[5992]: mx.terraraq.uk noperm ihave without permission
Nov 6 16:09:06 rpi-studio nnrpd[5996]: mx.terraraq.uk noperm ihave without permission

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	7410	47.3%	749.1 KB	33.9%
inn	4126	26.3%	782.6 KB	35.4%
innd	2398	15.3%	395.4 KB	17.9%
innfeed	1736	11.1%	284.4 KB	12.9%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	15672	100.0%	2.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	24311	63.2%
Negative hits	10091	26.2%
Do not exist	4046	10.5%
Cache misses	5	0.0%
TOTAL: 4	38453	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.036	0.0%	19	0.000	1.895	7.000
article cancel	00:00:00.005	0.0%	19	0.000	0.263	1.000
article cleanup	00:00:00.115	0.0%	4054	0.000	0.028	0.150
article logging	00:00:00.305	0.0%	4083	0.000	0.075	0.280
article parse	00:00:00.795	0.0%	9498	0.000	0.084	0.364
article write	00:00:02.236	0.0%	3649	0.000	0.613	2.105
artlog/artcncl	00:00:00.000	0.0%	19	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	19	0.000	0.105	1.000
data move	00:00:00.132	0.0%	43459	0.000	0.003	0.022
hisgrep/artcncl	00:00:00.001	0.0%	19	0.000	0.053	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	19	0.000	0.053	0.250
hishave/artcncl	00:00:00.001	0.0%	19	0.000	0.053	1.000
hishave/artcncl/perl	00:00:00.000	0.0%	19	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.483	0.0%	38506	0.000	0.013	0.039
history sync	00:00:00.055	0.0%	401	0.000	0.137	1.000
history write	00:00:00.980	0.0%	4054	0.000	0.242	3.294
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:15.537	99.9%	45927	731.271	1881.585	11544.577
nntp read	00:00:01.488	0.0%	43240	0.000	0.034	0.069
overview write	00:00:02.487	0.0%	3649	0.000	0.682	7.125
perl filter	00:00:21.700	0.0%	4054	2.933	5.353	17.150
python filter	00:00:00.004	0.0%	4054	0.000	0.001	0.028
site send	00:00:01.418	0.0%	7385	0.000	0.192	0.500
TOTAL: 24:01:10.512	24:00:47.781	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	3714	0.000	0.011	0.105
article prepare	00:00:00.002	0.0%	512	0.000	0.004	0.250
article read	00:00:00.016	0.0%	82	0.000	0.195	7.000
backlog stats	00:00:00.121	0.0%	56081	0.000	0.002	0.009
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.701	0.0%	33512	0.000	0.021	0.079
data write	00:00:01.936	0.0%	30005	0.026	0.065	0.117
idle	23:49:52.978	100.0%	56081	690.709	1529.805	5460.736
status file	00:00:00.590	0.0%	190	1.000	3.105	14.000
TOTAL: 23:49:59.508	23:49:56.385	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:02:37.119	52.4%	5915	11.400	26.563	4558.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.325	0.1%	12118	0.000	0.027	0.333
TOTAL: 00:05:00.051	00:02:37.444	52.5%	-	-	-	-

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	1	3251	1380	1848	23	42%	20:42:55
2	i2pn.org	1	3427	897	2388	142	26%	22:39:22
3	news.glou.org	2	4048	669	3351	28	16%	29:12:21
4	feed-out.gegeweb.org	3	2500	181	2319	0	7%	22:47:08
5	news.nntp4.net	1	3745	144	3486	115	3%	24:34:30
6	usenet.pasdenom.info	2	2276	114	2161	1	5%	23:58:39
7	nntp.terraraq.uk	1	3051	46	3005	0	1%	24:12:47
8	news.samoylyk.net	2	3569	13	3556	0	0%	22:43:08
9	gegeweb-out.news.tnetconsulting.net	1	624	8	616	0	1%	07:10:41
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		39	26491	3452	22730	309	13%	198:01:31

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.glou.org	6.3 MB	78.7 KB	6.3 MB	98%	9.3 KB
2	news-out.aioe.org	4.3 MB	56.2 KB	4.4 MB	98%	3.2 KB
3	i2pn.org	2.8 MB	347.9 KB	3.1 MB	89%	3.1 KB
4	news.nntp4.net	1.6 MB	530.3 KB	2.1 MB	75%	8.3 KB
5	feed-out.gegeweb.org	549.7 KB	0.0 KB	549.7 KB	100%	3.0 KB
6	gegeweb-out.news.tnetconsulting.net	478.8 KB	0.0 KB	478.8 KB	100%	59.8 KB
7	news.samoylyk.net	324.5 KB	0.0 KB	324.5 KB	100%	25.0 KB
8	usenet.pasdenom.info	309.6 KB	1.1 KB	310.7 KB	99%	2.7 KB
9	nntp.terraraq.uk	109.4 KB	0.0 KB	109.4 KB	100%	2.4 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		16.7 MB	1014.2 KB	17.7 MB	94%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 6 04:15:01 - 04:59:59	66	1.8%	0.02	1.6 MB	8.8%	0.61
Nov 6 05:00:00 - 05:59:59	92	2.5%	0.03	734.1 KB	3.9%	0.20
Nov 6 06:00:00 - 06:59:59	87	2.4%	0.02	319.3 KB	1.7%	0.09
Nov 6 07:00:00 - 07:59:59	61	1.7%	0.02	234.0 KB	1.3%	0.07
Nov 6 08:00:00 - 08:59:59	79	2.2%	0.02	266.4 KB	1.4%	0.07
Nov 6 09:00:00 - 09:59:59	97	2.7%	0.03	1.2 MB	6.4%	0.33
Nov 6 10:00:00 - 10:59:59	109	3.0%	0.03	292.8 KB	1.6%	0.08
Nov 6 11:00:00 - 11:59:59	89	2.4%	0.02	263.6 KB	1.4%	0.07
Nov 6 12:00:00 - 12:59:59	120	3.3%	0.03	402.1 KB	2.2%	0.11
Nov 6 13:00:00 - 13:59:59	97	2.7%	0.03	1.1 MB	6.3%	0.32
Nov 6 14:00:00 - 14:59:59	187	5.1%	0.05	591.8 KB	3.2%	0.16
Nov 6 15:00:00 - 15:59:59	172	4.7%	0.05	492.9 KB	2.6%	0.14
Nov 6 16:00:00 - 16:59:59	177	4.8%	0.05	633.2 KB	3.4%	0.18
Nov 6 17:00:00 - 17:59:59	242	6.6%	0.07	1.1 MB	6.0%	0.31
Nov 6 18:00:00 - 18:59:59	221	6.0%	0.06	725.7 KB	3.9%	0.20
Nov 6 19:00:00 - 19:59:59	221	6.0%	0.06	732.9 KB	3.9%	0.20
Nov 6 20:00:00 - 20:59:59	301	8.2%	0.08	1.0 MB	5.6%	0.29
Nov 6 21:00:00 - 21:59:59	242	6.6%	0.07	761.7 KB	4.1%	0.21
Nov 6 22:00:00 - 22:59:59	203	5.6%	0.06	1.0 MB	5.7%	0.30
Nov 6 23:00:00 - 23:59:59	194	5.3%	0.05	662.7 KB	3.5%	0.18
Nov 7 00:00:00 - 00:59:59	245	6.7%	0.07	1.5 MB	8.2%	0.42
Nov 7 01:00:00 - 01:59:59	137	3.8%	0.04	578.4 KB	3.1%	0.16
Nov 7 02:00:00 - 02:59:59	85	2.3%	0.02	458.0 KB	2.5%	0.13
Nov 7 03:00:00 - 03:59:59	83	2.3%	0.02	696.7 KB	3.7%	0.19
Nov 7 04:00:00 - 04:15:01	46	1.3%	0.05	1.0 MB	5.7%	1.19
TOTAL: 24:00:00	3653	100.0%	0.04	18.2 MB	100.0%	0.22

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	185	0	185
2	i2pn.org	155	0	155
3	news-out.aioe.org	62	1	61
4	news.glou.org	22	0	22
5	news.samoylyk.net	5	0	5
6	gegeweb-out.news.tnetconsulting.net	3	0	3
7	usenet.pasdenom.info	3	0	3
TOTAL: 7		435	1	434

Unwanted newsgroups [Top 20]:

Newsgroup	Count
news.test	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	156
EMP (phn path)	87
Bad path (news.giganews.com.POSTED)	80
Too many newsgroups	33
EMP (md5)	25
EMP (phn nph)	16
HTML Multipart	5
Cancels abusifs	2
TOTAL: 8	404

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	20
	news.samoylyk.net	5
	news.nntp4.net	5
	TOTAL: 3	30
TOTAL: 1		30

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	3949	36	3445	0	0	0%	23:59:51
2	i2pn.org	4702	19	2622	7	43	0%	23:59:56
3	nntp.terraraq.uk	2962	16	2507	34	1	0%	23:59:56
4	news.aioe.org	1681	9	1424	1	0	0%	23:49:25
5	news.tnetconsulting.net	5728	5	3642	5	32	0%	23:59:56
6	news.gegeweb.org	3543	1	3465	1	0	0%	23:59:36
7	news.samoylyk.net	4438	1	3632	6	11	0%	23:59:36
8	news.pasdenom.info	3464	0	3091	0	0	0%	23:58:48
TOTAL: 8		30467	87	23828	54	87	0%	191:47:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	1.9 MB	0.0 KB	1.9 MB	54.8 KB	23:59:51
2	nntp.terraraq.uk	794.4 KB	2.7 MB	3.5 MB	71.3 KB	23:59:56
3	i2pn.org	70.1 KB	21.1 KB	91.3 KB	3.5 KB	23:59:56
4	news.aioe.org	47.8 KB	2.5 KB	50.3 KB	5.0 KB	23:49:25
5	news.tnetconsulting.net	19.6 KB	13.2 KB	32.9 KB	3.3 KB	23:59:56
6	news.samoylyk.net	4.3 KB	15.8 KB	20.0 KB	2.9 KB	23:59:36
7	news.gegeweb.org	3.5 KB	2.9 KB	6.4 KB	3.2 KB	23:59:36
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:58:48
TOTAL: 8		2.8 MB	2.8 MB	5.6 MB	40.7 KB	191:47:04

NNRP readership statistics:

System		Conn	Elapsed
1	192.241.212.143	1	00:00:00
2	mail.gegeweb.eu	288	00:00:34
3	mx.terraraq.uk	1491	00:04:22
TOTAL: 3		1780	00:04:57

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	1	00:00:00
2	*.terraraq.uk	1491	00:04:22
3	*.gegeweb.eu	288	00:00:34
TOTAL: 3		1780	00:04:57

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
mx.terraraq.uk	39.787	39.437	0.000	00:04:22
mail.gegeweb.eu	7.989	8.154	2.305	00:00:34
192.241.212.143	0.020	0.030	0.000	00:00:00
TOTAL: 3	47.796	47.621	2.305	00:04:57

NNRP unrecognized commands (by host):

System	Conn
192.241.212.143	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	1
TOTAL: 1	1

Daily Usenet report for news.niel.me

Nov 6 04:15:01 -- Nov 7 04:15:01