Daily Usenet report: Sep 23 04:15:03

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 23 15:55:15 newsfeed nnrpd[17302]: SERVER perl filter not defined
Sep 23 16:30:31 newsfeed nnrpd[18454]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2792639	97.8%	320.7 MB	97.4%
innfeed	34436	1.2%	4.1 MB	1.2%
innd	22036	0.8%	3.8 MB	1.2%
nnrpd	4943	0.2%	523.7 KB	0.2%
TOTAL: 4	2854054	100.0%	329.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2786759	98.1%
Negative hits	38045	1.3%
Positive hits	16463	0.6%
Cache misses	188	0.0%
TOTAL: 4	2841455	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.899	0.0%	204	0.000	28.917	1753.000
article cleanup	00:00:34.194	0.0%	2792416	0.005	0.012	0.029
article logging	00:01:09.165	0.1%	2792965	0.011	0.025	0.522
article parse	00:53:04.694	3.7%	162685207	0.010	0.020	0.047
article write	00:25:53.755	1.8%	2787864	0.211	0.557	3.729
artlog/artcncl	00:00:00.002	0.0%	203	0.000	0.010	0.143
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:39.635	0.2%	179050567	0.000	0.001	0.004
hisgrep/artcncl	00:00:01.415	0.0%	185	0.000	7.649	520.000
hishave/artcncl	00:00:00.132	0.0%	204	0.000	0.647	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:43:01.044	3.0%	2843149	0.074	0.908	15.717
history sync	00:00:00.013	0.0%	291	0.000	0.045	1.000
history write	00:55:46.934	3.9%	2788520	0.128	1.200	19.391
hiswrite/artcncl	00:00:00.020	0.0%	19	0.000	1.053	8.000
idle	15:29:17.375	64.5%	120194963	0.284	0.464	0.879
nntp read	00:40:32.898	2.8%	160296974	0.009	0.015	0.026
overview write	00:00:12.926	0.0%	2787864	0.001	0.005	0.012
perl filter	04:12:38.962	17.5%	2788520	3.106	5.436	7.895
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:53.363	0.3%	5637334	0.026	0.041	0.063
TOTAL: 24:00:18.034	23:28:52.426	97.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.241	0.0%	111657	0.000	0.002	0.143
article prepare	00:00:00.011	0.0%	75568	0.000	0.000	0.250
article read	00:01:00.571	0.1%	18877	0.000	3.209	1105.000
backlog stats	00:00:00.161	0.0%	297609	0.000	0.001	0.016
callbacks	00:00:00.000	0.0%	5	0.000	0.000	0.000
data read	00:00:01.516	0.0%	169262	0.000	0.009	0.103
data write	00:00:08.746	0.0%	114084	0.000	0.077	1.853
idle	23:59:15.398	99.9%	297609	36.041	290.164	2202.750
status file	00:00:06.743	0.0%	11878	0.000	0.568	8.000
TOTAL: 24:00:42.132	24:00:33.387	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:52:09.389	99.9%	63234	0.000	163.352	10051.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.521	0.0%	127215	0.000	0.012	0.667
readart	00:00:00.002	0.0%	46	0.000	0.043	0.500
TOTAL: 02:52:24.770	02:52:10.912	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	1114	2786804	2782124	647	4033	99%	396:16:24
2	news.nask.pl	2	17171	4795	12025	351	27%	24:39:30
3	news.icm.edu.pl	54	350	16	166	168	4%	16:56:39
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1173	2804327	2786937	12838	4552	99%	437:52:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	796.4 GB	13.7 MB	22.2 MB	796.4 GB	99%	299.7 KB
2	news.nask.pl	16.7 MB	819.9 KB	925.8 KB	18.4 MB	90%	3.7 KB
3	news.icm.edu.pl	428.5 KB	8.2 KB	10.5 MB	11.0 MB	3%	61.1 KB
4	localhost	2.7 KB	0.0 KB	0.0 KB	2.7 KB	100%	1.3 KB
TOTAL: 4		796.4 GB	14.6 MB	33.7 MB	796.5 GB	99%	299.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 23 04:15:03 - 04:59:59	63300	2.3%	23.47	23.2 GB	2.9%	9008.23
Sep 23 05:00:00 - 05:59:59	88237	3.2%	24.51	32.7 GB	4.1%	9513.86
Sep 23 06:00:00 - 06:59:59	76463	2.7%	21.24	27.9 GB	3.5%	8138.26
Sep 23 07:00:00 - 07:59:59	108415	3.9%	30.12	36.8 GB	4.6%	10717.73
Sep 23 08:00:00 - 08:59:59	98651	3.5%	27.40	33.5 GB	4.2%	9757.82
Sep 23 09:00:00 - 09:59:59	99466	3.6%	27.63	33.2 GB	4.2%	9666.59
Sep 23 10:00:00 - 10:59:59	104374	3.7%	28.99	34.5 GB	4.3%	10043.89
Sep 23 11:00:00 - 11:59:59	110551	4.0%	30.71	34.8 GB	4.4%	10142.90
Sep 23 12:00:00 - 12:59:59	123841	4.4%	34.40	36.4 GB	4.6%	10595.54
Sep 23 13:00:00 - 13:59:59	119004	4.3%	33.06	36.0 GB	4.5%	10495.55
Sep 23 14:00:00 - 14:59:59	119175	4.3%	33.10	35.4 GB	4.5%	10321.35
Sep 23 15:00:00 - 15:59:59	128974	4.6%	35.83	36.7 GB	4.6%	10689.77
Sep 23 16:00:00 - 16:59:59	132444	4.8%	36.79	35.6 GB	4.5%	10369.23
Sep 23 17:00:00 - 17:59:59	124633	4.5%	34.62	35.2 GB	4.4%	10251.09
Sep 23 18:00:00 - 18:59:59	117953	4.2%	32.76	34.2 GB	4.3%	9951.07
Sep 23 19:00:00 - 19:59:59	169745	6.1%	47.15	32.5 GB	4.1%	9477.23
Sep 23 20:00:00 - 20:59:59	184357	6.6%	51.21	34.9 GB	4.4%	10179.31
Sep 23 21:00:00 - 21:59:59	170740	6.1%	47.43	34.2 GB	4.3%	9975.33
Sep 23 22:00:00 - 22:59:59	134936	4.8%	37.48	29.8 GB	3.8%	8691.44
Sep 23 23:00:00 - 23:59:59	120823	4.3%	33.56	31.2 GB	3.9%	9101.18
Sep 24 00:00:00 - 00:59:59	81163	2.9%	22.55	26.3 GB	3.3%	7651.83
Sep 24 01:00:00 - 01:59:59	98663	3.5%	27.41	32.1 GB	4.0%	9359.64
Sep 24 02:00:00 - 02:59:59	97545	3.5%	27.10	32.3 GB	4.1%	9397.91
Sep 24 03:00:00 - 03:59:59	89847	3.2%	24.96	28.5 GB	3.6%	8297.82
Sep 24 04:00:00 - 04:15:02	24038	0.9%	26.65	7.3 GB	0.9%	8470.83
TOTAL: 23:59:59	2787338	100.0%	32.26	795.3 GB	100.0%	9652.50

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4501	322	3576	1	602
2	news.nask.pl	428	8	317	14	89
3	news.icm.edu.pl	169	0	1	0	168
TOTAL: 3		5098	330	3894	15	859

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	178
it.comp.os.win.windows10	64
it.tlc.cellulari.android	46
comp.mobile.android	9
uk.rec.cycling.moderated	7
comp.sys.mac.vintage	6
comp.mobile.ipad	5
hr.alt.cellular.gsm.iphone	4
comp.sys.raspberry-pi	3
alt.sex.telephones	3
hr.ponuda.hardver.komponente	2
it.comp.os.win.windows7	2
it.comp.os.linux.ubuntu	1
TOTAL: 13	330

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

Groups	Count
pl.sci.matematyka	9
pl.praca.oferowana	5
bit.listserv.catholic	1
TOTAL: 3	15

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	225
EMP (md5)	77
Too many newsgroups	6
HTML post	2
Scoring filter (8)	1
TOTAL: 5	311

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	55389	1610	33100	1017	12	75944	2%	24:01:28
2	icm	54594	1305	27890	14036	0	11	2%	23:55:08
3	poznan	6709	85	4475	42	0	0	1%	24:00:04
4	okapi	0	0	0	0	0	2071	0%	24:00:03
5	nask	0	0	0	0	0	12741	0%	24:00:03
TOTAL: 5		116692	3000	65465	15095	12	90767	2%	119:56:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	214.8 MB	3.4 GB	3.6 GB	44.2 KB/s	248.2 KB	23:55:08
2	panorama	6.4 MB	16.1 MB	22.4 MB	0.3 KB/s	8.7 KB	24:01:28
3	poznan	296.8 KB	84.7 KB	381.5 KB	0.0 KB/s	3.0 KB	24:00:04
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		221.5 MB	3.4 GB	3.7 GB	8.9 KB/s	211.7 KB	119:56:46

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	44	44.9 KB	20	0	00:00:32
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		290	44	44.9 KB	20	2	02:52:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	674	44	44.9 KB	20	2	00:00:36
2	*.toya.net.pl	37	0	0.0 KB	0	0	00:00:02
3	unresolved	4	0	0.0 KB	0	0	02:51:31
4	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:08
5	*.dyn.optonline.net	1	0	0.0 KB	0	0	00:00:00
6	*.shodan.io	1	0	0.0 KB	0	0	00:00:04
TOTAL: 6		719	44	44.9 KB	20	2	02:52:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.40.102	2.947	3.055	02:51:29
web.man.lodz.pl	0.776	3.211	00:00:32
host227.elsnet.pl	0.005	0.024	00:00:08
census3.shodan.io	0.000	0.011	00:00:04
mon.man.lodz.pl	0.636	2.954	00:00:03
staticline41435.toya.net.pl	0.084	0.430	00:00:02
173.0.3.81	0.000	0.010	00:00:01
71.94.21.184	0.004	0.013	00:00:01
david.man.lodz.pl	0.208	1.043	00:00:00
ool-4a59c3c5.dyn.optonline.net	0.004	0.014	00:00:00
isvcs01.man.lodz.pl	0.011	0.011	00:00:00
TOTAL: 11	4.675	10.776	02:52:24

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	37
host227.elsnet.pl	2
89.38.40.102	2
ool-4a59c3c5.dyn.optonline.net	1
census3.shodan.io	1
71.94.21.184	1
173.0.3.81	1
TOTAL: 9	429

NNRP unrecognized commands (by host):

System	Conn
ool-4a59c3c5.dyn.optonline.net	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
BYE	1
TOTAL: 1	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Sep 23 04:15:03 -- Sep 24 04:15:02