Daily Usenet report: Apr 1 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Apr 1 17:05:36 newsfeed nnrpd[7423]: SERVER perl filter not defined
Apr 1 19:37:19 newsfeed nnrpd[12609]: SERVER perl filter not defined
Apr 1 21:49:37 newsfeed nnrpd[17112]: SERVER perl filter not defined
Apr 2 00:18:32 newsfeed nnrpd[22484]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2773836	98.4%	330.4 MB	98.2%
innd	34015	1.2%	4.7 MB	1.4%
nnrpd	5445	0.2%	560.6 KB	0.2%
innfeed	5084	0.2%	724.1 KB	0.2%
TOTAL: 4	2818380	100.0%	336.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2762975	94.7%
Negative hits	133320	4.6%
Positive hits	19964	0.7%
Cache misses	123	0.0%
TOTAL: 4	2916382	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.116	0.0%	227	0.000	13.727	634.000
article cleanup	00:00:42.890	0.0%	2772519	0.007	0.015	0.027
article logging	00:01:37.295	0.1%	2773034	0.018	0.035	1.270
article parse	01:14:19.957	5.2%	207074818	0.011	0.022	0.076
article write	01:32:48.727	6.4%	2748977	0.278	2.026	8.220
artlog/artcncl	00:00:00.004	0.0%	222	0.000	0.018	1.000
data move	00:07:04.839	0.5%	224614311	0.001	0.002	0.009
hisgrep/artcncl	00:00:00.335	0.0%	203	0.000	1.650	16.000
hishave/artcncl	00:00:00.075	0.0%	227	0.000	0.330	5.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:36:55.503	2.6%	2916705	0.162	0.760	7.552
history sync	00:00:00.010	0.0%	293	0.000	0.034	1.000
history write	00:48:42.281	3.4%	2763273	0.245	1.058	12.782
hiswrite/artcncl	00:00:00.255	0.0%	24	0.000	10.625	193.000
idle	11:34:26.397	48.2%	147004966	0.104	0.283	0.674
nntp read	01:32:00.212	6.4%	204871798	0.014	0.027	0.040
overview write	00:00:16.525	0.0%	2748977	0.001	0.006	0.016
perl filter	05:50:57.160	24.4%	2763273	5.187	7.620	10.259
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:26.100	0.4%	5830891	0.036	0.056	0.089
TOTAL: 23:59:42.648	23:25:21.681	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.349	0.0%	361379	0.000	0.004	0.333
article prepare	00:00:00.295	0.0%	1240980	0.000	0.000	0.125
article read	00:03:28.472	0.2%	310142	0.000	0.672	244.500
backlog stats	00:00:01.699	0.0%	1732511	0.000	0.001	0.032
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:09.429	0.0%	721891	0.000	0.013	0.135
data write	00:02:27.217	0.2%	1033797	0.000	0.142	0.291
idle	23:53:07.842	99.5%	1732511	9.961	49.632	8819.143
status file	00:00:01.315	0.0%	1646	0.000	0.799	5.000
TOTAL: 23:59:59.453	23:59:17.618	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:55.104	76.6%	3273	0.000	16.836	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.202	0.3%	7203	0.000	0.028	0.667
readart	00:00:00.000	0.0%	2	0.000	0.000	0.000
TOTAL: 00:01:11.945	00:00:55.306	76.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	684	2749074	2731938	7517	9619	99%	421:34:08
2	news.nask.pl	2	34166	17405	2911	13850	50%	23:52:25
3	news.icm.edu.pl	42	257	37	191	29	14%	15:29:29
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		733	2783501	2749384	10619	23498	98%	460:56:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	866.3 GB	1.6 GB	1.7 GB	869.6 GB	99%	332.6 KB
2	news.nask.pl	1.9 GB	71.1 MB	203.1 MB	2.2 GB	87%	73.5 KB
3	news.icm.edu.pl	677.5 KB	0.0 KB	2.0 MB	2.6 MB	24%	41.1 KB
4	localhost	6.1 KB	0.0 KB	0.0 KB	6.1 KB	100%	1.5 KB
TOTAL: 4		868.2 GB	1.7 GB	1.9 GB	871.8 GB	99%	329.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 1 04:15:02 - 04:59:59	78466	2.9%	29.08	27.8 GB	3.2%	10814.84
Apr 1 05:00:00 - 05:59:59	99699	3.6%	27.69	36.2 GB	4.2%	10533.99
Apr 1 06:00:00 - 06:59:59	106333	3.9%	29.54	38.0 GB	4.4%	11060.97
Apr 1 07:00:00 - 07:59:59	110599	4.0%	30.72	39.6 GB	4.6%	11541.88
Apr 1 08:00:00 - 08:59:59	118679	4.3%	32.97	38.9 GB	4.5%	11332.89
Apr 1 09:00:00 - 09:59:59	128975	4.7%	35.83	37.5 GB	4.3%	10919.43
Apr 1 10:00:00 - 10:59:59	127793	4.6%	35.50	37.0 GB	4.3%	10790.21
Apr 1 11:00:00 - 11:59:59	126209	4.6%	35.06	36.6 GB	4.2%	10654.59
Apr 1 12:00:00 - 12:59:59	127825	4.6%	35.51	37.1 GB	4.3%	10812.28
Apr 1 13:00:00 - 13:59:59	127101	4.6%	35.31	36.3 GB	4.2%	10568.45
Apr 1 14:00:00 - 14:59:59	131222	4.8%	36.45	36.3 GB	4.2%	10578.23
Apr 1 15:00:00 - 15:59:59	129005	4.7%	35.83	37.0 GB	4.3%	10769.76
Apr 1 16:00:00 - 16:59:59	113619	4.1%	31.56	37.2 GB	4.3%	10821.59
Apr 1 17:00:00 - 17:59:59	115720	4.2%	32.14	38.4 GB	4.4%	11192.09
Apr 1 18:00:00 - 18:59:59	121986	4.4%	33.88	38.2 GB	4.4%	11125.29
Apr 1 19:00:00 - 19:59:59	118813	4.3%	33.00	37.2 GB	4.3%	10849.73
Apr 1 20:00:00 - 20:59:59	140630	5.1%	39.06	35.0 GB	4.0%	10199.40
Apr 1 21:00:00 - 21:59:59	75733	2.8%	21.04	24.4 GB	2.8%	7098.78
Apr 1 22:00:00 - 22:59:59	92248	3.4%	25.62	31.5 GB	3.6%	9175.69
Apr 1 23:00:00 - 23:59:59	112617	4.1%	31.28	36.8 GB	4.2%	10724.20
Apr 2 00:00:00 - 00:59:59	94877	3.5%	26.35	32.1 GB	3.7%	9342.50
Apr 2 01:00:00 - 01:59:59	111421	4.1%	30.95	37.2 GB	4.3%	10838.87
Apr 2 02:00:00 - 02:59:59	109765	4.0%	30.49	37.9 GB	4.4%	11039.85
Apr 2 03:00:00 - 03:59:59	103280	3.8%	28.69	34.4 GB	4.0%	10030.24
Apr 2 04:00:00 - 04:15:02	26944	1.0%	29.87	8.9 GB	1.0%	10355.54
TOTAL: 24:00:00	2749559	100.0%	31.82	867.6 GB	100.0%	10529.19

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	14148	14	579	14	13541
2	newsfeed.pionier.net.pl	9877	155	8667	1	1054
3	news.icm.edu.pl	30	0	0	0	30
TOTAL: 3		24055	169	9246	15	14625

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	72
it.tlc.cellulari.android	51
comp.mobile.android	19
it.comp.os.win.windows7	12
it.comp.os.win.windows10	4
hr.alt.cellular.gsm.android	2
uk.rec.cycling.moderated	2
nl.gezondheid.alternatief-genezen	1
nl.comp.3d-printen	1
alt.sex.telephones	1
nl.wetenschap.regulier	1
nl.actueel	1
nl.comp.os.linux.techniek	1
nl.comp.sys.android	1
TOTAL: 14	169

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

Groups	Count
pl.praca.oferowana	13
pl.sci.historia	1
bit.listserv.catholic	1
TOTAL: 3	15

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12936
Binary in non-binary group	887
Scoring filter (8)	114
Scoring filter (9)	61
Scoring filter (10)	31
EMP (phl)	22
Scoring filter (14)	8
Scoring filter (17)	8
Scoring filter (15)	8
Scoring filter (16)	7
Scoring filter (12)	6
Too many newsgroups	6
Excessively crossposted test article	5
Scoring filter (11)	5
Scoring filter (13)	2
Scoring filter (20)	1
Scoring filter (18)	1
Scoring filter (19)	1
HTML post	1
TOTAL: 19	14110

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	333910	302153	21979	7407	7	4144	90%	24:00:01
2	panorama	59159	325	56166	95	7	300635	0%	24:02:27
3	poznan	14453	174	9666	11	0	0	1%	23:59:53
4	nask	7414	20	5683	1	0	0	0%	24:04:54
5	okapi	0	0	0	0	0	1113	0%	24:00:01
TOTAL: 5		414936	302672	93494	7514	14	305892	72%	120:07:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	54.2 GB	316.5 MB	54.5 GB	661.7 KB/s	184.7 KB	24:00:01
2	panorama	3.1 MB	2.5 MB	5.6 MB	0.1 KB/s	13.7 KB	24:02:27
3	nask	1.8 MB	2.2 KB	1.8 MB	0.0 KB/s	87.0 KB	24:04:54
4	poznan	711.7 KB	68.2 KB	779.8 KB	0.0 KB/s	4.2 KB	23:59:53
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		54.2 GB	319.2 MB	54.5 GB	132.2 KB/s	184.3 KB	120:07:16

Backlog files shrunk by innfeed:

Server	Size
panorama	21.5 MB
TOTAL: 1	21.5 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	2	2.2 KB	1	0	00:00:24
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 2		292	2	2.2 KB	1	4	00:01:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	2	2.2 KB	1	4	00:00:30
2	*.versanet.de	176	0	0.0 KB	0	0	00:00:41
TOTAL: 2		852	2	2.2 KB	1	4	00:01:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
i5387f08c.versanet.de	0.482	1.698	00:00:41
web.man.lodz.pl	0.980	3.849	00:00:24
mon.man.lodz.pl	0.807	2.706	00:00:03
david.man.lodz.pl	0.314	0.973	00:00:01
isvcs01.man.lodz.pl	0.007	0.052	00:00:00
TOTAL: 5	2.590	9.278	00:01:11

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
i5387f08c.versanet.de	176
david.man.lodz.pl	96
TOTAL: 3	560

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Apr 1 04:15:02 -- Apr 2 04:15:02