Daily Usenet report: Mar 26 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Mar 26 20:22:15 newsfeed nnrpd[20673]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3103784	98.5%	360.2 MB	98.3%
innd	36539	1.2%	5.2 MB	1.4%
nnrpd	4775	0.2%	493.9 KB	0.1%
innfeed	4688	0.1%	672.1 KB	0.2%
TOTAL: 4	3149786	100.0%	366.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3085323	96.5%
Negative hits	89947	2.8%
Positive hits	22328	0.7%
Cache misses	123	0.0%
TOTAL: 4	3197721	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.900	0.0%	170	0.000	28.824	873.000
article cleanup	00:00:44.458	0.1%	3101654	0.006	0.014	0.026
article logging	00:01:56.078	0.1%	3102330	0.016	0.037	0.838
article parse	01:16:02.847	5.3%	206484978	0.014	0.022	0.071
article write	01:07:32.932	4.7%	3074348	0.294	1.318	6.186
artlog/artcncl	00:00:00.004	0.0%	169	0.000	0.024	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:03:52.428	0.3%	225258154	0.000	0.001	0.005
hisgrep/artcncl	00:00:01.040	0.0%	153	0.000	6.797	604.000
hishave/artcncl	00:00:00.043	0.0%	170	0.000	0.253	1.222
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:29:48.787	2.1%	3199891	0.141	0.559	8.035
history sync	00:00:00.013	0.0%	290	0.000	0.045	1.000
history write	00:39:12.047	2.7%	3087385	0.257	0.762	9.207
hiswrite/artcncl	00:00:00.024	0.0%	17	0.000	1.412	10.000
idle	12:10:42.696	50.8%	142205983	0.124	0.308	0.543
nntp read	01:16:20.662	5.3%	204022387	0.015	0.022	0.035
overview write	00:00:17.773	0.0%	3074348	0.001	0.006	0.012
perl filter	05:56:47.243	24.8%	3087382	4.996	6.934	9.468
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:28.274	0.4%	6448438	0.036	0.051	0.079
TOTAL: 23:59:27.607	23:08:52.249	96.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.214	0.0%	362435	0.000	0.003	0.111
article prepare	00:00:00.272	0.0%	1202858	0.000	0.000	0.013
article read	00:15:51.894	1.1%	300365	0.000	3.169	196.857
backlog stats	00:00:01.847	0.0%	1643556	0.000	0.001	0.028
callbacks	00:00:00.000	0.0%	12	0.000	0.000	0.000
data read	00:00:08.643	0.0%	677728	0.000	0.013	0.105
data write	00:02:30.843	0.2%	984184	0.000	0.153	1.613
idle	23:40:10.828	98.7%	1643556	14.785	51.845	8638.571
status file	00:00:01.324	0.0%	1626	0.000	0.814	3.000
TOTAL: 23:59:23.989	23:58:46.865	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:36:21.850	97.9%	14714	0.000	148.284	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.022	0.0%	30192	0.000	0.034	3.541
readart	00:00:28.957	1.3%	20805	0.000	1.392	1.427
TOTAL: 00:37:08.066	00:36:51.829	99.3%	-	-	-	-

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	1200	3077238	3059606	2953	14679	99%	399:24:16
2	news.nask.pl	2	34529	16906	4889	12734	48%	24:06:20
3	news.icm.edu.pl	47	284	53	209	22	18%	19:27:06
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		1251	3112052	3076566	8051	27435	98%	442:57:42

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	893.9 GB	2.1 GB	2.2 GB	898.2 GB	99%	306.3 KB
2	news.nask.pl	2.1 GB	7.8 MB	189.0 MB	2.3 GB	91%	79.7 KB
3	news.icm.edu.pl	912.8 KB	8.2 KB	707.1 KB	1.6 MB	56%	21.7 KB
4	localhost	1.6 KB	0.0 KB	0.0 KB	1.6 KB	100%	1.6 KB
TOTAL: 4		896.0 GB	2.1 GB	2.4 GB	900.4 GB	99%	304.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 26 04:15:02 - 04:59:59	94446	3.1%	35.01	26.6 GB	3.0%	10347.67
Mar 26 05:00:00 - 05:59:59	126068	4.1%	35.02	37.1 GB	4.1%	10792.92
Mar 26 06:00:00 - 06:59:59	128071	4.2%	35.58	36.8 GB	4.1%	10709.11
Mar 26 07:00:00 - 07:59:59	132097	4.3%	36.69	36.7 GB	4.1%	10676.81
Mar 26 08:00:00 - 08:59:59	122267	4.0%	33.96	35.0 GB	3.9%	10203.96
Mar 26 09:00:00 - 09:59:59	107202	3.5%	29.78	30.5 GB	3.4%	8876.62
Mar 26 10:00:00 - 10:59:59	115634	3.8%	32.12	36.7 GB	4.1%	10679.88
Mar 26 11:00:00 - 11:59:59	109188	3.6%	30.33	36.8 GB	4.1%	10728.68
Mar 26 12:00:00 - 12:59:59	103468	3.4%	28.74	36.7 GB	4.1%	10677.37
Mar 26 13:00:00 - 13:59:59	101347	3.3%	28.15	36.9 GB	4.1%	10751.48
Mar 26 14:00:00 - 14:59:59	111257	3.6%	30.90	37.8 GB	4.2%	11008.28
Mar 26 15:00:00 - 15:59:59	134665	4.4%	37.41	38.8 GB	4.3%	11290.43
Mar 26 16:00:00 - 16:59:59	138456	4.5%	38.46	38.4 GB	4.3%	11194.44
Mar 26 17:00:00 - 17:59:59	144494	4.7%	40.14	37.5 GB	4.2%	10929.35
Mar 26 18:00:00 - 18:59:59	140066	4.6%	38.91	37.2 GB	4.2%	10827.07
Mar 26 19:00:00 - 19:59:59	135095	4.4%	37.53	36.7 GB	4.1%	10683.49
Mar 26 20:00:00 - 20:59:59	145231	4.7%	40.34	39.7 GB	4.4%	11562.94
Mar 26 21:00:00 - 21:59:59	147189	4.8%	40.89	40.2 GB	4.5%	11703.53
Mar 26 22:00:00 - 22:59:59	138625	4.5%	38.51	38.3 GB	4.3%	11146.41
Mar 26 23:00:00 - 23:59:59	131471	4.3%	36.52	37.4 GB	4.2%	10886.10
Mar 27 00:00:00 - 00:59:59	117568	3.8%	32.66	34.4 GB	3.9%	10013.59
Mar 27 01:00:00 - 01:59:59	143166	4.7%	39.77	40.2 GB	4.5%	11709.88
Mar 27 02:00:00 - 02:59:59	147850	4.8%	41.07	41.4 GB	4.6%	12064.34
Mar 27 03:00:00 - 03:59:59	126780	4.1%	35.22	35.9 GB	4.0%	10470.39
Mar 27 04:00:00 - 04:15:02	33914	1.1%	37.60	9.4 GB	1.1%	10953.51
TOTAL: 24:00:00	3075615	100.0%	35.60	892.9 GB	100.0%	10836.94

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	14978	111	13815	0	1052
2	news.nask.pl	12990	13	459	1	12517
3	news.icm.edu.pl	32	0	1	0	31
TOTAL: 3		28000	124	14275	1	13600

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	57
it.tlc.cellulari.android	29
comp.mobile.android	19
it.comp.os.win.windows7	11
de.comp.os.os2	2
it.comp.virtualizzazione	1
it.comp.os.win.windows10	1
hr.ponuda.hardver.komponente	1
uk.rec.cycling.moderated	1
it.comp.os.win.windows8	1
alt.sex.telephones	1
TOTAL: 11	124

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)	11679
Binary in non-binary group	1084
Scoring filter (8)	55
Scoring filter (9)	38
Scoring filter (10)	16
Poison newsgroup	16
Excessively crossposted test article	15
Scoring filter (17)	5
Scoring filter (16)	5
Scoring filter (11)	3
Scoring filter (12)	2
Too many newsgroups	1
EMP (fsl)	1
Scoring filter (15)	1
TOTAL: 14	12921

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	325441	291638	25588	6126	20	33234	89%	24:00:47
2	panorama	48658	1808	43054	996	29	269519	3%	24:04:17
3	poznan	13273	148	8410	15	0	0	1%	24:04:24
4	nask	12992	146	7165	2295	0	0	1%	24:00:10
5	okapi	0	0	0	0	0	1170	0%	24:00:00
TOTAL: 5		400364	293740	84217	9432	49	303923	73%	120:09:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	52.4 GB	896.0 MB	53.2 GB	645.7 KB/s	187.5 KB	24:00:47
2	nask	32.4 MB	855.7 MB	888.1 MB	10.5 KB/s	372.6 KB	24:00:10
3	panorama	9.3 MB	15.2 MB	24.5 MB	0.3 KB/s	9.0 KB	24:04:17
4	poznan	589.0 KB	116.7 KB	705.8 KB	0.0 KB/s	4.3 KB	24:04:24
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		52.4 GB	1.7 GB	54.1 GB	131.2 KB/s	187.2 KB	120:09:38

Backlog files shrunk by innfeed:

Server	Size
panorama	22.9 MB
okapi	488.4 KB
TOTAL: 2	23.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	20	21.2 KB	10	0	00:00:25
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	20	21.2 KB	10	1	00:37:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	673	20	21.2 KB	10	1	00:00:31
2	*.dyn.optonline.net	2	0	0.0 KB	0	0	00:01:08
3	unresolved	2	0	0.0 KB	0	0	00:35:25
4	*.binaryedge.ninja	1	0	0.0 KB	0	0	00:00:01
TOTAL: 4		678	20	21.2 KB	10	1	00:37:07

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.41.33	0.661	0.921	00:35:25
ool-ae2c99f9.dyn.optonline.net	0.432	1.427	00:01:08
web.man.lodz.pl	0.928	4.990	00:00:25
mon.man.lodz.pl	0.904	4.817	00:00:04
min-01-31-27117-uk-b-prod.binaryedge.ninja	0.004	0.021	00:00:01
david.man.lodz.pl	0.277	1.443	00:00:01
isvcs01.man.lodz.pl	0.009	0.036	00:00:00
TOTAL: 7	3.215	13.655	00:37:07

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
89.38.41.33	2
ool-ae2c99f9.dyn.optonline.net	2
min-01-31-27117-uk-b-prod.binaryedge.ninja	1
TOTAL: 5	389

NNRP client timeouts [Top 20]:

System	Conn	Peer
89.38.41.33	1	1
TOTAL: 1	1	2

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	14
2	pl.comp.os.ms-windows.winnt	6
TOTAL: 2		20

Daily Usenet report

Mar 26 04:15:02 -- Mar 27 04:15:02