Daily Usenet report: Sep 13 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 13 09:55:39 newsfeed nnrpd[2016]: SERVER perl filter not defined
Sep 13 09:57:12 newsfeed nnrpd[2032]: SERVER perl filter not defined
Sep 13 09:57:50 newsfeed nnrpd[2034]: SERVER perl filter not defined
Sep 13 09:58:30 newsfeed nnrpd[2035]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2936898	98.4%	342.8 MB	98.2%
innd	37021	1.2%	5.1 MB	1.5%
innfeed	4898	0.2%	684.4 KB	0.2%
nnrpd	4811	0.2%	504.9 KB	0.1%
TOTAL: 4	2983628	100.0%	349.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2930147	95.8%
Negative hits	110607	3.6%
Positive hits	17256	0.6%
Cache misses	146	0.0%
TOTAL: 4	3058156	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.657	0.0%	151	0.000	10.974	214.000
article cleanup	00:00:43.976	0.1%	2936740	0.007	0.015	0.026
article logging	00:01:26.858	0.1%	2937336	0.015	0.030	0.517
article parse	01:19:22.425	5.5%	215109021	0.010	0.022	0.069
article write	00:27:13.392	1.9%	2917633	0.335	0.560	4.120
artlog/artcncl	00:00:00.002	0.0%	149	0.000	0.013	0.056
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:51.476	0.2%	233513379	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.271	0.0%	134	0.000	2.022	19.000
hishave/artcncl	00:00:00.071	0.0%	151	0.000	0.470	3.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:43.053	1.8%	3060743	0.071	0.504	7.906
history sync	00:00:00.016	0.0%	291	0.000	0.055	1.000
history write	00:39:03.159	2.7%	2932746	0.161	0.799	10.326
hiswrite/artcncl	00:00:00.008	0.0%	17	0.000	0.471	8.000
idle	12:46:02.103	53.2%	152017881	0.126	0.302	0.766
nntp read	01:14:17.141	5.2%	212757940	0.011	0.021	0.043
overview write	00:00:16.554	0.0%	2917633	0.001	0.006	0.013
perl filter	06:03:49.969	25.3%	2932746	5.249	7.444	10.130
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:52.543	0.3%	5878520	0.033	0.050	0.085
TOTAL: 24:00:15.975	23:05:44.674	96.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.181	0.0%	56646	0.000	0.003	0.250
article prepare	00:00:00.015	0.0%	67056	0.000	0.000	0.125
article read	00:00:05.745	0.0%	16770	0.000	0.343	636.000
backlog stats	00:00:00.263	0.0%	278865	0.000	0.001	0.035
callbacks	00:00:00.000	0.0%	9	0.000	0.000	0.000
data read	00:00:01.800	0.0%	138711	0.000	0.013	0.107
data write	00:00:13.369	0.0%	138665	0.000	0.096	0.274
idle	24:00:05.857	100.0%	278865	23.400	309.848	5015.583
status file	00:00:00.771	0.0%	940	0.000	0.820	32.500
TOTAL: 24:00:35.083	24:00:28.001	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	17:54:30.095	99.9%	539069	0.000	119.595	87866.190
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:21.112	0.0%	1078967	0.000	0.020	0.500
readart	00:00:02.582	0.0%	131	0.000	19.710	29.224
TOTAL: 17:55:38.464	17:54:53.789	99.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	1028	2916596	2903156	9104	4336	99%	323:15:57
2	news.nask.pl	2	32418	13720	3953	14745	42%	24:12:53
3	news.icm.edu.pl	44	311	17	276	18	5%	17:06:55
4	localhost	5	4	4	0	0	100%	00:00:01
TOTAL: 4		1079	2949329	2916897	13333	19099	98%	364:35:46

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	884.1 GB	198.3 MB	283.7 MB	884.6 GB	99%	319.0 KB
2	news.nask.pl	366.6 MB	8.8 MB	338.6 MB	714.0 MB	51%	25.7 KB
3	news.icm.edu.pl	440.5 KB	179.1 KB	461.7 KB	1.1 MB	40%	30.9 KB
4	localhost	7.2 KB	0.0 KB	0.0 KB	7.2 KB	100%	1.8 KB
TOTAL: 4		884.5 GB	207.3 MB	622.8 MB	885.3 GB	99%	316.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 13 04:15:02 - 04:59:59	82944	2.8%	30.74	28.5 GB	3.2%	11082.54
Sep 13 05:00:00 - 05:59:59	103696	3.6%	28.80	35.7 GB	4.0%	10406.79
Sep 13 06:00:00 - 06:59:59	107110	3.7%	29.75	34.8 GB	3.9%	10133.91
Sep 13 07:00:00 - 07:59:59	116179	4.0%	32.27	32.3 GB	3.7%	9406.20
Sep 13 08:00:00 - 08:59:59	134113	4.6%	37.25	37.9 GB	4.3%	11039.39
Sep 13 09:00:00 - 09:59:59	105359	3.6%	29.27	30.6 GB	3.5%	8902.00
Sep 13 10:00:00 - 10:59:59	120319	4.1%	33.42	36.0 GB	4.1%	10498.59
Sep 13 11:00:00 - 11:59:59	114859	3.9%	31.91	33.7 GB	3.8%	9825.13
Sep 13 12:00:00 - 12:59:59	118010	4.0%	32.78	35.9 GB	4.1%	10451.61
Sep 13 13:00:00 - 13:59:59	134485	4.6%	37.36	40.0 GB	4.5%	11665.12
Sep 13 14:00:00 - 14:59:59	129814	4.5%	36.06	42.1 GB	4.8%	12270.07
Sep 13 15:00:00 - 15:59:59	133315	4.6%	37.03	42.2 GB	4.8%	12287.88
Sep 13 16:00:00 - 16:59:59	124579	4.3%	34.61	40.5 GB	4.6%	11787.88
Sep 13 17:00:00 - 17:59:59	122825	4.2%	34.12	39.0 GB	4.4%	11353.64
Sep 13 18:00:00 - 18:59:59	119522	4.1%	33.20	35.7 GB	4.0%	10388.44
Sep 13 19:00:00 - 19:59:59	107770	3.7%	29.94	33.0 GB	3.7%	9598.78
Sep 13 20:00:00 - 20:59:59	138548	4.7%	38.49	40.6 GB	4.6%	11813.91
Sep 13 21:00:00 - 21:59:59	144969	5.0%	40.27	40.9 GB	4.6%	11904.26
Sep 13 22:00:00 - 22:59:59	141565	4.9%	39.32	41.5 GB	4.7%	12097.55
Sep 13 23:00:00 - 23:59:59	148431	5.1%	41.23	40.9 GB	4.6%	11926.11
Sep 14 00:00:00 - 00:59:59	111825	3.8%	31.06	31.2 GB	3.5%	9089.36
Sep 14 01:00:00 - 01:59:59	126960	4.4%	35.27	36.4 GB	4.1%	10603.21
Sep 14 02:00:00 - 02:59:59	113021	3.9%	31.39	36.0 GB	4.1%	10476.51
Sep 14 03:00:00 - 03:59:59	93324	3.2%	25.92	30.4 GB	3.4%	8855.46
Sep 14 04:00:00 - 04:15:02	23509	0.8%	26.06	7.5 GB	0.8%	8703.75
TOTAL: 24:00:00	2917051	100.0%	33.76	883.3 GB	100.0%	10719.51

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	15008	13	366	9	14620
2	newsfeed.pionier.net.pl	4672	155	3623	2	892
3	news.icm.edu.pl	18	0	2	0	16
TOTAL: 3		19698	168	3991	11	15528

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	65
it.tlc.cellulari.android	38
it.comp.os.win.windows10	17
comp.mobile.android	10
it.comp.os.win.windows7	9
hr.alt.cellular.gsm.android	9
uk.rec.cycling.moderated	7
comp.mobile.ipad	6
alt.windows7.general	2
hr.rec.glazba.hifi	1
hr.ponuda.hardver.komponente	1
hr.ponuda.hardver.periferije	1
comp.sys.raspberry-pi	1
hr.ponuda.hardver.konfiguracije	1
TOTAL: 14	168

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

Groups	Count
pl.praca.oferowana	5
pl.sci.matematyka	4
christnet.philosophy	1
bit.listserv.catholic	1
TOTAL: 4	11

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	13555
Binary in non-binary group	619
EMP (phl)	554
Scoring filter (8)	106
Scoring filter (9)	38
Scoring filter (16)	11
Scoring filter (11)	9
Scoring filter (10)	8
Scoring filter (13)	6
Scoring filter (23)	5
Scoring filter (12)	4
Too many newsgroups	4
Scoring filter (15)	4
Scoring filter (14)	2
HTML post	2
Scoring filter (19)	1
Scoring filter (17)	1
Scoring filter (24)	1
Scoring filter (18)	1
Scoring filter (21)	1
TOTAL: 21	14933

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	50661	428	25724	15710	0	0	0%	23:59:04
2	poznan	20239	335	13025	27	0	0	1%	24:07:19
3	panorama	15176	28	13636	16	26	43130	0%	24:02:59
4	nask	7582	25	4989	0	0	0	0%	23:58:28
5	okapi	0	0	0	0	0	2372	0%	24:00:00
TOTAL: 5		93658	816	57374	15753	26	45502	0%	120:07:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	9.3 MB	3.8 GB	3.8 GB	46.2 KB/s	247.4 KB	23:59:04
2	poznan	3.2 MB	1.2 MB	4.4 MB	0.1 KB/s	12.4 KB	24:07:19
3	panorama	164.1 KB	35.4 KB	199.5 KB	0.0 KB/s	4.5 KB	24:02:59
4	nask	87.2 KB	0.0 KB	87.2 KB	0.0 KB/s	3.5 KB	23:58:28
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		12.7 MB	3.8 GB	3.8 GB	9.2 KB/s	241.2 KB	120:07:50

Backlog files shrunk by innfeed:

Server	Size
panorama	3.3 MB
okapi	488.4 KB
TOTAL: 2	3.8 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	lze200.lze.lodz.pl	2	93	239.9 KB	7	0	00:46:12
2	web.man.lodz.pl	288	38	38.5 KB	18	0	00:00:20
3	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:03
TOTAL: 3		294	131	278.4 KB	25	4	17:55:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.lze.lodz.pl	2	93	239.9 KB	7	0	00:46:12
2	*.man.lodz.pl	676	38	38.5 KB	18	4	00:00:28
3	unresolved	1	0	0.0 KB	0	0	17:08:57
TOTAL: 3		679	131	278.4 KB	25	4	17:55:38

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.73	28.726	39.957	17:08:57
lze200.lze.lodz.pl	0.017	0.074	00:46:12
web.man.lodz.pl	0.884	4.689	00:00:20
mon.man.lodz.pl	0.910	3.994	00:00:03
isvcs01.man.lodz.pl	0.018	0.064	00:00:03
david.man.lodz.pl	0.311	1.307	00:00:01
TOTAL: 6	30.866	50.085	17:55:38

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.73	1
TOTAL: 3	385

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	56
2	pl.misc.telefonia.gsm	32
3	pl.comp.pecet	21
4	pl.rec.kuchnia	10
5	pl.comp.os.linux	8
6	pl.rec.dom	4
TOTAL: 6		131

Daily Usenet report

Sep 13 04:15:02 -- Sep 14 04:15:02