Daily Usenet report: Jul 22 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jul 22 11:08:40 newsfeed nnrpd[4805]: SERVER perl filter not defined
Jul 22 11:59:08 newsfeed nnrpd[6650]: SERVER perl filter not defined
Jul 22 16:19:23 newsfeed nnrpd[15599]: SERVER perl filter not defined
Jul 22 19:05:38 newsfeed nnrpd[21256]: SERVER perl filter not defined
Jul 22 19:41:52 newsfeed nnrpd[22537]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2517265	98.2%	289.7 MB	98.0%
innd	36273	1.4%	4.9 MB	1.6%
innfeed	4814	0.2%	666.9 KB	0.2%
nnrpd	4771	0.2%	493.4 KB	0.2%
TOTAL: 4	2563123	100.0%	295.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2508171	95.3%
Negative hits	103295	3.9%
Positive hits	19158	0.7%
Cache misses	114	0.0%
TOTAL: 4	2630738	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.534	0.0%	165	0.000	33.539	1020.000
article cleanup	00:00:41.428	0.0%	2517046	0.007	0.016	0.032
article logging	00:01:24.392	0.1%	2517631	0.016	0.034	0.508
article parse	01:07:24.554	4.7%	200261918	0.008	0.020	0.061
article write	00:22:07.661	1.5%	2494137	0.261	0.532	2.650
artlog/artcncl	00:00:00.006	0.0%	165	0.000	0.036	1.000
data move	00:02:42.016	0.2%	216348483	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.332	0.0%	145	0.000	2.290	166.000
hishave/artcncl	00:00:00.053	0.0%	165	0.000	0.321	2.222
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:30:04.488	2.1%	2633165	0.038	0.685	10.296
history sync	00:00:00.017	0.0%	290	0.000	0.059	1.000
history write	00:43:10.612	3.0%	2510593	0.130	1.032	17.900
hiswrite/artcncl	00:00:00.028	0.0%	20	0.000	1.400	16.000
idle	13:52:57.521	57.8%	151876720	0.119	0.329	0.588
nntp read	01:09:26.110	4.8%	198382205	0.012	0.021	0.041
overview write	00:00:15.019	0.0%	2494137	0.000	0.006	0.014
perl filter	05:09:36.291	21.5%	2510593	4.492	7.399	11.503
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:53.030	0.3%	5018103	0.039	0.058	0.103
TOTAL: 24:00:24.640	23:04:49.092	96.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.152	0.0%	45113	0.000	0.003	0.167
article prepare	00:00:00.009	0.0%	15394	0.000	0.001	0.125
article read	00:00:31.076	0.0%	3896	0.000	7.976	757.333
backlog stats	00:00:00.142	0.0%	184736	0.000	0.001	0.029
callbacks	00:00:00.000	0.0%	50	0.000	0.000	0.000
data read	00:00:01.345	0.0%	105094	0.000	0.013	0.167
data write	00:00:03.450	0.0%	79143	0.000	0.044	0.250
idle	23:58:45.865	100.0%	184736	43.745	467.293	5023.167
status file	00:00:00.653	0.0%	848	0.000	0.770	2.500
TOTAL: 23:59:27.373	23:59:22.692	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:28.373	66.8%	3044	0.000	9.321	1022.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.168	0.4%	6688	0.000	0.025	0.500
readart	00:00:00.033	0.1%	40	0.000	0.825	2.357
TOTAL: 00:00:42.487	00:00:28.574	67.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	1042	2493541	2479315	7717	6509	99%	314:08:46
2	news.nask.pl	2	35022	14179	4535	16308	40%	24:03:32
3	news.icm.edu.pl	39	567	53	433	81	9%	16:31:26
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		1089	2529135	2493552	12685	22898	98%	354:43:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	765.8 GB	37.9 MB	94.5 MB	765.9 GB	99%	323.1 KB
2	news.nask.pl	78.1 MB	1.7 MB	206.6 MB	286.4 MB	27%	9.6 KB
3	news.icm.edu.pl	5.0 MB	265.0 KB	1.8 MB	7.1 MB	70%	54.1 KB
4	localhost	6.6 KB	0.0 KB	0.0 KB	6.6 KB	100%	1.3 KB
TOTAL: 4		765.9 GB	39.9 MB	302.9 MB	766.2 GB	99%	319.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 22 04:15:03 - 04:59:59	65909	2.6%	24.44	23.5 GB	3.1%	9144.46
Jul 22 05:00:00 - 05:59:59	98204	3.9%	27.28	35.3 GB	4.6%	10279.46
Jul 22 06:00:00 - 06:59:59	101140	4.1%	28.09	36.5 GB	4.8%	10620.74
Jul 22 07:00:00 - 07:59:59	109663	4.4%	30.46	38.0 GB	5.0%	11079.25
Jul 22 08:00:00 - 08:59:59	119561	4.8%	33.21	38.7 GB	5.1%	11265.23
Jul 22 09:00:00 - 09:59:59	119737	4.8%	33.26	36.8 GB	4.8%	10714.73
Jul 22 10:00:00 - 10:59:59	118588	4.8%	32.94	36.8 GB	4.8%	10727.87
Jul 22 11:00:00 - 11:59:59	115023	4.6%	31.95	36.4 GB	4.8%	10611.04
Jul 22 12:00:00 - 12:59:59	112662	4.5%	31.30	36.4 GB	4.8%	10611.70
Jul 22 13:00:00 - 13:59:59	94076	3.8%	26.13	30.5 GB	4.0%	8894.50
Jul 22 14:00:00 - 14:59:59	107967	4.3%	29.99	34.4 GB	4.5%	10026.94
Jul 22 15:00:00 - 15:59:59	105496	4.2%	29.30	33.4 GB	4.4%	9715.24
Jul 22 16:00:00 - 16:59:59	113639	4.6%	31.57	35.8 GB	4.7%	10413.02
Jul 22 17:00:00 - 17:59:59	120987	4.9%	33.61	37.5 GB	4.9%	10917.74
Jul 22 18:00:00 - 18:59:59	127494	5.1%	35.41	36.0 GB	4.7%	10494.67
Jul 22 19:00:00 - 19:59:59	126008	5.1%	35.00	35.6 GB	4.6%	10364.80
Jul 22 20:00:00 - 20:59:59	95536	3.8%	26.54	27.3 GB	3.6%	7954.84
Jul 22 21:00:00 - 21:59:59	84362	3.4%	23.43	24.2 GB	3.2%	7034.69
Jul 22 22:00:00 - 22:59:59	70965	2.8%	19.71	23.3 GB	3.0%	6772.56
Jul 22 23:00:00 - 23:59:59	64646	2.6%	17.96	22.5 GB	2.9%	6552.43
Jul 23 00:00:00 - 00:59:59	64142	2.6%	17.82	19.4 GB	2.5%	5657.97
Jul 23 01:00:00 - 01:59:59	72411	2.9%	20.11	23.5 GB	3.1%	6837.81
Jul 23 02:00:00 - 02:59:59	127826	5.1%	35.51	28.1 GB	3.7%	8191.06
Jul 23 03:00:00 - 03:59:59	127979	5.1%	35.55	29.0 GB	3.8%	8440.13
Jul 23 04:00:00 - 04:15:02	29591	1.2%	32.81	6.6 GB	0.9%	7628.64
TOTAL: 23:59:59	2493612	100.0%	28.86	765.4 GB	100.0%	9289.30

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	16507	58	479	3	15967
2	newsfeed.pionier.net.pl	6900	164	5967	0	769
3	news.icm.edu.pl	81	0	3	0	78
TOTAL: 3		23488	222	6449	3	16814

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	113
comp.mobile.android	54
it.comp.os.win.windows10	23
comp.mobile.ipad	10
it.tlc.cellulari.android	8
it.comp.os.win.windows7	4
comp.sys.raspberry-pi	4
nl.comp.sys.android	2
alt.sex.telephones	1
de.rec.sf.startrek	1
de.comp.lang.vbclassic	1
gmane.comp.gis.openstreetmap.devel	1
TOTAL: 12	222

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

Groups	Count
bit.listserv.catholic	1
christnet.philosophy	1
pl.praca.oferowana	1
TOTAL: 3	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14721
Binary in non-binary group	767
Scoring filter (8)	243
PFM bot misc	212
EMP (phl)	170
Scoring filter (9)	35
Scoring filter (10)	22
Poison newsgroup	14
Scoring filter (13)	12
Scoring filter (11)	11
Scoring filter (12)	10
Scoring filter (21)	5
Scoring filter (23)	3
Scoring filter (22)	2
Scoring filter (16)	1
Scoring filter (14)	1
TOTAL: 16	16229

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	15422	898	12689	400	120	31041	5%	23:57:28
2	poznan	22488	190	13925	37	0	0	0%	23:55:40
3	icm	36046	154	26465	1939	0	0	0%	24:00:15
4	nask	9523	74	6114	1	0	0	0%	24:07:33
5	okapi	0	0	0	0	0	1950	0%	24:00:01
TOTAL: 5		83479	1316	59193	2377	120	32991	1%	120:00:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	5.9 MB	405.2 MB	411.1 MB	4.9 KB/s	201.1 KB	24:00:15
2	panorama	2.7 MB	2.1 MB	4.7 MB	0.1 KB/s	3.7 KB	23:57:28
3	poznan	1.2 MB	120.9 KB	1.3 MB	0.0 KB/s	5.7 KB	23:55:40
4	nask	703.4 KB	4.1 KB	707.5 KB	0.0 KB/s	9.4 KB	24:07:33
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		10.4 MB	407.4 MB	417.8 MB	1.0 KB/s	115.9 KB	120:00:57

Backlog files shrunk by innfeed:

Server	Size
panorama	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	287	26	22.4 KB	12	0	00:00:25
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:03
TOTAL: 2		292	26	22.4 KB	12	5	00:00:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	26	22.4 KB	12	5	00:00:33
2	*.neoplus.adsl.tpnet.pl	2	0	0.0 KB	0	0	00:00:06
3	unresolved	1	0	0.0 KB	0	0	00:00:02
TOTAL: 3		679	26	22.4 KB	12	5	00:00:42

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	0.977	5.054	00:00:25
abtz252.neoplus.adsl.tpnet.pl	0.003	0.040	00:00:06
mon.man.lodz.pl	0.957	4.208	00:00:03
isvcs01.man.lodz.pl	0.023	0.096	00:00:03
196.52.22.8	0.003	0.021	00:00:02
david.man.lodz.pl	0.275	1.366	00:00:01
TOTAL: 6	2.238	10.785	00:00:42

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
abtz252.neoplus.adsl.tpnet.pl	2
196.52.22.8	1
TOTAL: 4	387

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Jul 22 04:15:03 -- Jul 23 04:15:02