Daily Usenet report: Sep 29 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Sep 29 08:05:43 newsfeed nnrpd[32523]: SERVER perl filter not defined
Sep 29 08:10:29 newsfeed nnrpd[32621]: SERVER perl filter not defined
Sep 29 08:25:39 newsfeed nnrpd[760]: SERVER perl filter not defined
Sep 29 09:22:44 newsfeed nnrpd[2619]: SERVER perl filter not defined
Sep 29 11:31:29 newsfeed nnrpd[7073]: SERVER perl filter not defined
Sep 29 11:33:07 newsfeed nnrpd[7217]: SERVER perl filter not defined
Sep 29 11:34:52 newsfeed nnrpd[7255]: SERVER perl filter not defined
Sep 29 11:37:05 newsfeed nnrpd[7319]: SERVER perl filter not defined
Sep 29 11:43:12 newsfeed nnrpd[7559]: SERVER perl filter not defined
Sep 29 12:31:41 newsfeed nnrpd[9137]: SERVER perl filter not defined
Sep 29 13:29:08 newsfeed nnrpd[11242]: SERVER perl filter not defined
Sep 29 15:39:08 newsfeed nnrpd[15702]: SERVER perl filter not defined
Sep 29 16:00:29 newsfeed nnrpd[16466]: SERVER perl filter not defined
Sep 29 22:22:36 newsfeed nnrpd[29566]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2459868	98.4%	289.3 MB	98.1%
innd	30521	1.2%	4.3 MB	1.5%
nnrpd	4908	0.2%	504.1 KB	0.2%
innfeed	4767	0.2%	671.3 KB	0.2%
TOTAL: 4	2500064	100.0%	294.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2454008	95.8%
Negative hits	92011	3.6%
Positive hits	15350	0.6%
Cache misses	117	0.0%
TOTAL: 4	2561486	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.092	0.0%	176	0.000	23.250	2014.000
article cleanup	00:00:37.697	0.0%	2458879	0.002	0.015	0.034
article logging	00:01:17.957	0.1%	2459508	0.013	0.032	1.078
article parse	01:04:34.507	4.5%	201230760	0.007	0.019	0.060
article write	00:28:03.462	1.9%	2444714	0.368	0.689	3.568
artlog/artcncl	00:00:00.003	0.0%	175	0.000	0.017	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:29.790	0.2%	217034282	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.449	0.0%	160	0.000	2.806	147.000
hishave/artcncl	00:00:00.019	0.0%	176	0.000	0.108	4.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:15.690	1.8%	2563334	0.151	0.591	7.519
history sync	00:00:00.022	0.0%	293	0.000	0.075	1.000
history write	00:34:41.780	2.4%	2455789	0.210	0.848	8.424
hiswrite/artcncl	00:00:00.050	0.0%	16	0.000	3.125	19.000
idle	14:22:44.415	59.9%	151016833	0.223	0.343	1.209
nntp read	01:03:42.475	4.4%	199324398	0.012	0.019	0.045
overview write	00:00:14.066	0.0%	2444714	0.000	0.006	0.018
perl filter	04:57:01.916	20.6%	2455789	4.750	7.257	11.357
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:12.248	0.3%	4928201	0.025	0.051	0.092
TOTAL: 23:59:24.444	23:05:00.638	96.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.167	0.0%	53781	0.000	0.003	0.136
article prepare	00:00:00.018	0.0%	74752	0.000	0.000	0.050
article read	00:00:33.906	0.0%	18667	0.000	1.816	185.800
backlog stats	00:00:00.227	0.0%	251297	0.000	0.001	0.024
callbacks	00:00:00.000	0.0%	11	0.000	0.000	0.000
data read	00:00:01.684	0.0%	134906	0.000	0.012	0.070
data write	00:00:10.192	0.0%	114880	0.000	0.089	0.340
idle	23:59:34.222	99.9%	251297	82.341	343.714	1690.491
status file	00:00:00.563	0.0%	830	0.000	0.678	31.000
TOTAL: 24:00:27.558	24:00:20.979	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:02:17.878	91.7%	3191	0.000	43.208	24435.800
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.188	0.1%	7059	0.000	0.027	0.667
readart	00:00:00.127	0.1%	116	0.000	1.095	14.000
TOTAL: 00:02:30.288	00:02:18.193	92.0%	-	-	-	-

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	1012	2445531	2434636	7411	3484	99%	322:34:41
2	news.nask.pl	2	25559	10331	4543	10685	40%	23:44:54
3	localhost	15	14	14	0	0	100%	00:00:01
4	news.icm.edu.pl	44	327	10	282	35	3%	19:05:24
TOTAL: 4		1073	2471431	2444991	12236	14204	98%	365:25:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	756.0 GB	42.3 MB	120.4 MB	756.2 GB	99%	325.2 KB
2	news.nask.pl	67.3 MB	1.4 MB	133.5 MB	202.1 MB	33%	9.8 KB
3	news.icm.edu.pl	308.9 KB	0.0 KB	2.6 MB	2.9 MB	10%	66.4 KB
4	localhost	24.2 KB	0.0 KB	0.0 KB	24.2 KB	100%	1.7 KB
TOTAL: 4		756.1 GB	43.7 MB	256.5 MB	756.4 GB	99%	322.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 29 04:15:02 - 04:59:59	91082	3.7%	33.76	26.5 GB	3.5%	10285.83
Sep 29 05:00:00 - 05:59:59	116550	4.8%	32.38	35.9 GB	4.8%	10469.23
Sep 29 06:00:00 - 06:59:59	116967	4.8%	32.49	34.8 GB	4.6%	10132.26
Sep 29 07:00:00 - 07:59:59	141490	5.8%	39.30	40.8 GB	5.4%	11871.34
Sep 29 08:00:00 - 08:59:59	143058	5.9%	39.74	40.1 GB	5.3%	11669.86
Sep 29 09:00:00 - 09:59:59	142004	5.8%	39.45	39.7 GB	5.2%	11554.37
Sep 29 10:00:00 - 10:59:59	142988	5.8%	39.72	40.9 GB	5.4%	11900.31
Sep 29 11:00:00 - 11:59:59	109213	4.5%	30.34	32.3 GB	4.3%	9420.46
Sep 29 12:00:00 - 12:59:59	114676	4.7%	31.85	35.8 GB	4.7%	10429.50
Sep 29 13:00:00 - 13:59:59	113156	4.6%	31.43	36.6 GB	4.8%	10668.12
Sep 29 14:00:00 - 14:59:59	119636	4.9%	33.23	38.4 GB	5.1%	11178.00
Sep 29 15:00:00 - 15:59:59	120569	4.9%	33.49	40.0 GB	5.3%	11653.30
Sep 29 16:00:00 - 16:59:59	123774	5.1%	34.38	40.4 GB	5.3%	11764.37
Sep 29 17:00:00 - 17:59:59	118172	4.8%	32.83	40.2 GB	5.3%	11696.03
Sep 29 18:00:00 - 18:59:59	138987	5.7%	38.61	39.5 GB	5.2%	11504.64
Sep 29 19:00:00 - 19:59:59	114559	4.7%	31.82	34.2 GB	4.5%	9953.15
Sep 29 20:00:00 - 20:59:59	121179	5.0%	33.66	37.0 GB	4.9%	10765.62
Sep 29 21:00:00 - 21:59:59	92107	3.8%	25.59	27.6 GB	3.6%	8026.01
Sep 29 22:00:00 - 22:59:59	42691	1.7%	11.86	15.0 GB	2.0%	4375.69
Sep 29 23:00:00 - 23:59:59	41005	1.7%	11.39	14.3 GB	1.9%	4168.70
Sep 30 00:00:00 - 00:59:59	31633	1.3%	8.79	12.0 GB	1.6%	3507.88
Sep 30 01:00:00 - 01:59:59	41454	1.7%	11.52	14.6 GB	1.9%	4247.74
Sep 30 02:00:00 - 02:59:59	45890	1.9%	12.75	17.0 GB	2.3%	4960.96
Sep 30 03:00:00 - 03:59:59	49415	2.0%	13.73	17.8 GB	2.4%	5179.81
Sep 30 04:00:00 - 04:15:01	12641	0.5%	14.03	4.7 GB	0.6%	5464.84
TOTAL: 23:59:59	2444896	100.0%	28.30	755.9 GB	100.0%	9174.01

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	10954	16	359	4	10575
2	newsfeed.pionier.net.pl	3818	233	2733	0	852
3	news.icm.edu.pl	25	0	0	0	25
TOTAL: 3		14797	249	3092	4	11452

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	150
it.tlc.cellulari.android	32
it.comp.os.win.windows10	26
comp.mobile.android	12
comp.mobile.ipad	9
hr.alt.cellular.gsm.android	9
it.comp.os.win.windows7	7
uk.rec.cycling.moderated	2
it.tlc.cellulari.iphone	2
TOTAL: 9	249

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9873
Binary in non-binary group	725
Scoring filter (8)	82
Scoring filter (9)	52
EMP (phl)	47
Scoring filter (11)	12
Scoring filter (10)	11
HTML post	9
Scoring filter (13)	6
Scoring filter (16)	2
Scoring filter (12)	1
Scoring filter (20)	1
Too many newsgroups	1
Scoring filter (17)	1
TOTAL: 14	10823

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	17513	2836	12464	831	34	37635	16%	24:04:28
2	icm	46297	319	23537	14172	0	0	0%	23:59:05
3	poznan	15493	177	10187	16	0	0	1%	24:07:19
4	nask	9201	32	5792	147	0	0	0%	23:58:28
5	okapi	0	0	0	0	0	2104	0%	24:00:02
TOTAL: 5		88504	3364	51980	15166	34	39739	3%	120:09:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	12.3 MB	2.5 MB	14.8 MB	0.2 KB/s	4.1 KB	24:04:28
2	icm	4.2 MB	2.9 GB	2.9 GB	35.6 KB/s	212.1 KB	23:59:05
3	poznan	688.7 KB	49.9 KB	738.6 KB	0.0 KB/s	3.8 KB	24:07:19
4	nask	146.5 KB	90.9 MB	91.0 MB	1.1 KB/s	520.6 KB	23:58:28
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		17.3 MB	3.0 GB	3.0 GB	7.4 KB/s	171.7 KB	120:09:22

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	96	96.0 KB	47	0	00:00:21
2	isvcs01.man.lodz.pl	14	0	0.0 KB	0	14	00:00:01
TOTAL: 2		302	96	96.0 KB	47	14	00:02:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	686	96	96.0 KB	47	14	00:00:27
2	unresolved	1	0	0.0 KB	0	0	00:02:02
TOTAL: 2		687	96	96.0 KB	47	14	00:02:29

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
196.52.22.49	0.000	0.026	00:02:02
web.man.lodz.pl	0.922	5.179	00:00:21
mon.man.lodz.pl	0.891	4.839	00:00:03
david.man.lodz.pl	0.302	1.659	00:00:01
isvcs01.man.lodz.pl	0.068	0.247	00:00:01
TOTAL: 5	2.183	11.950	00:02:29

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
196.52.22.49	1
TOTAL: 3	385

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	60
2	pl.comp.pecet	34
3	pl.internet.polip	2
TOTAL: 3		96

Daily Usenet report

Sep 29 04:15:02 -- Sep 30 04:15:01