Daily Usenet report: Sep 22 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 22 04:21:13 newsfeed nnrpd[237396]: nms1.man.lodz.pl rejected Expiring process 237235
Sep 22 16:37:49 newsfeed nnrpd[270067]: SERVER perl filter not defined
Sep 22 18:00:00 newsfeed nnrpd[273560]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	205788	94.7%	24.3 MB	95.4%
nnrpd	7726	3.6%	791.9 KB	3.0%
innd	2471	1.1%	272.7 KB	1.0%
innfeed	1262	0.6%	132.6 KB	0.5%
overchan	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	217249	100.0%	25.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	204626	99.3%
Negative hits	1333	0.6%
Positive hits	84	0.0%
Cache misses	32	0.0%
TOTAL: 4	206075	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.797	0.0%	78	0.000	23.038	124.000
article cleanup	00:00:01.022	0.0%	205239	0.000	0.005	0.013
article logging	00:00:04.307	0.0%	205263	0.010	0.021	0.105
article parse	00:00:05.024	0.0%	713294	0.004	0.007	0.011
article write	00:00:18.182	0.0%	205044	0.039	0.089	1.627
artlog/artcncl	00:00:00.004	0.0%	77	0.000	0.052	1.000
data move	00:00:00.660	0.0%	909059	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.659	0.0%	78	0.000	8.449	27.500
hishave/artcncl	00:00:00.461	0.0%	78	0.000	5.910	26.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:35:33.473	2.5%	206759	7.413	10.319	25.078
history sync	00:00:00.011	0.0%	403	0.000	0.027	0.667
history write	00:35:44.879	2.5%	205236	7.809	10.451	24.408
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	22:45:35.496	94.8%	670738	55.782	122.157	290.847
nntp read	00:00:07.853	0.0%	604967	0.007	0.013	0.020
overview write	00:00:00.438	0.0%	205044	0.000	0.002	0.007
perl filter	00:02:52.462	0.2%	205236	0.583	0.840	1.265
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:06.505	0.0%	501906	0.007	0.013	0.019
TOTAL: 24:01:04.579	24:00:33.233	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.120	0.0%	91937	0.000	0.001	0.019
article prepare	00:00:00.000	0.0%	40	0.000	0.000	0.000
article read	00:00:00.001	0.0%	10	0.000	0.100	1.000
backlog stats	00:00:00.046	0.0%	111217	0.000	0.000	0.010
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.960	0.0%	98799	0.000	0.010	0.027
data write	00:00:00.283	0.0%	7042	0.000	0.040	0.160
idle	23:55:03.818	100.0%	111217	198.853	774.197	4079.302
status file	00:00:00.220	0.0%	315	0.000	0.698	3.500
TOTAL: 23:55:07.098	23:55:05.448	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:35:54.557	95.4%	9864	0.000	218.426	10020.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.656	0.0%	32798	0.000	0.020	2.329
readart	00:01:24.436	3.7%	11269	0.000	7.493	14.554
TOTAL: 00:37:37.564	00:37:19.649	99.2%	-	-	-	-

Control commands to INND:

Command	Number
flush	27
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	192

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	61	205527	205332	0	195	99%	34:23:14
2	news.icm.edu.pl	26	40	3	37	0	7%	05:18:54
3	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 3		90	205569	205337	37	195	99%	39:42:08

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	2.1 GB	19.2 KB	2.1 MB	2.1 GB	99%	10.7 KB
2	news.icm.edu.pl	29.8 KB	0.0 KB	0.0 KB	29.8 KB	100%	9.9 KB
3	localhost	2.8 KB	0.0 KB	0.0 KB	2.8 KB	100%	1.4 KB
TOTAL: 3		2.1 GB	19.2 KB	2.1 MB	2.1 GB	99%	10.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 22 04:15:02 - 04:59:59	2168	1.1%	0.80	36.7 MB	1.7%	13.95
Sep 22 05:00:00 - 05:59:59	5339	2.6%	1.48	67.8 MB	3.1%	19.29
Sep 22 06:00:00 - 06:59:59	3828	1.9%	1.06	52.2 MB	2.4%	14.84
Sep 22 07:00:00 - 07:59:59	5508	2.7%	1.53	54.1 MB	2.5%	15.39
Sep 22 08:00:00 - 08:59:59	5299	2.6%	1.47	56.0 MB	2.6%	15.94
Sep 22 09:00:00 - 09:59:59	4651	2.3%	1.29	56.0 MB	2.6%	15.92
Sep 22 10:00:00 - 10:59:59	4158	2.0%	1.16	51.5 MB	2.4%	14.65
Sep 22 11:00:00 - 11:59:59	8489	4.1%	2.36	96.4 MB	4.5%	27.42
Sep 22 12:00:00 - 12:59:59	7677	3.7%	2.13	75.0 MB	3.5%	21.33
Sep 22 13:00:00 - 13:59:59	12064	5.9%	3.35	85.7 MB	4.0%	24.37
Sep 22 14:00:00 - 14:59:59	8965	4.4%	2.49	96.8 MB	4.5%	27.55
Sep 22 15:00:00 - 15:59:59	4904	2.4%	1.36	65.6 MB	3.0%	18.66
Sep 22 16:00:00 - 16:59:59	9013	4.4%	2.50	88.8 MB	4.1%	25.27
Sep 22 17:00:00 - 17:59:59	11336	5.5%	3.15	122.2 MB	5.7%	34.75
Sep 22 18:00:00 - 18:59:59	10863	5.3%	3.02	118.9 MB	5.5%	33.83
Sep 22 19:00:00 - 19:59:59	11446	5.6%	3.18	124.5 MB	5.8%	35.41
Sep 22 20:00:00 - 20:59:59	9233	4.5%	2.56	102.6 MB	4.8%	29.19
Sep 22 21:00:00 - 21:59:59	10307	5.0%	2.86	79.4 MB	3.7%	22.58
Sep 22 22:00:00 - 22:59:59	15471	7.5%	4.30	153.3 MB	7.1%	43.60
Sep 22 23:00:00 - 23:59:59	13722	6.7%	3.81	137.0 MB	6.4%	38.96
Sep 23 00:00:00 - 00:59:59	8388	4.1%	2.33	85.7 MB	4.0%	24.38
Sep 23 01:00:00 - 01:59:59	8922	4.3%	2.48	101.8 MB	4.7%	28.97
Sep 23 02:00:00 - 02:59:59	13464	6.6%	3.74	125.6 MB	5.8%	35.73
Sep 23 03:00:00 - 03:59:59	8776	4.3%	2.44	100.1 MB	4.6%	28.46
Sep 23 04:00:00 - 04:15:02	1501	0.7%	1.66	19.5 MB	0.9%	22.14
TOTAL: 24:00:00	205492	100.0%	2.38	2.1 GB	100.0%	25.52

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	newsfeed.pionier.net.pl	219	165	0	3	27	0	0	0	24
TOTAL: 1		219	165	0	3	27	0	0	0	24

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.pictures.erotica.corset	110
alt.comp.software.firefox	15
uk.railway	12
comp.sys.raspberry-pi	10
comp.mobile.android	7
it.tlc.cellulari.android	4
eternal-september.test	3
fr.usenet.documents	2
grisbi.test	1
alt.comp.software.seamonkey	1
TOTAL: 10	165

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

Groups	Count
christnet.bible	23
fr.bienvenue	4
TOTAL: 2	27

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	24
	TOTAL: 1	24
TOTAL: 1		24

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	6874	9	6217	1	0	0%	24:03:20
2	nask	0	0	0	0	89409	0%	23:57:49
3	okapi	0	0	0	0	844	0%	23:57:49
4	poznan	2	0	2	0	0	0%	00:30:08
5	panorama	0	0	0	0	91840	0%	23:57:49
TOTAL: 5		6876	9	6219	1	182093	0%	96:26:55

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	21.7 KB	4.8 KB	26.5 KB	2.6 KB	24:03:20
2	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:49
3	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:49
4	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:30:08
5	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:49
TOTAL: 5		21.7 KB	4.8 KB	26.5 KB	2.6 KB	96:26:55

Backlog files shrunk by innfeed:

Server	Size
panorama	8.1 MB
TOTAL: 1	8.1 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	69.10.48.174	10	5638	3.6 MB	4	0	00:36:38
2	web.man.lodz.pl	288	2	1.2 KB	1	0	00:00:09
3	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 3		300	5640	3.6 MB	5	2	00:37:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	112	5638	3.6 MB	4	0	00:36:56
2	*.man.lodz.pl	1730	2	1.2 KB	1	2	00:00:22
3	*.survey.inspici.com	1	0	0.0 KB	0	0	00:00:03
4	*.monitoring.internet-measurement.com	1	0	0.0 KB	0	0	00:00:01
5	*.stretchoid.com	1	0	0.0 KB	0	0	00:00:00
6	*.nycmny.fios.verizon.net	1	0	0.0 KB	0	0	00:00:12
7	*.census.shodan.io	1	0	0.0 KB	0	0	00:00:00
TOTAL: 7		1847	5640	3.6 MB	5	2	00:37:38

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
69.10.48.174	0.350	0.992	00:36:38
nms1.man.lodz.pl	3.405	6.426	00:00:12
pool-100-38-239-226.nycmny.fios.verizon.net	0.085	0.074	00:00:12
198.235.24.92	0.003	0.003	00:00:10
web.man.lodz.pl	0.801	1.255	00:00:09
198.235.24.162	0.003	0.003	00:00:04
server-0-3.survey.inspici.com	0.000	0.005	00:00:03
80.111.142.213	0.022	0.006	00:00:02
fragrant.monitoring.internet-measurement.com	0.006	0.000	00:00:01
212.51.192.185	0.252	0.444	00:00:01
soda.census.shodan.io	0.000	0.006	00:00:00
azpdsgb73.stretchoid.com	0.000	0.006	00:00:00
isvcs01.man.lodz.pl	0.004	0.016	00:00:00
TOTAL: 13	4.931	9.236	00:37:38

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	1440
212.51.192.185	96
80.111.142.213	4
198.235.24.162	1
soda.census.shodan.io	1
azpdsgb73.stretchoid.com	1
server-0-3.survey.inspici.com	1
198.235.24.92	1
pool-100-38-239-226.nycmny.fios.verizon.net	1
fragrant.monitoring.internet-measurement.com	1
TOTAL: 10	1547

NNRP unrecognized commands (by host):

System	Conn
azpdsgb73.stretchoid.com	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_212.191.2.21_119	1
TOTAL: 1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	5638	100.0%
2	pl	2	0.0%
TOTAL: 2		5640	100.0%

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

Newsgroup		Count
1	lodman.info	5588
2	lodman.test	50
3	pl.comp.os.ms-windows.winnt	2
TOTAL: 3		5640

Daily Usenet report

Sep 22 04:15:02 -- Sep 23 04:15:02