Daily Usenet report: Oct 13 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Oct 13 10:48:18 newsfeed nnrpd[14335]: SERVER perl filter not defined
Oct 13 11:37:07 newsfeed nnrpd[16053]: SERVER perl filter not defined
Oct 13 11:39:19 newsfeed nnrpd[16069]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2881816	98.8%	337.7 MB	98.5%
innd	25398	0.9%	4.0 MB	1.2%
innfeed	4888	0.2%	698.1 KB	0.2%
nnrpd	4838	0.2%	496.3 KB	0.1%
TOTAL: 4	2916940	100.0%	342.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2875698	97.2%
Negative hits	68928	2.3%
Positive hits	13096	0.4%
Cache misses	116	0.0%
TOTAL: 4	2957838	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.848	0.0%	205	0.000	13.893	783.500
article cleanup	00:00:43.493	0.1%	2881775	0.006	0.015	0.028
article logging	00:01:22.817	0.1%	2882403	0.016	0.029	0.492
article parse	01:17:20.949	5.4%	210661984	0.010	0.022	0.068
article write	00:23:48.642	1.7%	2874069	0.321	0.497	1.764
artlog/artcncl	00:00:00.005	0.0%	204	0.000	0.025	0.500
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:03:03.482	0.2%	228605791	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.270	0.0%	165	0.000	1.636	80.000
hishave/artcncl	00:00:00.228	0.0%	205	0.000	1.112	125.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:24:25.364	1.7%	2959914	0.106	0.495	7.711
history sync	00:00:00.011	0.0%	290	0.000	0.038	1.000
history write	00:36:18.507	2.5%	2877739	0.205	0.757	9.569
hiswrite/artcncl	00:00:00.198	0.0%	40	0.000	4.950	163.000
idle	13:23:40.644	55.8%	149602506	0.153	0.322	0.680
nntp read	01:16:00.299	5.3%	208366994	0.014	0.022	0.037
overview write	00:00:16.391	0.0%	2874069	0.001	0.006	0.012
perl filter	05:53:05.384	24.5%	2877738	4.941	7.362	9.204
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:41.107	0.3%	5775265	0.030	0.049	0.084
TOTAL: 24:00:19.151	23:24:50.639	97.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.133	0.0%	36883	0.000	0.004	0.250
article prepare	00:00:00.006	0.0%	30222	0.000	0.000	0.250
article read	00:00:17.076	0.0%	7562	0.000	2.258	202.500
backlog stats	00:00:00.157	0.0%	170316	0.000	0.001	0.059
callbacks	00:00:00.000	0.0%	4	0.000	0.000	0.000
data read	00:00:01.321	0.0%	92390	0.000	0.014	0.222
data write	00:00:04.354	0.0%	71714	0.000	0.061	0.338
idle	23:59:36.914	100.0%	170316	114.091	507.157	7715.300
status file	00:00:00.643	0.0%	888	0.000	0.724	3.000
TOTAL: 24:00:05.420	24:00:00.604	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:33:47.581	99.8%	43726	0.000	211.032	91521.727
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.778	0.0%	88272	0.000	0.020	0.895
readart	00:00:02.023	0.0%	123	0.000	16.447	34.245
TOTAL: 02:34:05.052	02:33:51.382	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	190

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1059	2873601	2864764	4733	4104	99%	323:07:09
2	news.nask.pl	2	16181	8451	4073	3657	52%	24:07:47
3	news.icm.edu.pl	52	204	5	197	2	2%	17:00:51
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		1117	2889989	2873223	9003	7763	99%	364:15:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	863.3 GB	73.9 MB	94.8 MB	863.5 GB	99%	315.6 KB
2	news.nask.pl	43.1 MB	2.0 MB	69.7 MB	114.8 MB	37%	9.7 KB
3	news.icm.edu.pl	114.4 KB	43.0 KB	43.0 KB	200.5 KB	57%	28.6 KB
4	localhost	5.1 KB	0.0 KB	0.0 KB	5.1 KB	100%	1.7 KB
TOTAL: 4		863.3 GB	76.0 MB	164.5 MB	863.6 GB	99%	314.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 13 04:15:02 - 04:59:59	98418	3.4%	36.48	31.4 GB	3.6%	12187.98
Oct 13 05:00:00 - 05:59:59	120422	4.2%	33.45	40.3 GB	4.7%	11741.57
Oct 13 06:00:00 - 06:59:59	124892	4.3%	34.69	40.1 GB	4.7%	11671.37
Oct 13 07:00:00 - 07:59:59	149626	5.2%	41.56	41.8 GB	4.9%	12179.95
Oct 13 08:00:00 - 08:59:59	115086	4.0%	31.97	31.4 GB	3.7%	9138.75
Oct 13 09:00:00 - 09:59:59	140679	4.9%	39.08	38.6 GB	4.5%	11240.03
Oct 13 10:00:00 - 10:59:59	122126	4.3%	33.92	39.3 GB	4.6%	11458.43
Oct 13 11:00:00 - 11:59:59	113165	3.9%	31.43	37.8 GB	4.4%	11015.29
Oct 13 12:00:00 - 12:59:59	112218	3.9%	31.17	37.9 GB	4.4%	11025.32
Oct 13 13:00:00 - 13:59:59	120577	4.2%	33.49	40.1 GB	4.7%	11672.39
Oct 13 14:00:00 - 14:59:59	129795	4.5%	36.05	41.8 GB	4.9%	12188.12
Oct 13 15:00:00 - 15:59:59	97353	3.4%	27.04	33.4 GB	3.9%	9741.39
Oct 13 16:00:00 - 16:59:59	111883	3.9%	31.08	38.2 GB	4.4%	11122.47
Oct 13 17:00:00 - 17:59:59	115960	4.0%	32.21	38.5 GB	4.5%	11207.36
Oct 13 18:00:00 - 18:59:59	134108	4.7%	37.25	39.8 GB	4.6%	11582.18
Oct 13 19:00:00 - 19:59:59	128075	4.5%	35.58	34.8 GB	4.0%	10139.55
Oct 13 20:00:00 - 20:59:59	92726	3.2%	25.76	26.0 GB	3.0%	7580.65
Oct 13 21:00:00 - 21:59:59	115420	4.0%	32.06	30.7 GB	3.6%	8954.16
Oct 13 22:00:00 - 22:59:59	148056	5.2%	41.13	38.0 GB	4.4%	11079.47
Oct 13 23:00:00 - 23:59:59	166990	5.8%	46.39	42.4 GB	4.9%	12349.14
Oct 14 00:00:00 - 00:59:59	112711	3.9%	31.31	31.1 GB	3.6%	9051.40
Oct 14 01:00:00 - 01:59:59	106397	3.7%	29.55	30.5 GB	3.5%	8884.22
Oct 14 02:00:00 - 02:59:59	91411	3.2%	25.39	26.9 GB	3.1%	7838.08
Oct 14 03:00:00 - 03:59:59	82928	2.9%	23.04	22.7 GB	2.6%	6609.50
Oct 14 04:00:00 - 04:15:02	22257	0.8%	24.68	6.0 GB	0.7%	7032.68
TOTAL: 24:00:00	2873279	100.0%	33.26	859.6 GB	100.0%	10431.96

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4568	225	3669	2	672
2	news.nask.pl	3763	23	366	1	3373
3	news.icm.edu.pl	2	0	2	0	0
TOTAL: 3		8333	248	4037	3	4045

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	120
it.comp.os.win.windows10	34
it.tlc.cellulari.android	29
comp.mobile.ipad	23
it.comp.os.win.windows7	13
uk.rec.cycling.moderated	11
comp.mobile.android	7
nl.comp.os.linux.techniek	5
it.comp.os.win.windows8	2
comp.sys.raspberry-pi	2
it.tlc.cellulari.iphone	2
TOTAL: 11	248

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
pl.praca.oferowana	2
bit.listserv.catholic	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2736
Binary in non-binary group	542
Scoring filter (8)	44
Scoring filter (9)	27
Scoring filter (12)	14
EMP (phl)	13
Scoring filter (11)	10
Scoring filter (10)	9
Too many newsgroups	7
EMP (fsl)	4
Poison newsgroup	4
Scoring filter (19)	3
Too many newsgroups (low_xpost)	2
Scoring filter (16)	1
HTML post	1
TOTAL: 15	3417

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	9564	2587	4714	877	15	28357	27%	24:02:36
2	icm	35390	559	22700	3222	0	316	1%	23:55:13
3	nask	7777	27	5286	0	0	0	0%	23:54:35
4	poznan	12579	20	8302	9	0	0	0%	23:57:30
5	okapi	0	0	0	0	0	1978	0%	24:00:02
TOTAL: 5		65310	3193	41002	4108	15	30651	4%	119:49:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	7.7 MB	2.4 MB	10.1 MB	0.1 KB/s	3.0 KB	24:02:36
2	icm	3.9 MB	767.0 MB	770.9 MB	9.2 KB/s	208.8 KB	23:55:13
3	nask	254.7 KB	0.0 KB	254.7 KB	0.0 KB/s	9.4 KB	23:54:35
4	poznan	119.3 KB	29.5 KB	148.7 KB	0.0 KB/s	5.1 KB	23:57:30
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		12.0 MB	769.4 MB	781.4 MB	1.9 KB/s	109.6 KB	119:49:56

Backlog files shrunk by innfeed:

Server	Size
panorama	2.4 MB
TOTAL: 1	2.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	lze200.lze.lodz.pl	5	67	124.0 KB	7	0	00:42:13
2	web.man.lodz.pl	288	56	56.7 KB	27	0	00:00:21
3	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 3		296	123	180.7 KB	34	3	02:34:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.lze.lodz.pl	5	67	124.0 KB	7	0	00:42:13
2	*.man.lodz.pl	675	56	56.7 KB	27	3	00:00:26
3	unresolved	2	0	0.0 KB	0	0	01:51:25
TOTAL: 3		682	123	180.7 KB	34	3	02:34:04

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.133	2.343	3.025	01:51:25
lze200.lze.lodz.pl	0.026	0.087	00:42:13
web.man.lodz.pl	0.976	3.931	00:00:21
mon.man.lodz.pl	1.001	3.618	00:00:03
david.man.lodz.pl	0.327	1.083	00:00:01
isvcs01.man.lodz.pl	0.031	0.040	00:00:00
TOTAL: 6	4.704	11.784	02:34:04

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.133	2
TOTAL: 3	386

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	123	100.0%
TOTAL: 1		123	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	49
2	pl.comp.os.ms-windows.winnt	37
3	pl.comp.os.linux	31
4	pl.comp.os.linux.sieci	4
5	pl.rec.kuchnia	2
TOTAL: 5		123

Daily Usenet report

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