Daily Usenet report: Aug 25 04:15:04

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Aug 25 14:18:36 newsfeed nnrpd[24713]: SERVER perl filter not defined
Aug 25 14:26:01 newsfeed nnrpd[25050]: SERVER perl filter not defined
Aug 25 15:42:50 newsfeed overchan[32672]: input line too long, skipping
Aug 25 16:38:39 newsfeed overchan[32672]: input line too long, skipping
Aug 25 19:17:52 newsfeed overchan[32672]: input line too long, skipping
Aug 26 00:37:00 newsfeed overchan[32672]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1919883	96.4%	220.1 MB	96.0%
innfeed	48958	2.5%	5.8 MB	2.5%
innd	18295	0.9%	2.9 MB	1.3%
nnrpd	4745	0.2%	499.0 KB	0.2%
overchan	5	0.0%	0.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	1991887	100.0%	229.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1905820	95.4%
Negative hits	79094	4.0%
Positive hits	12056	0.6%
Cache misses	113	0.0%
TOTAL: 4	1997083	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.009	0.0%	228	0.000	17.583	358.000
article cleanup	00:00:29.256	0.0%	1919172	0.012	0.015	0.021
article logging	00:01:13.496	0.1%	1919731	0.031	0.038	0.074
article parse	00:56:39.616	3.9%	154114668	0.014	0.022	0.036
article write	00:18:18.099	1.3%	1911307	0.387	0.575	1.053
artlog/artcncl	00:00:00.005	0.0%	228	0.000	0.022	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:32.291	0.2%	166920515	0.001	0.001	0.002
hisgrep/artcncl	00:00:01.565	0.0%	223	0.000	7.018	139.444
hishave/artcncl	00:00:00.057	0.0%	228	0.000	0.250	2.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:32:02.691	2.2%	2007516	0.106	0.958	3.936
history sync	00:00:00.015	0.0%	291	0.000	0.052	1.000
history write	02:33:25.302	10.7%	1914790	1.578	4.807	10.271
hiswrite/artcncl	00:00:00.009	0.0%	5	0.000	1.800	9.000
idle	13:30:26.120	56.3%	119906453	0.264	0.406	0.775
nntp read	01:11:25.465	5.0%	152689262	0.017	0.028	0.044
overview write	00:00:09.802	0.0%	1911307	0.003	0.005	0.007
perl filter	04:01:28.909	16.8%	1914790	6.467	7.567	8.559
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:20.485	0.2%	3844810	0.041	0.052	0.068
TOTAL: 24:00:04.583	23:11:37.192	96.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.235	0.0%	67693	0.000	0.003	0.023
article prepare	00:00:00.002	0.0%	5662	0.000	0.000	0.036
article read	00:00:38.091	0.0%	1379	0.000	27.622	512.000
backlog stats	00:00:00.157	0.0%	178887	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	6	0.000	0.000	0.000
data read	00:00:01.939	0.0%	95957	0.007	0.020	0.036
data write	00:00:03.235	0.0%	73963	0.017	0.044	0.117
idle	23:53:10.025	99.9%	178887	146.109	480.695	959.308
status file	00:00:15.271	0.0%	16509	0.683	0.925	1.549
TOTAL: 23:54:20.578	23:54:08.955	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:27.310	71.3%	3021	0.000	9.040	9745.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.192	0.5%	6670	0.000	0.029	0.667
readart	00:00:00.001	0.0%	30	0.000	0.033	0.250
TOTAL: 00:00:38.315	00:00:27.503	71.8%	-	-	-	-

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	1178	1910481	1901492	4698	4291	99%	381:48:38
2	news.nask.pl	2	15792	9548	2701	3543	60%	24:20:38
3	news.icm.edu.pl	44	210	19	189	2	9%	17:13:18
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1227	1926485	1911061	7588	7836	99%	423:22:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	649.8 GB	78.3 MB	78.9 MB	650.0 GB	99%	357.6 KB
2	news.nask.pl	135.2 MB	13.0 MB	32.6 MB	180.8 MB	74%	14.1 KB
3	news.icm.edu.pl	492.9 KB	18.3 KB	18.3 KB	529.6 KB	93%	25.2 KB
4	localhost	2.7 KB	0.0 KB	0.0 KB	2.7 KB	100%	1.4 KB
TOTAL: 4		650.0 GB	91.2 MB	111.5 MB	650.2 GB	99%	355.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 25 04:15:04 - 04:59:59	55171	2.9%	20.46	20.2 GB	3.1%	7853.38
Aug 25 05:00:00 - 05:59:59	74604	3.9%	20.72	28.8 GB	4.4%	8395.00
Aug 25 06:00:00 - 06:59:59	81482	4.3%	22.63	28.7 GB	4.4%	8373.35
Aug 25 07:00:00 - 07:59:59	81106	4.2%	22.53	29.0 GB	4.5%	8450.38
Aug 25 08:00:00 - 08:59:59	76348	4.0%	21.21	28.1 GB	4.3%	8196.06
Aug 25 09:00:00 - 09:59:59	81386	4.3%	22.61	29.5 GB	4.5%	8582.29
Aug 25 10:00:00 - 10:59:59	76704	4.0%	21.31	27.8 GB	4.3%	8109.61
Aug 25 11:00:00 - 11:59:59	72914	3.8%	20.25	26.5 GB	4.1%	7712.03
Aug 25 12:00:00 - 12:59:59	85759	4.5%	23.82	30.1 GB	4.6%	8771.11
Aug 25 13:00:00 - 13:59:59	99491	5.2%	27.64	30.8 GB	4.7%	8969.97
Aug 25 14:00:00 - 14:59:59	109086	5.7%	30.30	31.4 GB	4.8%	9143.46
Aug 25 15:00:00 - 15:59:59	76634	4.0%	21.29	23.4 GB	3.6%	6821.99
Aug 25 16:00:00 - 16:59:59	75316	3.9%	20.92	24.0 GB	3.7%	7002.83
Aug 25 17:00:00 - 17:59:59	82800	4.3%	23.00	26.4 GB	4.1%	7704.04
Aug 25 18:00:00 - 18:59:59	58368	3.1%	16.21	20.0 GB	3.1%	5820.58
Aug 25 19:00:00 - 19:59:59	85024	4.4%	23.62	28.7 GB	4.4%	8373.16
Aug 25 20:00:00 - 20:59:59	50318	2.6%	13.98	17.4 GB	2.7%	5064.13
Aug 25 21:00:00 - 21:59:59	49963	2.6%	13.88	18.2 GB	2.8%	5307.88
Aug 25 22:00:00 - 22:59:59	74555	3.9%	20.71	25.7 GB	4.0%	7490.42
Aug 25 23:00:00 - 23:59:59	95949	5.0%	26.65	31.6 GB	4.9%	9209.37
Aug 26 00:00:00 - 00:59:59	86473	4.5%	24.02	28.1 GB	4.3%	8195.47
Aug 26 01:00:00 - 01:59:59	96439	5.0%	26.79	31.4 GB	4.8%	9152.84
Aug 26 02:00:00 - 02:59:59	81789	4.3%	22.72	28.1 GB	4.3%	8174.27
Aug 26 03:00:00 - 03:59:59	82312	4.3%	22.86	27.6 GB	4.2%	8024.71
Aug 26 04:00:00 - 04:15:02	21240	1.1%	23.55	7.4 GB	1.1%	8553.60
TOTAL: 23:59:58	1911231	100.0%	22.12	649.1 GB	100.0%	7878.07

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4685	156	4078	0	451
2	news.nask.pl	3736	24	302	1	3409
3	news.icm.edu.pl	3	0	2	0	1
TOTAL: 3		8424	180	4382	1	3861

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	111
comp.mobile.android	31
it.tlc.cellulari.android	17
it.comp.os.win.windows10	14
de.comp.lang.vbclassic	3
de.rec.sf.startrek	1
comp.mobile.ipad	1
it.tlc.cellulari.iphone	1
it.comp.os.win.windows7	1
TOTAL: 9	180

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)	3135
Binary in non-binary group	125
Scoring filter (8)	15
HTML post	9
Too many newsgroups	5
Scoring filter (9)	5
Scoring filter (10)	3
Poison newsgroup	2
Scoring filter (11)	1
Attached HTML file	1
Scoring filter (14)	1
TOTAL: 11	3302

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	393
	news.nask.pl	165
	news.icm.edu.pl	1
	TOTAL: 3	559
TOTAL: 1		559

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	poznan	14723	386	8711	24	0	0	2%	23:59:56
2	panorama	48243	291	20321	154	7	46860	0%	23:59:56
3	icm	27363	103	19823	50	0	0	0%	23:59:56
4	nask	5940	58	4328	0	0	0	0%	23:59:56
5	okapi	0	0	0	0	0	2146	0%	23:57:49
TOTAL: 5		96269	838	53183	228	7	49006	0%	119:57:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	13.0 MB	0.0 KB	13.0 MB	0.2 KB/s	228.9 KB	23:59:56
2	icm	11.0 MB	13.1 MB	24.1 MB	0.3 KB/s	161.3 KB	23:59:56
3	panorama	1.5 MB	509.7 KB	2.0 MB	0.0 KB/s	4.5 KB	23:59:56
4	poznan	1.1 MB	219.9 KB	1.4 MB	0.0 KB/s	3.4 KB	23:59:56
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		26.6 MB	13.8 MB	40.4 MB	0.1 KB/s	38.8 KB	119:57:33

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	30	35.0 KB	10	0	00:00:22
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		290	30	35.0 KB	10	2	00:00:37

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	674	30	35.0 KB	10	2	00:00:27
2	unresolved	1	0	0.0 KB	0	0	00:00:09
TOTAL: 2		675	30	35.0 KB	10	2	00:00:37

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.248	4.236	00:00:22
45.55.22.8	0.004	0.012	00:00:09
mon.man.lodz.pl	1.292	4.300	00:00:03
david.man.lodz.pl	0.352	1.416	00:00:01
isvcs01.man.lodz.pl	0.024	0.032	00:00:00
TOTAL: 5	2.920	9.996	00:00:37

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
45.55.22.8	1
TOTAL: 3	385

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	16
2	pl.comp.pecet	14
TOTAL: 2		30

Daily Usenet report

Aug 25 04:15:04 -- Aug 26 04:15:02