Daily Usenet report: Sep 26 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 26 08:57:35 newsfeed nnrpd[10030]: SERVER perl filter not defined
Sep 26 14:21:41 newsfeed nnrpd[21446]: SERVER perl filter not defined
Sep 26 14:26:13 newsfeed nnrpd[21542]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2997727	98.4%	342.5 MB	98.2%
innd	37556	1.2%	5.3 MB	1.5%
innfeed	4834	0.2%	673.8 KB	0.2%
nnrpd	4825	0.2%	502.9 KB	0.1%
TOTAL: 4	3044942	100.0%	348.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2990541	96.7%
Negative hits	85483	2.8%
Positive hits	16067	0.5%
Cache misses	140	0.0%
TOTAL: 4	3092231	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.559	0.0%	422	0.000	8.434	123.000
article cleanup	00:00:44.411	0.1%	2998252	0.006	0.015	0.034
article logging	00:01:35.420	0.1%	2998780	0.016	0.032	0.836
article parse	01:17:42.749	5.4%	198013944	0.011	0.024	0.079
article write	00:34:17.465	2.4%	2978428	0.348	0.691	3.450
artlog/artcncl	00:00:00.003	0.0%	182	0.000	0.016	0.333
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:41.088	0.2%	216349678	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.184	0.0%	405	0.000	0.454	13.000
hishave/artcncl	00:00:00.031	0.0%	422	0.000	0.073	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:29:58.502	2.1%	3093813	0.181	0.581	8.146
history sync	00:00:00.022	0.0%	293	0.000	0.075	1.000
history write	00:39:46.021	2.8%	2992391	0.067	0.797	9.066
hiswrite/artcncl	00:00:00.012	0.0%	17	0.000	0.706	7.000
idle	12:37:42.545	52.6%	139519164	0.168	0.326	1.233
nntp read	01:11:33.276	5.0%	195688584	0.014	0.022	0.047
overview write	00:00:16.734	0.0%	2978428	0.000	0.006	0.013
perl filter	06:02:08.461	25.1%	2992391	5.284	7.261	10.606
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:57.988	0.3%	5999983	0.032	0.050	0.103
TOTAL: 24:00:26.262	23:03:28.471	96.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.180	0.0%	51970	0.000	0.003	0.118
article prepare	00:00:00.022	0.0%	75278	0.000	0.000	0.036
article read	00:00:07.307	0.0%	18821	0.000	0.388	138.000
backlog stats	00:00:00.271	0.0%	265354	0.000	0.001	0.020
callbacks	00:00:00.000	0.0%	6	0.000	0.000	0.000
data read	00:00:02.035	0.0%	138168	0.000	0.015	0.087
data write	00:00:14.357	0.0%	123710	0.000	0.116	0.363
idle	23:59:25.041	100.0%	265354	65.348	325.471	7039.333
status file	00:00:00.613	0.0%	844	0.000	0.726	4.333
TOTAL: 23:59:56.672	23:59:49.826	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:34:01.564	99.8%	16068	0.000	351.106	165457.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.794	0.0%	32890	0.000	0.024	3.700
readart	00:00:00.054	0.0%	89	0.000	0.607	7.400
TOTAL: 01:34:14.919	01:34:02.412	99.8%	-	-	-	-

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	1413	2978498	2967019	4793	6686	99%	384:22:10
2	news.nask.pl	2	27889	10179	4790	12920	36%	23:38:08
3	news.icm.edu.pl	35	526	15	310	201	2%	15:23:45
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		1454	3006916	2977216	9893	19807	99%	423:24:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	861.8 GB	92.9 MB	265.7 MB	862.1 GB	99%	304.0 KB
2	news.nask.pl	103.4 MB	3.5 MB	207.4 MB	314.4 MB	32%	13.9 KB
3	news.icm.edu.pl	522.0 KB	610.1 KB	21.4 MB	22.5 MB	2%	106.8 KB
4	localhost	3.9 KB	0.0 KB	0.0 KB	3.9 KB	100%	1.3 KB
TOTAL: 4		861.9 GB	97.1 MB	494.5 MB	862.5 GB	99%	301.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 26 04:15:02 - 04:59:59	87972	3.0%	32.61	27.7 GB	3.2%	10746.72
Sep 26 05:00:00 - 05:59:59	111799	3.8%	31.06	36.9 GB	4.3%	10740.02
Sep 26 06:00:00 - 06:59:59	115276	3.9%	32.02	36.8 GB	4.3%	10723.17
Sep 26 07:00:00 - 07:59:59	123194	4.1%	34.22	39.2 GB	4.6%	11420.48
Sep 26 08:00:00 - 08:59:59	131761	4.4%	36.60	39.6 GB	4.6%	11526.93
Sep 26 09:00:00 - 09:59:59	123924	4.2%	34.42	37.9 GB	4.4%	11044.18
Sep 26 10:00:00 - 10:59:59	138225	4.6%	38.40	37.8 GB	4.4%	11004.57
Sep 26 11:00:00 - 11:59:59	129908	4.4%	36.09	38.2 GB	4.5%	11133.23
Sep 26 12:00:00 - 12:59:59	118363	4.0%	32.88	36.6 GB	4.3%	10673.89
Sep 26 13:00:00 - 13:59:59	124042	4.2%	34.46	38.5 GB	4.5%	11226.76
Sep 26 14:00:00 - 14:59:59	118695	4.0%	32.97	37.8 GB	4.4%	11012.09
Sep 26 15:00:00 - 15:59:59	118737	4.0%	32.98	38.5 GB	4.5%	11221.58
Sep 26 16:00:00 - 16:59:59	135466	4.6%	37.63	40.9 GB	4.8%	11920.99
Sep 26 17:00:00 - 17:59:59	146163	4.9%	40.60	41.2 GB	4.8%	11990.44
Sep 26 18:00:00 - 18:59:59	163212	5.5%	45.34	40.9 GB	4.8%	11915.11
Sep 26 19:00:00 - 19:59:59	134670	4.5%	37.41	37.0 GB	4.3%	10773.81
Sep 26 20:00:00 - 20:59:59	141169	4.7%	39.21	36.6 GB	4.3%	10667.48
Sep 26 21:00:00 - 21:59:59	153649	5.2%	42.68	41.2 GB	4.8%	12009.82
Sep 26 22:00:00 - 22:59:59	149835	5.0%	41.62	39.8 GB	4.6%	11595.04
Sep 26 23:00:00 - 23:59:59	147824	5.0%	41.06	39.3 GB	4.6%	11459.94
Sep 27 00:00:00 - 00:59:59	133989	4.5%	37.22	35.0 GB	4.1%	10199.21
Sep 27 01:00:00 - 01:59:59	101350	3.4%	28.15	24.4 GB	2.8%	7110.56
Sep 27 02:00:00 - 02:59:59	70530	2.4%	19.59	19.6 GB	2.3%	5698.69
Sep 27 03:00:00 - 03:59:59	45557	1.5%	12.65	13.2 GB	1.5%	3857.53
Sep 27 04:00:00 - 04:15:02	11890	0.4%	13.18	3.5 GB	0.4%	4089.27
TOTAL: 24:00:00	2977200	100.0%	34.46	858.3 GB	100.0%	10416.84

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	13095	27	457	4	12607
2	newsfeed.pionier.net.pl	7049	256	5394	1	1398
3	news.icm.edu.pl	201	0	5	0	196
TOTAL: 3		20345	283	5856	5	14201

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	171
it.comp.os.win.windows10	30
it.tlc.cellulari.android	22
comp.mobile.ipad	12
comp.mobile.android	10
uk.rec.cycling.moderated	9
it.comp.os.win.windows7	5
nl.comp.os.linux.techniek	5
de.comp.os.os2	4
hr.alt.cellular.gsm.android	4
hr.ponuda.hardver.komponente	4
de.rec.sf.startrek	2
comp.sys.raspberry-pi	2
hr.alt.cellular.gsm.iphone	2
de.comp.office-pakete.ms-office.word	1
TOTAL: 15	283

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11856
Binary in non-binary group	1470
EMP (phl)	218
Scoring filter (8)	78
Scoring filter (9)	16
Scoring filter (10)	9
Scoring filter (11)	9
Scoring filter (13)	7
Scoring filter (12)	6
Scoring filter (16)	1
Scoring filter (20)	1
HTML post	1
Scoring filter (14)	1
TOTAL: 13	13673

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	49693	455	23865	18193	0	0	0%	23:59:04
2	poznan	15432	51	10032	14	0	0	0%	23:57:19
3	nask	8849	38	5901	0	0	0	0%	23:58:29
4	panorama	8969	35	7603	11	9	44424	0%	24:01:43
5	okapi	0	0	0	0	0	1927	0%	24:00:01
TOTAL: 5		82943	579	47401	18218	9	46351	0%	119:56:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	17.2 MB	4.0 GB	4.1 GB	49.2 KB/s	228.0 KB	23:59:04
2	poznan	588.6 KB	33.0 KB	621.6 KB	0.0 KB/s	9.6 KB	23:57:19
3	panorama	455.2 KB	50.2 KB	505.4 KB	0.0 KB/s	11.0 KB	24:01:43
4	nask	376.1 KB	0.0 KB	376.1 KB	0.0 KB/s	9.9 KB	23:58:29
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		18.6 MB	4.0 GB	4.1 GB	9.8 KB/s	226.3 KB	119:56:36

Backlog files shrunk by innfeed:

Server	Size
panorama	3.8 MB
TOTAL: 1	3.8 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	84	92.1 KB	33	0	00:00:21
2	ip-209-5.ap-media.pl	2	5	7.2 KB	1	0	00:15:57
3	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 3		293	89	99.3 KB	34	3	01:34:14

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	675	84	92.1 KB	33	3	00:00:27
2	*.ap-media.pl	2	5	7.2 KB	1	0	00:15:57
3	unresolved	4	0	0.0 KB	0	0	01:17:50
TOTAL: 3		681	89	99.3 KB	34	3	01:34:14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.195.88	0.695	1.139	01:17:50
ip-209-5.ap-media.pl	0.042	0.042	00:15:57
web.man.lodz.pl	0.954	5.214	00:00:21
mon.man.lodz.pl	0.902	5.226	00:00:03
david.man.lodz.pl	0.269	1.659	00:00:01
isvcs01.man.lodz.pl	0.010	0.087	00:00:00
TOTAL: 6	2.872	13.367	01:34:14

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.195.88	4
TOTAL: 3	388

NNRP client timeouts [Top 20]:

System	Conn	Peer
185.48.195.88	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	84	94.4%
2	lodman	5	5.6%
TOTAL: 2		89	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	48
2	pl.comp.pecet	36
3	lodman.info	5
TOTAL: 3		89

Daily Usenet report

Sep 26 04:15:02 -- Sep 27 04:15:02