Daily Usenet report: Mar 25 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Mar 25 09:17:18 newsfeed nnrpd[12415]: SERVER perl filter not defined
Mar 25 13:43:37 newsfeed nnrpd[21700]: SERVER perl filter not defined
Mar 25 22:50:26 newsfeed nnrpd[8743]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2781129	98.5%	327.8 MB	98.3%
innd	33882	1.2%	4.7 MB	1.4%
nnrpd	4578	0.2%	473.3 KB	0.1%
innfeed	4553	0.2%	647.6 KB	0.2%
TOTAL: 4	2824142	100.0%	333.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2776909	96.3%
Negative hits	92969	3.2%
Positive hits	12418	0.4%
Cache misses	141	0.0%
TOTAL: 4	2882437	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.577	0.0%	237	0.000	10.873	517.000
article cleanup	00:00:42.035	0.1%	2782319	0.006	0.015	0.025
article logging	00:01:35.247	0.1%	2782803	0.017	0.034	1.019
article parse	01:16:03.728	5.5%	194756929	0.012	0.023	0.070
article write	01:23:18.865	6.0%	2766348	0.366	1.807	7.878
artlog/artcncl	00:00:00.002	0.0%	232	0.000	0.009	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:03:56.253	0.3%	212211111	0.001	0.001	0.005
hisgrep/artcncl	00:00:01.170	0.0%	220	0.000	5.318	362.000
hishave/artcncl	00:00:00.200	0.0%	237	0.000	0.844	81.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:34:47.731	2.5%	2884978	0.160	0.724	9.756
history sync	00:00:00.014	0.0%	285	0.000	0.049	1.000
history write	00:48:23.892	3.5%	2779529	0.251	1.045	12.137
hiswrite/artcncl	00:00:00.029	0.0%	17	0.000	1.706	11.000
idle	10:55:21.374	47.5%	131982770	0.118	0.298	0.840
nntp read	01:14:18.444	5.4%	192528703	0.015	0.023	0.037
overview write	00:00:16.739	0.0%	2766348	0.001	0.006	0.014
perl filter	05:54:08.852	25.6%	2779528	5.536	7.645	9.448
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:14.142	0.4%	5866966	0.037	0.054	0.088
TOTAL: 23:00:48.658	22:18:11.294	96.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.367	0.0%	436928	0.000	0.003	0.200
article prepare	00:00:00.277	0.0%	1335424	0.000	0.000	0.250
article read	00:10:47.837	0.8%	316414	0.000	2.047	1459.667
backlog stats	00:00:01.920	0.0%	1874211	0.000	0.001	0.038
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:10.027	0.0%	760818	0.000	0.013	0.250
data write	00:02:31.651	0.2%	1131767	0.000	0.134	0.294
idle	22:46:11.322	99.0%	1874211	9.242	43.736	5301.167
status file	00:00:01.185	0.0%	1390	0.000	0.853	3.000
TOTAL: 23:00:25.618	22:59:45.586	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:36.734	29.1%	2934	0.000	12.520	673.375
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.155	0.1%	6614	0.000	0.023	1.000
readart	00:01:14.987	59.4%	20808	0.000	3.604	5.330
TOTAL: 00:02:06.308	00:01:51.876	88.6%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	23
flushlogs	2
go	2
logmode	2
mode	142
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	182

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	950	2765454	2755015	6394	4045	99%	413:22:18
2	news.nask.pl	2	23769	8987	2917	11865	37%	23:01:50
3	news.icm.edu.pl	37	372	55	255	62	14%	18:29:35
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		993	2789598	2764060	9566	15972	99%	454:53:43

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	862.0 GB	121.2 MB	364.0 MB	862.5 GB	99%	327.8 KB
2	news.nask.pl	127.1 MB	849.0 KB	140.5 MB	268.4 MB	47%	13.2 KB
3	news.icm.edu.pl	1.1 MB	101.8 KB	2.3 MB	3.5 MB	31%	30.8 KB
4	localhost	4.3 KB	0.0 KB	0.0 KB	4.3 KB	100%	1.4 KB
TOTAL: 4		862.2 GB	122.2 MB	506.8 MB	862.8 GB	99%	325.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 25 04:15:02 - 04:59:59	94525	3.4%	35.04	27.0 GB	0.0%	10492.56
Mar 25 05:00:00 - 05:59:59	123553	4.5%	34.32	36.4 GB	10.5%	10605.06
Mar 25 06:00:00 - 06:59:59	125059	4.5%	34.74	37.8 GB	10.9%	11011.78
Mar 25 07:00:00 - 07:59:59	117841	4.3%	32.73	38.7 GB	11.1%	11267.18
Mar 25 08:00:00 - 08:59:59	118075	4.3%	32.80	39.1 GB	11.2%	11380.69
Mar 25 09:00:00 - 09:59:59	116712	4.2%	32.42	38.6 GB	11.1%	11231.53
Mar 25 10:00:00 - 10:59:59	127223	4.6%	35.34	36.1 GB	10.4%	10526.40
Mar 25 11:00:00 - 11:59:59	123826	4.5%	34.40	35.9 GB	10.3%	10444.39
Mar 25 12:00:00 - 12:59:59	123602	4.5%	34.33	36.0 GB	10.3%	10481.22
Mar 25 13:00:00 - 13:59:59	114429	4.1%	31.79	37.8 GB	10.9%	11014.29
Mar 25 14:00:00 - 14:59:59	120660	4.4%	33.52	40.7 GB	11.7%	11862.55
Mar 25 15:00:00 - 15:59:59	115909	4.2%	32.20	39.2 GB	11.3%	11420.45
Mar 25 16:00:00 - 16:59:59	112562	4.1%	31.27	37.1 GB	10.7%	10804.15
Mar 25 17:00:00 - 17:59:59	109660	4.0%	30.46	37.7 GB	10.8%	10979.62
Mar 25 18:00:00 - 18:59:59	114108	4.1%	31.70	38.5 GB	11.1%	11204.12
Mar 25 19:00:00 - 19:59:59	121674	4.4%	33.80	38.0 GB	10.9%	11063.70
Mar 25 20:00:00 - 20:59:59	123010	4.4%	34.17	38.4 GB	11.1%	11197.54
Mar 25 21:00:00 - 21:59:59	119843	4.3%	33.29	38.8 GB	11.2%	11305.13
Mar 25 22:00:00 - 22:59:59	127149	4.6%	35.32	40.7 GB	11.7%	11862.48
Mar 25 23:00:00 - 23:59:59	124442	4.5%	34.57	38.3 GB	11.0%	11158.51
Mar 26 00:00:00 - 00:59:59	111877	4.0%	31.08	31.4 GB	9.0%	9133.90
Mar 26 01:00:00 - 01:59:59	132764	4.8%	36.88	37.5 GB	10.8%	10918.25
Mar 26 02:00:00 - 02:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Mar 26 03:00:00 - 03:59:59	114863	4.2%	31.91	32.6 GB	9.4%	9498.77
Mar 26 04:00:00 - 04:15:02	31089	1.1%	34.47	8.8 GB	2.5%	10232.06
TOTAL: 24:00:00	2764455	100.0%	32.00	347.7 GB	100.0%	4219.60

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12049	16	216	11	11806
2	newsfeed.pionier.net.pl	4330	89	2573	2	1666
3	news.icm.edu.pl	63	0	3	0	60
TOTAL: 3		16442	105	2792	13	13532

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	51
it.tlc.cellulari.android	23
comp.mobile.android	14
hr.ponuda.hardver.komponente	7
it.comp.os.win.windows10	3
comp.sys.raspberry-pi	2
hr.alt.cellular.gsm.android	2
alt.sex.telephones	1
it.discussioni.energia	1
uk.rec.cycling.moderated	1
TOTAL: 10	105

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

Groups	Count
pl.praca.oferowana	12
bit.listserv.catholic	1
TOTAL: 2	13

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11252
Binary in non-binary group	1557
Scoring filter (8)	92
Scoring filter (9)	64
Scoring filter (10)	20
Scoring filter (11)	14
Excessively crossposted test article	13
EMP (phl)	9
Poison newsgroup	8
Scoring filter (12)	8
Scoring filter (15)	3
Scoring filter (16)	2
Scoring filter (17)	1
EMP (fsl)	1
Too many newsgroups	1
HTML post	1
Scoring filter (13)	1
TOTAL: 17	13047

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	320421	298408	12934	8320	9	51506	93%	22:55:11
2	panorama	114096	1565	87457	21984	11	276848	1%	22:56:16
3	poznan	13099	57	8582	5	0	0	0%	22:54:24
4	nask	5940	18	4050	0	0	0	0%	23:00:10
5	okapi	0	0	0	0	0	996	0%	23:00:04
TOTAL: 5		453556	300048	113023	30309	20	329350	66%	114:46:05

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	53.6 GB	1.4 GB	55.0 GB	698.8 KB/s	188.0 KB	22:55:11
2	panorama	5.2 MB	3.8 GB	3.8 GB	48.7 KB/s	170.8 KB	22:56:16
3	nask	1.3 MB	0.0 KB	1.3 MB	0.0 KB/s	75.4 KB	23:00:10
4	poznan	383.0 KB	83.4 KB	466.4 KB	0.0 KB/s	7.5 KB	22:54:24
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:00:04
TOTAL: 5		53.6 GB	5.2 GB	58.8 GB	149.3 KB/s	186.7 KB	114:46:05

Backlog files shrunk by innfeed:

Server	Size
panorama	13.8 MB
TOTAL: 1	13.8 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	276	28	26.8 KB	12	0	00:00:22
2	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 2		279	28	26.8 KB	12	3	00:02:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	647	28	26.8 KB	12	3	00:00:28
2	*.dyn.optonline.net	2	0	0.0 KB	0	0	00:01:38
TOTAL: 2		649	28	26.8 KB	12	3	00:02:06

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ool-ae2c99f9.dyn.optonline.net	0.453	1.693	00:01:38
web.man.lodz.pl	1.049	4.766	00:00:22
mon.man.lodz.pl	0.862	4.509	00:00:03
david.man.lodz.pl	0.296	1.327	00:00:01
isvcs01.man.lodz.pl	0.018	0.043	00:00:00
TOTAL: 5	2.678	12.338	00:02:06

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	276
david.man.lodz.pl	92
ool-ae2c99f9.dyn.optonline.net	2
TOTAL: 3	370

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

Mar 25 04:15:02 -- Mar 26 04:15:02