Daily Usenet report: Oct 3 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Oct 3 09:31:02 newsfeed nnrpd[18815]: SERVER perl filter not defined
Oct 3 09:45:54 newsfeed nnrpd[19254]: SERVER perl filter not defined
Oct 3 10:29:41 newsfeed nnrpd[20826]: SERVER perl filter not defined
Oct 3 15:20:43 newsfeed nnrpd[30900]: SERVER perl filter not defined
Oct 3 16:25:09 newsfeed nnrpd[607]: SERVER perl filter not defined
Oct 3 17:22:12 newsfeed nnrpd[2609]: SERVER perl filter not defined
Oct 4 02:38:35 newsfeed nnrpd[21599]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2028730	98.2%	237.5 MB	97.9%
innd	27961	1.4%	3.9 MB	1.6%
innfeed	4904	0.2%	673.5 KB	0.3%
nnrpd	4821	0.2%	500.1 KB	0.2%
TOTAL: 4	2066416	100.0%	242.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2020344	94.8%
Negative hits	90571	4.3%
Positive hits	16094	0.8%
Cache misses	3110	0.1%
TOTAL: 4	2130119	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.880	0.0%	211	0.000	4.171	108.000
article cleanup	00:00:31.194	0.0%	2028164	0.005	0.015	0.030
article logging	00:01:01.426	0.1%	2028745	0.012	0.030	0.536
article parse	00:58:51.000	4.1%	178085588	0.011	0.020	0.046
article write	00:23:55.100	1.7%	2010365	0.393	0.714	3.079
artlog/artcncl	00:00:00.004	0.0%	197	0.000	0.020	1.000
data move	00:02:20.070	0.2%	191334812	0.000	0.001	0.001
hisgrep/artcncl	00:00:00.264	0.0%	154	0.000	1.714	59.000
hishave/artcncl	00:00:00.055	0.0%	211	0.000	0.261	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:24:28.336	1.7%	2130635	0.114	0.689	7.678
history sync	00:00:00.021	0.0%	294	0.000	0.071	2.000
history write	00:34:59.096	2.4%	2020935	0.052	1.039	13.055
hiswrite/artcncl	00:00:00.082	0.0%	57	0.000	1.439	14.000
idle	14:55:53.748	62.2%	145721083	0.222	0.369	2.147
nntp read	01:05:19.420	4.5%	176591044	0.014	0.022	0.045
overview write	00:00:11.001	0.0%	2010365	0.000	0.005	0.014
perl filter	04:40:52.609	19.5%	2020933	6.156	8.339	11.715
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:30.951	0.2%	4061042	0.030	0.052	0.111
TOTAL: 24:00:20.002	23:11:55.257	96.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.181	0.0%	57262	0.000	0.003	0.091
article prepare	00:00:00.023	0.0%	66784	0.000	0.000	0.050
article read	00:00:45.785	0.1%	16687	0.000	2.744	295.000
backlog stats	00:00:00.205	0.0%	252903	0.000	0.001	0.024
callbacks	00:00:00.000	0.0%	4	0.000	0.000	0.000
data read	00:00:01.741	0.0%	136459	0.000	0.013	0.333
data write	00:00:10.471	0.0%	112011	0.000	0.093	12.000
idle	23:59:01.713	99.9%	252903	20.670	341.402	7519.750
status file	00:00:00.663	0.0%	893	0.000	0.742	5.000
TOTAL: 24:00:07.199	24:00:00.782	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:04:18.262	99.7%	7834	0.000	492.502	310592.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.337	0.0%	16299	0.000	0.021	0.500
readart	00:00:00.020	0.0%	29	0.000	0.690	6.333
TOTAL: 01:04:29.923	01:04:18.619	99.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1041	2013413	1999894	6015	7504	99%	277:24:06
2	news.nask.pl	2	25614	9980	5476	10158	38%	23:47:00
3	news.icm.edu.pl	38	342	20	312	10	5%	16:52:47
4	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 4		1089	2039376	2009901	11803	17672	98%	318:03:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	625.3 GB	842.3 MB	913.3 MB	627.0 GB	99%	327.5 KB
2	news.nask.pl	427.8 MB	9.9 MB	134.2 MB	571.8 MB	74%	29.1 KB
3	news.icm.edu.pl	786.4 KB	13.1 KB	169.0 KB	968.5 KB	81%	32.3 KB
4	localhost	10.5 KB	0.0 KB	0.0 KB	10.5 KB	100%	1.5 KB
TOTAL: 4		625.7 GB	852.1 MB	1.0 GB	627.6 GB	99%	324.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 3 04:15:02 - 04:59:59	38721	1.9%	14.35	11.6 GB	1.9%	4523.71
Oct 3 05:00:00 - 05:59:59	53843	2.7%	14.96	17.7 GB	2.8%	5151.33
Oct 3 06:00:00 - 06:59:59	61853	3.1%	17.18	23.2 GB	3.7%	6751.71
Oct 3 07:00:00 - 07:59:59	57499	2.9%	15.97	22.9 GB	3.7%	6657.75
Oct 3 08:00:00 - 08:59:59	55254	2.7%	15.35	20.9 GB	3.3%	6079.29
Oct 3 09:00:00 - 09:59:59	68338	3.4%	18.98	22.0 GB	3.5%	6408.57
Oct 3 10:00:00 - 10:59:59	65142	3.2%	18.09	22.6 GB	3.6%	6583.60
Oct 3 11:00:00 - 11:59:59	56977	2.8%	15.83	20.9 GB	3.3%	6085.57
Oct 3 12:00:00 - 12:59:59	57395	2.9%	15.94	21.3 GB	3.4%	6208.66
Oct 3 13:00:00 - 13:59:59	62852	3.1%	17.46	22.4 GB	3.6%	6511.13
Oct 3 14:00:00 - 14:59:59	71451	3.6%	19.85	22.3 GB	3.6%	6489.09
Oct 3 15:00:00 - 15:59:59	90300	4.5%	25.08	27.6 GB	4.4%	8027.95
Oct 3 16:00:00 - 16:59:59	97143	4.8%	26.98	29.9 GB	4.8%	8711.56
Oct 3 17:00:00 - 17:59:59	108796	5.4%	30.22	31.9 GB	5.1%	9279.78
Oct 3 18:00:00 - 18:59:59	108527	5.4%	30.15	31.1 GB	5.0%	9044.87
Oct 3 19:00:00 - 19:59:59	109698	5.5%	30.47	31.2 GB	5.0%	9073.42
Oct 3 20:00:00 - 20:59:59	103893	5.2%	28.86	30.0 GB	4.8%	8746.02
Oct 3 21:00:00 - 21:59:59	113918	5.7%	31.64	32.0 GB	5.1%	9306.70
Oct 3 22:00:00 - 22:59:59	108954	5.4%	30.27	32.1 GB	5.1%	9357.06
Oct 3 23:00:00 - 23:59:59	102650	5.1%	28.51	30.9 GB	4.9%	8993.09
Oct 4 00:00:00 - 00:59:59	88338	4.4%	24.54	25.0 GB	4.0%	7275.49
Oct 4 01:00:00 - 01:59:59	107506	5.3%	29.86	30.9 GB	5.0%	9008.88
Oct 4 02:00:00 - 02:59:59	102766	5.1%	28.55	30.5 GB	4.9%	8896.72
Oct 4 03:00:00 - 03:59:59	92492	4.6%	25.69	26.9 GB	4.3%	7837.82
Oct 4 04:00:00 - 04:15:02	25859	1.3%	28.67	7.0 GB	1.1%	8192.02
TOTAL: 24:00:00	2010165	100.0%	23.27	624.6 GB	100.0%	7580.37

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	10439	17	345	15	10062
2	newsfeed.pionier.net.pl	7916	174	6874	4	864
3	news.icm.edu.pl	13	0	1	0	12
TOTAL: 3		18368	191	7220	19	10938

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	112
it.tlc.cellulari.android	26
it.comp.os.win.windows10	24
comp.mobile.android	15
it.comp.os.linux.ubuntu	4
rec.arts.tv.x-factor	3
de.rec.sf.startrek	2
de.comp.lang.php	1
hr.ponuda.hardver.komponente	1
de.comp.office-pakete.ms-office.misc	1
hr.alt.cellular.gsm.android	1
it.comp.os.win.windows7	1
TOTAL: 12	191

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

Groups	Count
pl.sci.matematyka	14
pl.praca.oferowana	3
christnet.philosophy	1
bit.listserv.catholic	1
TOTAL: 4	19

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9433
Binary in non-binary group	694
EMP (phl)	112
Scoring filter (8)	53
Scoring filter (9)	27
Scoring filter (10)	10
Scoring filter (17)	8
Scoring filter (11)	7
Excessively crossposted test article	7
Poison newsgroup	2
Scoring filter (13)	2
TOTAL: 11	10355

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	17276	2500	12706	663	22	41122	14%	23:57:55
2	icm	48195	540	25892	12611	0	0	1%	24:02:45
3	poznan	14980	102	9560	25	0	0	0%	23:59:10
4	nask	10598	62	7276	2	0	0	0%	24:04:37
5	okapi	0	0	0	0	0	1848	0%	24:00:05
TOTAL: 5		91049	3204	55434	13301	22	42970	3%	120:04:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	21.7 MB	2.5 GB	2.5 GB	30.3 KB/s	199.2 KB	24:02:45
2	panorama	17.7 MB	3.8 MB	21.5 MB	0.3 KB/s	7.0 KB	23:57:55
3	nask	14.2 MB	4.9 KB	14.2 MB	0.2 KB/s	226.9 KB	24:04:37
4	poznan	9.3 MB	2.4 MB	11.7 MB	0.1 KB/s	94.7 KB	23:59:10
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:05
TOTAL: 5		62.9 MB	2.5 GB	2.5 GB	6.2 KB/s	161.6 KB	120:04:32

Backlog files shrunk by innfeed:

Server	Size
panorama	3.3 MB
TOTAL: 1	3.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	289	26	24.9 KB	12	0	00:00:21
2	bkb82.neoplus.adsl.tpnet.pl	3	3	4.0 KB	1	0	00:44:30
3	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	00:00:00
TOTAL: 3		299	29	28.9 KB	13	7	01:04:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	680	26	24.9 KB	12	7	00:00:26
2	*.neoplus.adsl.tpnet.pl	3	3	4.0 KB	1	0	00:44:30
3	unresolved	2	0	0.0 KB	0	0	00:19:32
TOTAL: 3		685	29	28.9 KB	13	7	01:04:29

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
bkb82.neoplus.adsl.tpnet.pl	0.079	0.063	00:44:30
185.48.195.142	0.238	0.444	00:19:32
web.man.lodz.pl	0.948	4.339	00:00:21
mon.man.lodz.pl	0.987	4.027	00:00:03
david.man.lodz.pl	0.317	1.193	00:00:01
isvcs01.man.lodz.pl	0.051	0.119	00:00:00
TOTAL: 6	2.620	10.185	01:04:29

Curious NNRP server explorers [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	26	89.7%
2	lodman	3	10.3%
TOTAL: 2		29	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	22
2	pl.comp.pecet	4
3	lodman.info	3
TOTAL: 3		29

Daily Usenet report

Oct 3 04:15:02 -- Oct 4 04:15:02