Daily Usenet report: Oct 19 04:15:04

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 19 15:54:06 newsfeed nnrpd[3787]: SERVER perl filter not defined
Oct 20 02:21:28 newsfeed nnrpd[25406]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2890231	98.3%	337.0 MB	98.1%
innd	39367	1.3%	5.4 MB	1.6%
innfeed	4854	0.2%	670.1 KB	0.2%
nnrpd	4847	0.2%	504.3 KB	0.1%
TOTAL: 4	2939299	100.0%	343.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2883789	96.2%
Negative hits	96847	3.2%
Positive hits	17865	0.6%
Cache misses	132	0.0%
TOTAL: 4	2998633	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.020	0.0%	192	0.000	10.521	295.000
article cleanup	00:00:41.817	0.0%	2890167	0.005	0.014	0.026
article logging	00:01:36.853	0.1%	2890737	0.014	0.034	1.633
article parse	01:11:04.540	4.9%	181044290	0.012	0.024	0.068
article write	00:34:13.411	2.4%	2869108	0.370	0.716	2.989
artlog/artcncl	00:00:00.001	0.0%	192	0.000	0.005	0.333
artlog/artparse	00:00:00.001	0.0%	1	1.000	1.000	1.000
data move	00:02:35.275	0.2%	198232484	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.099	0.0%	172	0.000	0.576	2.273
hishave/artcncl	00:00:00.080	0.0%	192	0.000	0.417	10.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:23:46.548	1.7%	3001089	0.089	0.475	7.001
history sync	00:00:00.014	0.0%	291	0.000	0.048	1.000
history write	00:35:57.268	2.5%	2886133	0.175	0.747	8.821
hiswrite/artcncl	00:00:00.034	0.0%	20	0.000	1.700	16.000
idle	13:32:40.859	56.4%	141822313	0.153	0.344	0.747
nntp read	01:04:51.989	4.5%	178749387	0.013	0.022	0.038
overview write	00:00:16.300	0.0%	2869108	0.001	0.006	0.012
perl filter	05:38:09.514	23.5%	2886132	4.758	7.030	10.078
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:52.216	0.3%	5786773	0.028	0.050	0.088
TOTAL: 24:00:18.810	23:10:48.839	96.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.225	0.0%	56870	0.000	0.004	0.143
article prepare	00:00:00.025	0.0%	95926	0.000	0.000	0.036
article read	00:00:18.134	0.0%	24096	0.000	0.753	143.800
backlog stats	00:00:00.236	0.0%	284859	0.000	0.001	0.024
callbacks	00:00:00.000	0.0%	93	0.000	0.000	0.000
data read	00:00:02.119	0.0%	157628	0.000	0.013	0.091
data write	00:00:12.420	0.0%	123933	0.000	0.100	0.410
idle	23:58:31.012	100.0%	284859	47.544	302.996	1382.932
status file	00:00:00.655	0.0%	861	0.000	0.761	3.000
TOTAL: 23:59:12.864	23:59:04.826	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:26:02.854	99.8%	3079	0.000	1676.796	262655.143
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.160	0.0%	6816	0.000	0.023	0.500
readart	00:00:00.148	0.0%	31	0.000	4.774	72.000
TOTAL: 01:26:14.886	01:26:03.162	99.8%	-	-	-	-

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	1193	2869125	2857994	6370	4761	99%	351:53:04
2	news.nask.pl	2	33762	10255	7199	16308	30%	24:05:59
3	news.icm.edu.pl	51	258	14	238	6	5%	16:15:34
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1249	2903147	2868265	13807	21075	98%	392:14:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	795.1 GB	28.4 MB	191.9 MB	795.3 GB	99%	291.3 KB
2	news.nask.pl	57.9 MB	1.7 MB	228.3 MB	287.9 MB	20%	11.1 KB
3	news.icm.edu.pl	820.3 KB	8.8 KB	124.8 KB	953.9 KB	85%	47.7 KB
4	localhost	2.5 KB	0.0 KB	0.0 KB	2.5 KB	100%	1.3 KB
TOTAL: 4		795.1 GB	30.1 MB	420.3 MB	795.6 GB	99%	288.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 19 04:15:04 - 04:59:59	102934	3.6%	38.18	27.6 GB	3.5%	10716.34
Oct 19 05:00:00 - 05:59:59	152568	5.3%	42.38	41.1 GB	5.2%	11958.17
Oct 19 06:00:00 - 06:59:59	144877	5.1%	40.24	41.5 GB	5.2%	12078.12
Oct 19 07:00:00 - 07:59:59	149748	5.2%	41.60	42.4 GB	5.4%	12363.57
Oct 19 08:00:00 - 08:59:59	153434	5.3%	42.62	41.6 GB	5.3%	12116.84
Oct 19 09:00:00 - 09:59:59	140250	4.9%	38.96	41.6 GB	5.3%	12124.17
Oct 19 10:00:00 - 10:59:59	153185	5.3%	42.55	40.9 GB	5.2%	11920.07
Oct 19 11:00:00 - 11:59:59	96378	3.4%	26.77	27.8 GB	3.5%	8102.39
Oct 19 12:00:00 - 12:59:59	116863	4.1%	32.46	34.5 GB	4.4%	10055.99
Oct 19 13:00:00 - 13:59:59	112798	3.9%	31.33	35.5 GB	4.5%	10336.24
Oct 19 14:00:00 - 14:59:59	112248	3.9%	31.18	36.4 GB	4.6%	10615.94
Oct 19 15:00:00 - 15:59:59	79085	2.8%	21.97	24.5 GB	3.1%	7123.95
Oct 19 16:00:00 - 16:59:59	88685	3.1%	24.63	25.3 GB	3.2%	7363.86
Oct 19 17:00:00 - 17:59:59	126103	4.4%	35.03	29.7 GB	3.7%	8649.14
Oct 19 18:00:00 - 18:59:59	124849	4.4%	34.68	30.6 GB	3.9%	8908.92
Oct 19 19:00:00 - 19:59:59	126940	4.4%	35.26	31.1 GB	3.9%	9056.37
Oct 19 20:00:00 - 20:59:59	123172	4.3%	34.21	30.5 GB	3.8%	8872.55
Oct 19 21:00:00 - 21:59:59	125202	4.4%	34.78	31.1 GB	3.9%	9054.62
Oct 19 22:00:00 - 22:59:59	120881	4.2%	33.58	28.9 GB	3.7%	8423.56
Oct 19 23:00:00 - 23:59:59	113040	3.9%	31.40	28.0 GB	3.5%	8164.00
Oct 20 00:00:00 - 00:59:59	88762	3.1%	24.66	24.9 GB	3.1%	7252.19
Oct 20 01:00:00 - 01:59:59	93035	3.2%	25.84	28.4 GB	3.6%	8265.44
Oct 20 02:00:00 - 02:59:59	101258	3.5%	28.13	30.8 GB	3.9%	8978.57
Oct 20 03:00:00 - 03:59:59	98628	3.4%	27.40	29.8 GB	3.8%	8679.67
Oct 20 04:00:00 - 04:15:02	23486	0.8%	26.04	7.6 GB	1.0%	8784.47
TOTAL: 23:59:58	2868409	100.0%	33.20	792.0 GB	100.0%	9612.34

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	16459	12	513	6	15928
2	newsfeed.pionier.net.pl	5165	174	3521	1	1469
3	news.icm.edu.pl	6	0	1	0	5
TOTAL: 3		21630	186	4035	7	17402

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	90
it.tlc.cellulari.android	42
it.comp.os.win.windows8	13
it.comp.os.win.windows10	11
it.comp.os.win.windows7	8
de.comp.lang.vbclassic	5
comp.mobile.ipad	5
it.discussioni.energia	3
comp.mobile.android	3
comp.sys.raspberry-pi	3
de.comp.lang.perl	2
it.tlc.cellulari.iphone	1
TOTAL: 12	186

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14817
Binary in non-binary group	1549
Scoring filter (8)	152
EMP (phl)	83
Scoring filter (9)	57
Poison newsgroup	54
Scoring filter (10)	31
Scoring filter (11)	21
Scoring filter (19)	20
Too many newsgroups	14
Scoring filter (18)	10
Scoring filter (13)	10
Scoring filter (12)	4
HTML post	3
Scoring filter (16)	2
Scoring filter (17)	1
Scoring filter (14)	1
Angle-bracket bot	1
Scoring filter (15)	1
TOTAL: 19	16831

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	8489	2328	3802	760	256	49662	27%	23:56:47
2	icm	58371	496	27730	19745	0	0	0%	24:01:36
3	poznan	15428	218	9991	21	0	0	1%	24:07:29
4	nask	14131	88	8702	3	0	0	0%	23:54:36
5	okapi	0	0	0	0	0	2553	0%	24:00:01
TOTAL: 5		96419	3130	50225	20529	256	52215	3%	120:00:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	7.6 MB	4.3 GB	4.3 GB	51.7 KB/s	220.9 KB	24:01:36
2	panorama	5.3 MB	4.2 MB	9.6 MB	0.1 KB/s	3.2 KB	23:56:47
3	poznan	938.3 KB	65.3 KB	1003.5 KB	0.0 KB/s	4.2 KB	24:07:29
4	nask	762.9 KB	16.8 KB	779.7 KB	0.0 KB/s	8.6 KB	23:54:36
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		14.6 MB	4.3 GB	4.3 GB	10.4 KB/s	189.5 KB	120:00:29

Backlog files shrunk by innfeed:

Server	Size
panorama	3.8 MB
TOTAL: 1	3.8 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	18	13.5 KB	8	0	0	00:00:20
2	jwq217.internetdsl.tpnet.pl	9	9	14.1 KB	4	0	4	01:07:14
3	jwq218.internetdsl.tpnet.pl	7	4	9.5 KB	4	0	2	00:18:33
4	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	0	00:00:00
TOTAL: 4		306	31	37.1 KB	16	2	6	01:26:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	674	18	13.5 KB	8	2	0	00:00:25
2	*.internetdsl.tpnet.pl	16	13	23.6 KB	8	0	6	01:25:48
3	*.shodan.io	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 3		691	31	37.1 KB	16	2	6	01:26:14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
jwq217.internetdsl.tpnet.pl	0.052	0.170	01:07:14
jwq218.internetdsl.tpnet.pl	0.050	0.126	00:18:33
web.man.lodz.pl	0.942	5.152	00:00:20
mon.man.lodz.pl	0.854	4.818	00:00:03
census3.shodan.io	0.003	0.015	00:00:01
david.man.lodz.pl	0.355	1.496	00:00:01
isvcs01.man.lodz.pl	0.006	0.047	00:00:00
TOTAL: 7	2.262	11.824	01:26:14

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
census3.shodan.io	1
TOTAL: 3	385

NNRP client timeouts [Top 20]:

System	Conn	Peer
jwq217.internetdsl.tpnet.pl	2	0
TOTAL: 1	2	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	18	58.1%
2	lodman	13	41.9%
TOTAL: 2		31	100.0%

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

Newsgroup		Count
1	lodman.test	13
2	pl.comp.pecet	12
3	pl.comp.os.ms-windows.winnt	6
TOTAL: 3		31

Daily Usenet report

Oct 19 04:15:04 -- Oct 20 04:15:02