Daily Usenet report: Oct 12 04:15:01

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Oct 12 09:38:12 newsfeed nnrpd[12172]: SERVER perl filter not defined
Oct 12 09:44:21 newsfeed nnrpd[12424]: SERVER perl filter not defined
Oct 12 09:45:07 newsfeed nnrpd[12490]: SERVER perl filter not defined
Oct 12 09:49:43 newsfeed nnrpd[12542]: SERVER perl filter not defined
Oct 12 10:06:47 newsfeed nnrpd[13315]: SERVER perl filter not defined
Oct 12 10:20:42 newsfeed nnrpd[13891]: SERVER perl filter not defined
Oct 12 11:09:22 newsfeed nnrpd[15403]: SERVER perl filter not defined
Oct 12 20:23:31 newsfeed overchan[2629]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2926363	98.5%	342.3 MB	98.3%
innd	34578	1.2%	4.8 MB	1.4%
innfeed	4898	0.2%	705.6 KB	0.2%
nnrpd	4854	0.2%	503.1 KB	0.1%
overchan	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2970695	100.0%	348.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2916926	96.4%
Negative hits	94022	3.1%
Positive hits	15155	0.5%
Cache misses	119	0.0%
TOTAL: 4	3026222	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.044	0.0%	188	0.000	16.191	229.667
article cleanup	00:00:44.190	0.1%	2923696	0.007	0.015	0.029
article logging	00:01:32.564	0.1%	2924405	0.015	0.032	0.765
article parse	01:19:18.579	5.5%	206375877	0.012	0.023	0.076
article write	00:27:01.471	1.9%	2907447	0.307	0.558	3.598
artlog/artcncl	00:00:00.005	0.0%	181	0.000	0.028	0.333
data move	00:03:01.377	0.2%	224334626	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.802	0.0%	172	0.000	4.663	22.000
hishave/artcncl	00:00:00.032	0.0%	188	0.000	0.170	2.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:24:56.750	1.7%	3029331	0.082	0.494	8.273
history sync	00:00:00.017	0.0%	290	0.000	0.059	1.000
history write	00:35:21.507	2.5%	2919881	0.177	0.727	8.869
hiswrite/artcncl	00:00:00.019	0.0%	16	0.000	1.188	16.000
idle	13:13:14.547	55.2%	146072680	0.142	0.326	0.853
nntp read	01:12:04.738	5.0%	204046200	0.014	0.021	0.039
overview write	00:00:16.293	0.0%	2907447	0.000	0.006	0.013
perl filter	06:01:44.729	25.2%	2919881	5.458	7.433	10.817
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:47.706	0.3%	5862842	0.028	0.049	0.091
TOTAL: 23:58:19.920	23:24:08.370	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.220	0.0%	63293	0.000	0.003	0.143
article prepare	00:00:00.021	0.0%	100866	0.000	0.000	0.008
article read	00:00:57.051	0.1%	22846	0.000	2.497	463.000
backlog stats	00:00:00.277	0.0%	321122	0.000	0.001	0.037
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:02.407	0.0%	159420	0.000	0.015	0.214
data write	00:00:16.654	0.0%	162649	0.000	0.102	0.290
idle	23:56:46.064	99.9%	321122	15.579	268.453	3363.050
status file	00:00:00.762	0.0%	1003	0.000	0.760	3.000
TOTAL: 23:58:11.429	23:58:03.456	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:43:01.564	99.5%	12808	0.000	201.559	21541.600
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.550	0.0%	26298	0.000	0.021	0.500
readart	00:00:00.446	0.0%	63	0.000	7.079	21.143
TOTAL: 00:43:14.677	00:43:02.560	99.5%	-	-	-	-

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	1109	2904187	2894286	5999	3902	99%	329:55:00
2	news.nask.pl	2	31268	13961	5080	12227	44%	23:52:28
3	news.icm.edu.pl	49	208	7	196	5	3%	16:46:36
4	localhost	8	7	7	0	0	100%	00:00:02
TOTAL: 4		1168	2935670	2908261	11275	16134	99%	370:34:06

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	854.1 GB	74.0 MB	124.3 MB	854.3 GB	99%	309.1 KB
2	news.nask.pl	118.9 MB	8.2 MB	179.2 MB	306.3 MB	38%	12.0 KB
3	news.icm.edu.pl	198.0 KB	17.9 KB	163.2 KB	379.2 KB	52%	31.6 KB
4	localhost	11.0 KB	0.0 KB	0.0 KB	11.0 KB	100%	1.6 KB
TOTAL: 4		854.2 GB	82.2 MB	303.6 MB	854.6 GB	99%	306.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 12 04:15:01 - 04:59:59	120726	4.1%	44.73	31.5 GB	3.7%	12241.05
Oct 12 05:00:00 - 05:59:59	150039	5.2%	41.68	39.6 GB	4.6%	11538.46
Oct 12 06:00:00 - 06:59:59	129533	4.5%	35.98	35.3 GB	4.1%	10292.93
Oct 12 07:00:00 - 07:59:59	155200	5.3%	43.11	40.6 GB	4.8%	11828.83
Oct 12 08:00:00 - 08:59:59	126519	4.3%	35.14	35.3 GB	4.1%	10274.91
Oct 12 09:00:00 - 09:59:59	137201	4.7%	38.11	37.7 GB	4.4%	10982.33
Oct 12 10:00:00 - 10:59:59	104892	3.6%	29.14	31.3 GB	3.7%	9104.89
Oct 12 11:00:00 - 11:59:59	104152	3.6%	28.93	31.7 GB	3.7%	9246.64
Oct 12 12:00:00 - 12:59:59	101593	3.5%	28.22	33.3 GB	3.9%	9706.31
Oct 12 13:00:00 - 13:59:59	115260	4.0%	32.02	36.5 GB	4.3%	10619.84
Oct 12 14:00:00 - 14:59:59	121672	4.2%	33.80	37.1 GB	4.3%	10808.31
Oct 12 15:00:00 - 15:59:59	128970	4.4%	35.83	40.9 GB	4.8%	11904.96
Oct 12 16:00:00 - 16:59:59	122299	4.2%	33.97	40.9 GB	4.8%	11903.07
Oct 12 17:00:00 - 17:59:59	112148	3.9%	31.15	34.7 GB	4.1%	10094.08
Oct 12 18:00:00 - 18:59:59	143896	4.9%	39.97	40.2 GB	4.7%	11723.25
Oct 12 19:00:00 - 19:59:59	117020	4.0%	32.51	36.3 GB	4.3%	10571.94
Oct 12 20:00:00 - 20:59:59	104727	3.6%	29.09	28.4 GB	3.3%	8259.46
Oct 12 21:00:00 - 21:59:59	113882	3.9%	31.63	28.9 GB	3.4%	8406.13
Oct 12 22:00:00 - 22:59:59	134297	4.6%	37.30	35.5 GB	4.2%	10337.38
Oct 12 23:00:00 - 23:59:59	132212	4.5%	36.73	39.0 GB	4.6%	11355.05
Oct 13 00:00:00 - 00:59:59	100168	3.4%	27.82	30.5 GB	3.6%	8874.18
Oct 13 01:00:00 - 01:59:59	97791	3.4%	27.16	32.7 GB	3.8%	9521.65
Oct 13 02:00:00 - 02:59:59	101449	3.5%	28.18	33.0 GB	3.9%	9599.02
Oct 13 03:00:00 - 03:59:59	103130	3.5%	28.65	33.2 GB	3.9%	9674.91
Oct 13 04:00:00 - 04:15:02	30444	1.0%	33.75	9.6 GB	1.1%	11152.37
TOTAL: 24:00:01	2909220	100.0%	33.67	853.5 GB	100.0%	10358.22

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12584	25	405	3	12151
2	newsfeed.pionier.net.pl	4373	186	3408	1	778
3	news.icm.edu.pl	5	0	2	0	3
TOTAL: 3		16962	211	3815	4	12932

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	108
it.tlc.cellulari.android	31
it.comp.os.win.windows10	27
comp.mobile.ipad	16
comp.mobile.android	15
it.comp.os.win.windows7	7
uk.rec.cycling.moderated	7
TOTAL: 7	211

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11152
Binary in non-binary group	601
Scoring filter (8)	231
Scoring filter (9)	60
Scoring filter (10)	32
HTML post	27
Scoring filter (13)	18
EMP (fsl)	18
Scoring filter (11)	17
Scoring filter (20)	15
EMP (phl)	13
Poison newsgroup	8
Too many newsgroups	8
Scoring filter (12)	8
Scoring filter (19)	6
Scoring filter (18)	5
Too many newsgroups (low_xpost)	2
Scoring filter (14)	1
TOTAL: 18	12222

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	19048	3125	11602	2800	5	45488	16%	23:54:14
2	icm	57464	470	28419	18343	0	0	0%	24:00:02
3	poznan	20125	170	13734	31	0	0	0%	24:00:02
4	nask	10049	57	6509	3	0	0	0%	24:00:01
5	okapi	0	0	0	0	0	2012	0%	24:00:02
TOTAL: 5		106686	3822	60264	21177	5	47500	3%	119:54:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	29.2 MB	578.6 MB	607.8 MB	7.2 KB/s	105.0 KB	23:54:14
2	icm	4.1 MB	4.4 GB	4.4 GB	53.5 KB/s	245.9 KB	24:00:02
3	poznan	991.7 KB	346.4 KB	1.3 MB	0.0 KB/s	6.7 KB	24:00:02
4	nask	434.2 KB	47.2 KB	481.4 KB	0.0 KB/s	8.0 KB	24:00:01
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		34.7 MB	5.0 GB	5.0 GB	12.2 KB/s	210.0 KB	119:54:21

Backlog files shrunk by innfeed:

Server	Size
panorama	1.9 MB
okapi	488.3 KB
TOTAL: 2	2.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	42	43.7 KB	20	0	00:00:20
2	lze200.lze.lodz.pl	2	21	80.9 KB	4	0	00:07:11
3	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	00:00:00
TOTAL: 3		297	63	124.6 KB	24	7	00:43:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	679	42	43.7 KB	20	7	00:00:25
2	*.lze.lodz.pl	2	21	80.9 KB	4	0	00:07:11
3	unresolved	5	0	0.0 KB	0	0	00:35:37
TOTAL: 3		686	63	124.6 KB	24	7	00:43:14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.133	0.554	0.724	00:34:40
lze200.lze.lodz.pl	0.003	0.035	00:07:11
61.149.195.59	0.006	0.016	00:00:57
web.man.lodz.pl	0.925	3.571	00:00:20
mon.man.lodz.pl	0.968	3.048	00:00:03
david.man.lodz.pl	0.364	1.036	00:00:01
isvcs01.man.lodz.pl	0.047	0.086	00:00:00
TOTAL: 7	2.867	8.516	00:43:14

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.133	3
61.149.195.59	2
TOTAL: 4	389

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	24
2	pl.comp.pecet	22
3	pl.misc.telefonia.gsm	14
4	pl.rec.dom	2
5	pl.rec.kuchnia	1
TOTAL: 5		63

Daily Usenet report

Oct 12 04:15:01 -- Oct 13 04:15:02