Daily Usenet report: Dec 23 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Dec 23 08:43:18 newsfeed nnrpd[22037]: SERVER perl filter not defined
Dec 23 20:30:49 newsfeed overchan[11122]: input line too long, skipping
Dec 23 22:37:14 newsfeed overchan[11122]: input line too long, skipping
Dec 23 22:37:46 newsfeed overchan[11122]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2296075	97.1%	268.6 MB	96.8%
innfeed	45918	1.9%	5.5 MB	2.0%
innd	16817	0.7%	2.8 MB	1.0%
nnrpd	4842	0.2%	518.0 KB	0.2%
overchan	4	0.0%	0.7 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	2363657	100.0%	277.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2275657	95.3%
Positive hits	64208	2.7%
Negative hits	46343	1.9%
Cache misses	1238	0.1%
TOTAL: 4	2387446	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.481	0.0%	89	0.000	50.348	278.000
article cleanup	00:00:28.024	0.0%	2295809	0.009	0.012	0.017
article logging	00:01:42.956	0.1%	2296274	0.031	0.045	0.084
article parse	00:41:32.228	2.9%	75943416	0.018	0.033	0.048
article write	00:16:45.154	1.2%	2287599	0.296	0.439	0.703
artlog/artcncl	00:00:00.005	0.0%	88	0.000	0.057	1.000
artlog/artparse	00:00:00.000	0.0%	5	0.000	0.000	0.000
data move	00:02:21.728	0.2%	89062121	0.001	0.002	0.005
hisgrep/artcncl	00:00:01.501	0.0%	86	0.000	17.453	51.889
hishave/artcncl	00:00:00.178	0.0%	89	0.000	2.000	6.375
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:39:53.656	11.1%	2404200	1.187	3.990	7.199
history sync	00:00:00.010	0.0%	290	0.000	0.034	0.500
history write	05:43:51.832	23.9%	2289471	4.229	9.012	16.571
hiswrite/artcncl	00:00:00.024	0.0%	3	0.000	8.000	23.000
idle	09:11:55.415	38.3%	46936410	0.256	0.706	1.954
nntp read	00:53:01.794	3.7%	74115004	0.033	0.043	0.060
overview write	00:00:11.633	0.0%	2287599	0.003	0.005	0.008
perl filter	04:01:41.559	16.8%	2289464	4.401	6.334	8.356
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:54.619	0.3%	4757038	0.045	0.062	0.082
TOTAL: 24:00:02.088	23:38:26.797	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.225	0.0%	411635	0.000	0.003	0.015
article prepare	00:00:00.094	0.0%	456462	0.000	0.000	0.050
article read	00:06:55.363	0.5%	111528	0.000	3.724	103.000
backlog stats	00:00:01.346	0.0%	1583113	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:13.352	0.0%	725342	0.009	0.018	0.075
data write	00:03:13.442	0.2%	896440	0.016	0.216	0.456
idle	23:42:01.089	99.2%	1583113	12.614	53.895	907.295
status file	00:00:23.870	0.0%	16453	0.873	1.451	16.000
TOTAL: 23:53:34.091	23:52:49.781	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:04:14.454	95.5%	3021	0.000	84.228	30283.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.327	0.1%	6748	0.000	0.048	1.474
readart	00:00:00.003	0.0%	30	0.000	0.100	1.000
TOTAL: 00:04:26.533	00:04:14.784	95.6%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	193

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	755	2287728	2283718	305	3705	99%	481:51:14
2	news.nask.pl	2	70662	3563	62584	4515	5%	24:16:59
3	news.icm.edu.pl	45	227	41	141	45	18%	16:00:28
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		804	2358618	2287323	63030	8265	96%	522:08:41

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	698.1 GB	495.3 MB	559.3 MB	699.1 GB	99%	320.5 KB
2	news.nask.pl	534.1 MB	561.6 MB	584.3 MB	1.6 GB	31%	213.0 KB
3	news.icm.edu.pl	941.7 KB	71.6 KB	2.7 MB	3.6 MB	25%	43.4 KB
4	localhost	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
TOTAL: 4		698.6 GB	1.0 GB	1.1 GB	700.7 GB	99%	320.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 23 04:15:02 - 04:59:59	72048	3.1%	26.70	28.0 GB	4.0%	10867.74
Dec 23 05:00:00 - 05:59:59	96635	4.2%	26.84	36.6 GB	5.2%	10656.59
Dec 23 06:00:00 - 06:59:59	112767	4.9%	31.32	39.6 GB	5.7%	11523.57
Dec 23 07:00:00 - 07:59:59	98657	4.3%	27.40	35.6 GB	5.1%	10367.78
Dec 23 08:00:00 - 08:59:59	103916	4.5%	28.87	36.8 GB	5.3%	10726.25
Dec 23 09:00:00 - 09:59:59	95265	4.2%	26.46	33.4 GB	4.8%	9727.63
Dec 23 10:00:00 - 10:59:59	92201	4.0%	25.61	31.2 GB	4.5%	9084.78
Dec 23 11:00:00 - 11:59:59	115681	5.1%	32.13	32.6 GB	4.7%	9502.56
Dec 23 12:00:00 - 12:59:59	90487	4.0%	25.14	26.5 GB	3.8%	7714.70
Dec 23 13:00:00 - 13:59:59	100628	4.4%	27.95	29.6 GB	4.2%	8609.33
Dec 23 14:00:00 - 14:59:59	114876	5.0%	31.91	33.3 GB	4.8%	9687.69
Dec 23 15:00:00 - 15:59:59	108613	4.7%	30.17	33.3 GB	4.8%	9693.79
Dec 23 16:00:00 - 16:59:59	102853	4.5%	28.57	33.5 GB	4.8%	9749.41
Dec 23 17:00:00 - 17:59:59	89443	3.9%	24.85	28.2 GB	4.0%	8214.15
Dec 23 18:00:00 - 18:59:59	108996	4.8%	30.28	29.7 GB	4.3%	8658.72
Dec 23 19:00:00 - 19:59:59	86622	3.8%	24.06	21.5 GB	3.1%	6273.50
Dec 23 20:00:00 - 20:59:59	70286	3.1%	19.52	19.0 GB	2.7%	5539.54
Dec 23 21:00:00 - 21:59:59	88030	3.8%	24.45	24.8 GB	3.5%	7211.89
Dec 23 22:00:00 - 22:59:59	111074	4.9%	30.85	31.0 GB	4.4%	9023.51
Dec 23 23:00:00 - 23:59:59	96789	4.2%	26.89	27.7 GB	4.0%	8070.66
Dec 24 00:00:00 - 00:59:59	68186	3.0%	18.94	13.3 GB	1.9%	3872.34
Dec 24 01:00:00 - 01:59:59	91594	4.0%	25.44	24.1 GB	3.5%	7015.35
Dec 24 02:00:00 - 02:59:59	80372	3.5%	22.33	23.3 GB	3.3%	6787.24
Dec 24 03:00:00 - 03:59:59	73474	3.2%	20.41	20.4 GB	2.9%	5933.99
Dec 24 04:00:00 - 04:15:04	17808	0.8%	19.70	5.2 GB	0.7%	6036.01
TOTAL: 24:00:02	2287301	100.0%	26.47	698.0 GB	100.0%	8470.86

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	4518	5	3312	1	1200
2	newsfeed.pionier.net.pl	4122	198	3023	0	901
3	news.icm.edu.pl	46	0	3	0	43
TOTAL: 3		8686	203	6338	1	2144

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	124
it.comp.os.win.windows10	54
it.tlc.cellulari.android	9
comp.sys.raspberry-pi	8
comp.mobile.ipad	5
alt.fr.rec.tv.internet	1
comp.mobile.android	1
it.comp.os.win.windows8	1
TOTAL: 8	203

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)	881
Binary in non-binary group	615
Poison newsgroup	103
EMP (phl)	33
Scoring filter (16)	14
Scoring filter (8)	12
Scoring filter (10)	3
Scoring filter (9)	3
Scoring filter (11)	3
Too many newsgroups	1
Scoring filter (14)	1
HTML post	1
TOTAL: 12	1670

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	newsfeed.pionier.net.pl	2
	TOTAL: 1	2
Including strange strings
	newsfeed.pionier.net.pl	418
	news.nask.pl	48
	news.icm.edu.pl	1
	TOTAL: 3	467
TOTAL: 2		469

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	nask	205148	106283	63429	682	0	15262	51%	23:59:59
2	panorama	226897	690	198703	262	3	196976	0%	23:59:59
3	poznan	3018	51	2152	9	0	0	1%	23:54:40
4	icm	192251	25	175331	5680	0	0	0%	23:59:56
5	okapi	0	0	0	0	0	872	0%	23:57:52
TOTAL: 5		627314	107049	439615	6633	3	213110	17%	119:52:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	39.6 GB	260.0 MB	39.8 GB	483.1 KB/s	390.2 KB	23:59:59
2	panorama	3.7 MB	2.4 MB	6.1 MB	0.1 KB/s	6.6 KB	23:59:59
3	icm	710.6 KB	2.1 GB	2.1 GB	25.6 KB/s	387.5 KB	23:59:56
4	poznan	146.3 KB	41.5 KB	187.9 KB	0.0 KB/s	3.1 KB	23:54:40
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:52
TOTAL: 5		39.6 GB	2.4 GB	41.9 GB	101.9 KB/s	386.7 KB	119:52:26

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	30	27.3 KB	14	0	00:00:18
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	30	27.3 KB	14	1	00:04:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	577	30	27.3 KB	14	1	00:00:22
2	unresolved	96	0	0.0 KB	0	0	00:00:01
3	*.kleczek.org	2	0	0.0 KB	0	0	00:04:01
TOTAL: 3		675	30	27.3 KB	14	1	00:04:25

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
b15.kleczek.org	0.076	0.064	00:04:01
web.man.lodz.pl	1.304	5.520	00:00:18
mon.man.lodz.pl	1.284	5.248	00:00:03
212.51.192.185	0.448	1.924	00:00:01
isvcs01.man.lodz.pl	0.000	0.024	00:00:00
TOTAL: 5	3.112	12.780	00:04:25

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	96
b15.kleczek.org	2
TOTAL: 3	386

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	22
2	pl.comp.pecet	8
TOTAL: 2		30

Daily Usenet report

Dec 23 04:15:02 -- Dec 24 04:15:04