Daily Usenet report: Apr 26 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Apr 26 16:28:30 newsfeed nnrpd[9076]: SERVER perl filter not defined
Apr 26 17:57:22 newsfeed nnrpd[13249]: SERVER perl filter not defined
Apr 26 17:57:34 newsfeed nnrpd[13255]: SERVER perl filter not defined
Apr 26 17:57:42 newsfeed nnrpd[13256]: SERVER perl filter not defined
Apr 26 20:24:41 newsfeed overchan[1053]: input line too long, skipping
Apr 26 22:24:33 newsfeed overchan[1053]: input line too long, skipping
Apr 26 22:33:27 newsfeed nnrpd[23434]: SERVER perl filter not defined
Apr 27 03:03:48 newsfeed overchan[1053]: input line too long, skipping
Apr 27 03:04:06 newsfeed overchan[1053]: input line too long, skipping
Apr 27 03:04:24 newsfeed overchan[1053]: input line too long, skipping
Apr 27 03:04:43 newsfeed overchan[1053]: input line too long, skipping
Apr 27 03:05:39 newsfeed overchan[1053]: input line too long, skipping
Apr 27 03:07:39 newsfeed overchan[1053]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2133146	96.5%	248.0 MB	96.3%
innfeed	43558	2.0%	5.1 MB	2.0%
innd	29430	1.3%	4.0 MB	1.6%
nnrpd	4788	0.2%	503.3 KB	0.2%
overchan	9	0.0%	1.3 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	2210933	100.0%	257.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2099181	94.8%
Negative hits	96439	4.4%
Positive hits	18495	0.8%
Cache misses	132	0.0%
TOTAL: 4	2214247	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:04.213	0.0%	241	0.000	17.481	446.000
article cleanup	00:00:28.532	0.0%	2118379	0.010	0.013	0.020
article logging	00:01:25.840	0.1%	2118967	0.029	0.041	0.185
article parse	00:49:22.702	3.5%	181448586	0.010	0.016	0.026
article write	00:20:20.042	1.4%	2097176	0.403	0.582	1.153
artlog/artcncl	00:00:00.006	0.0%	234	0.000	0.026	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:07.329	0.2%	195080937	0.001	0.001	0.002
hisgrep/artcncl	00:00:01.566	0.0%	224	0.000	6.991	302.500
hishave/artcncl	00:00:00.259	0.0%	241	0.000	1.075	16.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:40:17.569	2.8%	2228514	0.107	1.085	5.137
history sync	00:00:00.014	0.0%	287	0.000	0.049	1.000
history write	01:40:08.212	7.0%	2111317	0.393	2.846	8.408
hiswrite/artcncl	00:00:00.090	0.0%	17	0.000	5.294	10.000
idle	14:47:15.288	62.0%	143009121	0.187	0.372	0.716
nntp read	01:07:02.420	4.7%	179857730	0.016	0.022	0.032
overview write	00:00:10.730	0.0%	2097176	0.003	0.005	0.010
perl filter	03:44:13.646	15.7%	2111317	5.700	6.372	7.184
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:18.231	0.2%	4231053	0.034	0.047	0.066
TOTAL: 23:50:03.838	23:17:16.689	97.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.232	0.0%	93534	0.000	0.002	0.012
article prepare	00:00:00.012	0.0%	33032	0.000	0.000	0.009
article read	00:00:43.253	0.1%	8163	0.000	5.299	110.250
backlog stats	00:00:00.189	0.0%	267361	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:02.323	0.0%	149257	0.002	0.016	0.037
data write	00:00:08.303	0.0%	114057	0.016	0.073	0.243
idle	23:52:37.191	99.9%	267361	40.826	321.502	731.174
status file	00:00:14.643	0.0%	16773	0.575	0.873	6.075
TOTAL: 23:53:59.471	23:53:46.146	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:28:59.928	99.3%	3048	0.000	570.843	430288.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.161	0.0%	6705	0.000	0.024	1.000
readart	00:00:00.001	0.0%	28	0.000	0.036	0.500
TOTAL: 00:29:12.397	00:29:00.090	99.3%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	992	2108942	2097009	4406	7527	99%	346:14:29
2	news.nask.pl	2	33501	12731	6796	13974	38%	23:56:01
3	news.icm.edu.pl	45	255	23	232	0	9%	16:47:08
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		1045	2142703	2109768	11434	21501	98%	386:57:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	647.7 GB	777.8 MB	889.7 MB	649.3 GB	99%	323.5 KB
2	news.nask.pl	1.0 GB	14.0 MB	192.0 MB	1.2 GB	83%	47.7 KB
3	news.icm.edu.pl	884.6 KB	0.0 KB	0.0 KB	884.6 KB	100%	38.5 KB
4	localhost	7.8 KB	0.0 KB	0.0 KB	7.8 KB	100%	1.6 KB
TOTAL: 4		648.7 GB	791.8 MB	1.1 GB	650.5 GB	99%	320.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 26 04:15:02 - 04:59:59	79851	3.8%	29.60	29.0 GB	4.5%	11275.50
Apr 26 05:00:00 - 05:59:59	112285	5.3%	31.19	37.8 GB	5.8%	11014.23
Apr 26 06:00:00 - 06:59:59	113922	5.4%	31.64	36.3 GB	5.6%	10568.66
Apr 26 07:00:00 - 07:59:59	108271	5.1%	30.08	33.8 GB	5.2%	9852.03
Apr 26 08:00:00 - 08:59:59	87136	4.1%	24.20	26.7 GB	4.1%	7786.58
Apr 26 09:00:00 - 09:59:59	56392	2.7%	15.66	16.5 GB	2.5%	4791.68
Apr 26 10:00:00 - 10:59:59	55536	2.6%	15.43	16.5 GB	2.5%	4799.42
Apr 26 11:00:00 - 11:59:59	51641	2.4%	14.34	16.0 GB	2.5%	4662.73
Apr 26 12:00:00 - 12:59:59	56274	2.7%	15.63	17.3 GB	2.7%	5042.88
Apr 26 13:00:00 - 13:59:59	98633	4.7%	27.40	30.4 GB	4.7%	8843.34
Apr 26 14:00:00 - 14:59:59	117255	5.6%	32.57	37.6 GB	5.8%	10946.74
Apr 26 15:00:00 - 15:59:59	108985	5.2%	30.27	34.9 GB	5.4%	10163.43
Apr 26 16:00:00 - 16:59:59	103164	4.9%	28.66	31.1 GB	4.8%	9070.33
Apr 26 17:00:00 - 17:59:59	120017	5.7%	33.34	36.3 GB	5.6%	10578.97
Apr 26 18:00:00 - 18:59:59	61443	2.9%	17.07	18.8 GB	2.9%	5487.82
Apr 26 19:00:00 - 19:59:59	59041	2.8%	16.40	17.0 GB	2.6%	4957.20
Apr 26 20:00:00 - 20:59:59	61906	2.9%	17.20	17.2 GB	2.7%	5017.75
Apr 26 21:00:00 - 21:59:59	64195	3.0%	17.83	17.3 GB	2.7%	5026.90
Apr 26 22:00:00 - 22:59:59	58219	2.8%	16.17	16.4 GB	2.5%	4766.66
Apr 26 23:00:00 - 23:59:59	94633	4.5%	26.29	27.9 GB	4.3%	8114.97
Apr 27 00:00:00 - 00:59:59	104703	5.0%	29.08	31.4 GB	4.8%	9136.34
Apr 27 01:00:00 - 01:59:59	123700	5.9%	34.36	37.0 GB	5.7%	10788.19
Apr 27 02:00:00 - 02:59:59	94198	4.5%	26.17	28.1 GB	4.3%	8196.08
Apr 27 03:00:00 - 03:59:59	97920	4.6%	27.20	30.2 GB	4.7%	8793.81
Apr 27 04:00:00 - 04:15:02	21487	1.0%	23.82	6.9 GB	1.1%	8067.31
TOTAL: 24:00:00	2110807	100.0%	24.43	648.5 GB	100.0%	7869.93

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	14116	6	602	2	13506
2	newsfeed.pionier.net.pl	7989	137	6659	2	1191
TOTAL: 2		22105	143	7261	4	14697

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	43
it.tlc.cellulari.android	41
it.comp.os.win.windows10	32
comp.mobile.android	11
it.comp.os.win.windows7	6
nl.comp.sys.android	3
hr.sci.med	2
comp.mobile.ipad	1
hr.rec.glazba.hifi	1
comp.sys.raspberry-pi	1
it.comp.virtualizzazione	1
de.rec.sf.startrek	1
TOTAL: 12	143

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12628
Binary in non-binary group	1078
Scoring filter (8)	154
EMP (phl)	99
Scoring filter (9)	65
Scoring filter (10)	30
Scoring filter (12)	12
Scoring filter (17)	7
Scoring filter (13)	5
HTML post	5
Scoring filter (16)	5
Excessively crossposted test article	4
Too many newsgroups	4
Poison newsgroup	3
EMP (fsl)	3
Adult group ECP	1
Scoring filter (14)	1
Scoring filter (15)	1
TOTAL: 18	14105

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	457
	news.nask.pl	135
	TOTAL: 2	592
TOTAL: 1		592

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	64173	2004	34004	317	4	57470	3%	23:58:58
2	icm	46400	273	30940	4820	0	0	0%	23:54:23
3	nask	16446	234	11445	2	0	0	1%	23:54:23
4	poznan	12309	111	8482	67	0	0	0%	23:54:23
5	okapi	0	0	0	0	0	1758	0%	23:52:17
TOTAL: 5		139328	2622	84871	5206	4	59228	1%	119:34:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	54.3 MB	505.4 KB	54.8 MB	0.7 KB/s	237.6 KB	23:54:23
2	icm	39.9 MB	1008.5 MB	1.0 GB	12.5 KB/s	210.8 KB	23:54:23
3	panorama	18.8 MB	1.6 MB	20.4 MB	0.2 KB/s	9.0 KB	23:58:58
4	poznan	546.5 KB	195.2 KB	741.7 KB	0.0 KB/s	4.2 KB	23:54:23
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:52:17
TOTAL: 5		113.6 MB	1010.8 MB	1.1 GB	2.7 KB/s	147.1 KB	119:34:24

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	28	27.3 KB	13	0	00:00:20
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 2		293	28	27.3 KB	13	5	00:29:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	677	28	27.3 KB	13	5	00:00:27
2	*.binaryedge.ninja	2	0	0.0 KB	0	0	00:00:03
3	unresolved	1	0	0.0 KB	0	0	00:28:41
TOTAL: 3		680	28	27.3 KB	13	5	00:29:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.2.183	0.004	0.008	00:28:41
web.man.lodz.pl	1.236	3.180	00:00:20
mon.man.lodz.pl	0.964	2.888	00:00:04
min-04-21-4025-uk-d-prod.binaryedge.ninja	0.008	0.000	00:00:01
min-extra-grab-29-uk-prod.binaryedge.ninja	0.008	0.024	00:00:01
david.man.lodz.pl	0.292	1.044	00:00:01
isvcs01.man.lodz.pl	0.032	0.032	00:00:00
TOTAL: 7	2.544	7.176	00:29:11

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
min-04-21-4025-uk-d-prod.binaryedge.ninja	1
212.191.2.183	1
min-extra-grab-29-uk-prod.binaryedge.ninja	1
TOTAL: 5	387

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	26
2	pl.comp.os.ms-windows.winnt	2
TOTAL: 2		28

Daily Usenet report

Apr 26 04:15:02 -- Apr 27 04:15:02