Daily Usenet report: Sep 4 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 4 16:52:04 newsfeed nnrpd[21024]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2807558	98.5%	328.6 MB	98.2%
innd	33930	1.2%	4.8 MB	1.4%
innfeed	4863	0.2%	679.1 KB	0.2%
nnrpd	4761	0.2%	496.0 KB	0.1%
TOTAL: 4	2851112	100.0%	334.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2802435	96.4%
Negative hits	91508	3.1%
Positive hits	13255	0.5%
Cache misses	99	0.0%
TOTAL: 4	2907297	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.922	0.0%	172	0.000	11.174	86.000
article cleanup	00:00:43.071	0.0%	2805843	0.007	0.015	0.029
article logging	00:01:20.723	0.1%	2806389	0.013	0.029	0.717
article parse	01:22:26.428	5.7%	221093247	0.012	0.022	0.076
article write	00:35:07.782	2.4%	2790327	0.334	0.755	5.241
artlog/artcncl	00:00:00.003	0.0%	171	0.000	0.018	0.500
data move	00:02:58.125	0.2%	239053212	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.082	0.0%	154	0.000	0.532	10.000
hishave/artcncl	00:00:00.070	0.0%	172	0.000	0.407	15.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:13.900	1.8%	2907256	0.079	0.521	8.220
history sync	00:00:00.018	0.0%	294	0.000	0.061	1.000
history write	00:37:43.010	2.6%	2802472	0.171	0.808	11.510
hiswrite/artcncl	00:00:00.041	0.0%	18	0.000	2.278	24.000
idle	12:27:08.814	51.9%	160846843	0.173	0.279	0.611
nntp read	01:17:06.992	5.4%	218850369	0.013	0.021	0.043
overview write	00:00:15.368	0.0%	2790327	0.001	0.006	0.016
perl filter	06:05:46.087	25.4%	2802472	5.861	7.831	9.922
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:42.714	0.3%	5655840	0.032	0.050	0.093
TOTAL: 23:59:21.193	23:00:35.150	95.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.334	0.0%	106933	0.000	0.003	0.333
article prepare	00:00:00.064	0.0%	231488	0.000	0.000	0.025
article read	00:01:37.322	0.1%	57918	0.000	1.680	713.000
backlog stats	00:00:00.426	0.0%	481242	0.000	0.001	0.032
callbacks	00:00:00.000	0.0%	54	0.000	0.000	0.000
data read	00:00:02.607	0.0%	209897	0.000	0.012	0.121
data write	00:00:32.854	0.0%	275628	0.000	0.119	0.262
idle	23:56:47.862	99.8%	481242	8.883	179.136	17107.250
status file	00:00:00.733	0.0%	981	0.000	0.747	3.250
TOTAL: 23:59:13.013	23:59:02.202	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:10:05.918	99.8%	75497	0.000	151.078	10042.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.921	0.0%	151640	0.000	0.019	1.000
readart	00:00:00.001	0.0%	38	0.000	0.026	0.500
TOTAL: 03:10:24.346	03:10:08.840	99.9%	-	-	-	-

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	1156	2793047	2781774	6576	4697	99%	360:16:07
2	news.nask.pl	2	23329	9512	3009	10808	40%	24:02:31
3	news.icm.edu.pl	44	278	19	241	18	6%	16:30:38
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		1204	2816655	2791306	9826	15523	99%	400:49:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	877.7 GB	248.0 MB	493.2 MB	878.4 GB	99%	330.5 KB
2	news.nask.pl	69.6 MB	3.2 MB	165.9 MB	238.7 MB	29%	12.0 KB
3	news.icm.edu.pl	955.5 KB	98.4 KB	759.4 KB	1.8 MB	52%	49.0 KB
4	localhost	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
TOTAL: 4		877.7 GB	251.3 MB	659.8 MB	878.6 GB	99%	328.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 4 04:15:02 - 04:59:59	81691	2.9%	30.28	26.9 GB	3.1%	10473.01
Sep 4 05:00:00 - 05:59:59	109747	3.9%	30.49	34.5 GB	3.9%	10042.68
Sep 4 06:00:00 - 06:59:59	123531	4.4%	34.31	36.5 GB	4.2%	10634.37
Sep 4 07:00:00 - 07:59:59	113560	4.1%	31.54	37.8 GB	4.3%	11024.14
Sep 4 08:00:00 - 08:59:59	115652	4.1%	32.13	38.1 GB	4.3%	11102.40
Sep 4 09:00:00 - 09:59:59	100848	3.6%	28.01	35.0 GB	4.0%	10187.90
Sep 4 10:00:00 - 10:59:59	108987	3.9%	30.27	37.6 GB	4.3%	10950.83
Sep 4 11:00:00 - 11:59:59	113770	4.1%	31.60	38.4 GB	4.4%	11197.08
Sep 4 12:00:00 - 12:59:59	126341	4.5%	35.09	40.6 GB	4.6%	11825.45
Sep 4 13:00:00 - 13:59:59	137395	4.9%	38.17	39.8 GB	4.5%	11596.45
Sep 4 14:00:00 - 14:59:59	120018	4.3%	33.34	38.6 GB	4.4%	11232.19
Sep 4 15:00:00 - 15:59:59	123243	4.4%	34.23	39.1 GB	4.5%	11398.07
Sep 4 16:00:00 - 16:59:59	91880	3.3%	25.52	32.1 GB	3.7%	9339.77
Sep 4 17:00:00 - 17:59:59	128999	4.6%	35.83	38.6 GB	4.4%	11233.92
Sep 4 18:00:00 - 18:59:59	121876	4.4%	33.85	36.4 GB	4.2%	10616.66
Sep 4 19:00:00 - 19:59:59	130612	4.7%	36.28	38.5 GB	4.4%	11226.95
Sep 4 20:00:00 - 20:59:59	121948	4.4%	33.87	38.3 GB	4.4%	11142.95
Sep 4 21:00:00 - 21:59:59	130812	4.7%	36.34	36.1 GB	4.1%	10511.40
Sep 4 22:00:00 - 22:59:59	135846	4.9%	37.73	37.8 GB	4.3%	11022.46
Sep 4 23:00:00 - 23:59:59	119021	4.3%	33.06	35.3 GB	4.0%	10271.29
Sep 5 00:00:00 - 00:59:59	87671	3.1%	24.35	27.8 GB	3.2%	8083.43
Sep 5 01:00:00 - 01:59:59	115316	4.1%	32.03	35.8 GB	4.1%	10423.89
Sep 5 02:00:00 - 02:59:59	113763	4.1%	31.60	37.4 GB	4.3%	10899.24
Sep 5 03:00:00 - 03:59:59	94217	3.4%	26.17	32.2 GB	3.7%	9371.35
Sep 5 04:00:00 - 04:15:02	24581	0.9%	27.25	8.0 GB	0.9%	9356.13
TOTAL: 24:00:00	2791325	100.0%	32.31	877.3 GB	100.0%	10647.00

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	11052	25	224	1	10802
2	newsfeed.pionier.net.pl	4992	140	3146	0	1706
3	news.icm.edu.pl	18	0	1	0	17
TOTAL: 3		16062	165	3371	1	12525

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	72
it.tlc.cellulari.android	32
it.comp.os.win.windows10	21
comp.mobile.ipad	12
comp.sys.raspberry-pi	7
comp.mobile.android	7
uk.rec.cycling.moderated	7
de.rec.sf.startrek	3
de.comm.provider.telefonie	2
it.comp.os.linux.ubuntu	1
it.politica.m5s	1
TOTAL: 11	165

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9945
Binary in non-binary group	1699
EMP (phl)	155
Scoring filter (8)	102
Scoring filter (9)	32
Adult group ECP	24
Scoring filter (13)	7
Scoring filter (10)	7
HTML post	4
Too many newsgroups	2
Scoring filter (11)	1
EMP (fsl)	1
TOTAL: 12	11979

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	79896	31096	17796	25487	8	7903	38%	24:04:34
2	panorama	30845	713	28180	260	166	69689	2%	23:57:49
3	poznan	14916	143	9340	1	0	0	0%	24:02:46
4	nask	5892	22	3922	1	0	0	0%	24:00:24
5	okapi	0	0	0	0	0	1453	0%	24:00:02
TOTAL: 5		131549	31974	59238	25749	174	79045	24%	120:05:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	5.6 GB	6.2 GB	11.7 GB	141.8 KB/s	217.2 KB	24:04:34
2	panorama	2.5 MB	2.0 MB	4.6 MB	0.1 KB/s	4.8 KB	23:57:49
3	poznan	1.4 MB	1.8 KB	1.4 MB	0.0 KB/s	10.2 KB	24:02:46
4	nask	323.5 KB	3.3 KB	326.8 KB	0.0 KB/s	14.2 KB	24:00:24
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		5.6 GB	6.2 GB	11.7 GB	28.4 KB/s	213.0 KB	120:05:35

Backlog files shrunk by innfeed:

Server	Size
panorama	6.2 MB
TOTAL: 1	6.2 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	38	39.8 KB	19	0	00:00:22
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	38	39.8 KB	19	1	03:10:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	673	38	39.8 KB	19	1	00:00:27
2	unresolved	2	0	0.0 KB	0	0	03:09:57
TOTAL: 2		675	38	39.8 KB	19	1	03:10:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.73	4.066	5.524	03:09:57
web.man.lodz.pl	0.990	4.534	00:00:22
mon.man.lodz.pl	1.015	3.781	00:00:03
david.man.lodz.pl	0.344	1.264	00:00:01
isvcs01.man.lodz.pl	0.009	0.018	00:00:00
TOTAL: 5	6.424	15.121	03:10:24

Curious NNRP server explorers [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	28
2	pl.comp.os.ms-windows.winnt	8
3	pl.internet.polip	2
TOTAL: 3		38

Daily Usenet report

Sep 4 04:15:02 -- Sep 5 04:15:02