Daily Usenet report: Oct 13 04:15:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Oct 13 06:32:59 newsfeed nnrpd[1858534]: SERVER perl filter not defined
Oct 13 06:32:59 newsfeed nnrpd[1858534]: SERVER perl filter not defined
Oct 13 11:05:01 newsfeed nnrpd[1891219]: SERVER perl filter not defined
Oct 13 11:05:01 newsfeed nnrpd[1891219]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	193390	82.0%	21.3 MB	84.1%
innd	25500	10.8%	2.4 MB	9.5%
nnrpd	15718	6.7%	1.5 MB	5.8%
innfeed	1284	0.5%	150.5 KB	0.6%
controlchan	2	0.0%	0.1 KB	0.0%
overchan	2	0.0%	0.2 KB	0.0%
TOTAL: 6	235896	100.0%	25.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	385834	99.7%
Negative hits	740	0.2%
Positive hits	128	0.0%
Cache misses	120	0.0%
TOTAL: 4	386822	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.010	0.0%	72	0.000	0.139	2.000
article cleanup	00:00:01.042	0.0%	386560	0.000	0.003	0.006
article logging	00:00:04.816	0.0%	386690	0.006	0.012	0.020
article parse	00:00:08.508	0.0%	1501312	0.003	0.006	0.009
article write	00:00:13.192	0.0%	386428	0.019	0.034	0.055
artlog/artcncl	00:00:00.000	0.0%	14	0.000	0.000	0.000
data move	00:00:01.466	0.0%	2272648	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.002	0.0%	86	0.000	0.023	0.250
hishave/artcncl	00:00:00.000	0.0%	14	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.404	0.0%	387694	0.000	0.004	0.013
history sync	00:00:00.028	0.0%	608	0.000	0.046	0.500
history write	00:00:16.640	0.0%	386428	0.022	0.043	0.101
idle	47:55:05.448	99.8%	1811074	41.399	95.250	263.324
nntp read	00:00:12.734	0.0%	1459038	0.005	0.009	0.013
overview write	00:00:00.548	0.0%	386428	0.000	0.001	0.005
perl filter	00:03:46.028	0.1%	386428	0.472	0.585	0.744
python filter	00:00:00.062	0.0%	386432	0.000	0.000	0.001
site send	00:00:05.356	0.0%	792300	0.001	0.007	0.011
TOTAL: 48:00:34.920	47:59:57.284	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	19438	0.000	0.002	0.029
article prepare	00:00:00.000	0.0%	1640	0.000	0.000	0.000
article read	00:00:00.012	0.0%	410	0.000	0.029	1.000
backlog stats	00:00:00.020	0.0%	106688	0.000	0.000	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.370	0.0%	53488	0.000	0.007	0.032
data write	00:00:00.958	0.0%	33310	0.000	0.029	0.073
idle	47:58:31.406	100.0%	106688	470.348	1618.846	3551.515
status file	00:00:00.166	0.0%	336	0.000	0.494	4.000
TOTAL: 47:58:33.874	47:58:32.976	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:22.130	66.7%	8738	1.000	9.399	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.198	0.2%	29668	0.000	0.007	0.333
readart	00:00:00.000	0.0%	8	0.000	0.000	0.000
TOTAL: 00:02:03.098	00:01:22.328	66.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	54
flushlogs	4
go	4
logmode	4
lowmark	2
mode	298
name	4
pause	4
paused	4
reload	4
reserve	4
TOTAL: 11	386

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	168	386822	386690	4	128	99%	67:13:34
2	news.icm.edu.pl	48	122	16	102	4	13%	13:09:52
3	localhost	6	4	4	0	0	100%	00:00:00
TOTAL: 3		222	386948	386710	106	132	99%	80:23:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	4.7 GB	2.2 MB	4.7 GB	99%	12.7 KB
2	news.icm.edu.pl	1.0 MB	56.5 KB	1.1 MB	94%	56.1 KB
3	localhost	5.8 KB	0.0 KB	5.8 KB	100%	1.4 KB
TOTAL: 3		4.7 GB	2.3 MB	4.7 GB	99%	12.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 13 04:15:01 - 04:59:59	3274	1.7%	1.21	41.5 MB	1.7%	15.73
Oct 13 05:00:00 - 05:59:59	4483	2.3%	1.25	59.8 MB	2.5%	17.02
Oct 13 06:00:00 - 06:59:59	6227	3.2%	1.73	77.7 MB	3.2%	22.09
Oct 13 07:00:00 - 07:59:59	8569	4.4%	2.38	107.6 MB	4.5%	30.59
Oct 13 08:00:00 - 08:59:59	7445	3.9%	2.07	89.9 MB	3.8%	25.58
Oct 13 09:00:00 - 09:59:59	10602	5.5%	2.94	138.8 MB	5.8%	39.49
Oct 13 10:00:00 - 10:59:59	10677	5.5%	2.97	133.9 MB	5.6%	38.09
Oct 13 11:00:00 - 11:59:59	11557	6.0%	3.21	143.4 MB	6.0%	40.79
Oct 13 12:00:00 - 12:59:59	9192	4.8%	2.55	137.4 MB	5.7%	39.08
Oct 13 13:00:00 - 13:59:59	9381	4.9%	2.61	110.6 MB	4.6%	31.45
Oct 13 14:00:00 - 14:59:59	8778	4.5%	2.44	100.9 MB	4.2%	28.70
Oct 13 15:00:00 - 15:59:59	8693	4.5%	2.41	97.5 MB	4.1%	27.74
Oct 13 16:00:00 - 16:59:59	11359	5.9%	3.16	169.4 MB	7.1%	48.17
Oct 13 17:00:00 - 17:59:59	8622	4.5%	2.40	117.1 MB	4.9%	33.31
Oct 13 18:00:00 - 18:59:59	7168	3.7%	1.99	80.9 MB	3.4%	23.01
Oct 13 19:00:00 - 19:59:59	6183	3.2%	1.72	64.0 MB	2.7%	18.20
Oct 13 20:00:00 - 20:59:59	8530	4.4%	2.37	89.9 MB	3.8%	25.57
Oct 13 21:00:00 - 21:59:59	6933	3.6%	1.93	77.6 MB	3.2%	22.07
Oct 13 22:00:00 - 22:59:59	7037	3.6%	1.95	78.5 MB	3.3%	22.33
Oct 13 23:00:00 - 23:59:59	8292	4.3%	2.30	92.7 MB	3.9%	26.37
Oct 14 00:00:00 - 00:59:59	7468	3.9%	2.07	88.7 MB	3.7%	25.23
Oct 14 01:00:00 - 01:59:59	7405	3.8%	2.06	101.2 MB	4.2%	28.79
Oct 14 02:00:00 - 02:59:59	7206	3.7%	2.00	89.6 MB	3.7%	25.50
Oct 14 03:00:00 - 03:59:59	6343	3.3%	1.76	78.9 MB	3.3%	22.43
Oct 14 04:00:00 - 04:15:01	1828	0.9%	2.03	26.6 MB	1.1%	30.26
TOTAL: 24:00:00	193252	100.0%	2.24	2.3 GB	100.0%	28.37

Sites sending bad articles:

Server		Total	Duplic	Other
1	newsfeed.pionier.net.pl	129	64	65
2	news.icm.edu.pl	2	2	0
TOTAL: 2		131	66	65

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	35750	404	19018	6	6	1%	47:59:12
2	poznan	30	0	16	0	0	0%	02:43:18
TOTAL: 2		35780	404	19034	6	6	1%	50:42:30

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	938.2 KB	14.6 KB	952.8 KB	2.3 KB	47:59:12
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	02:43:18
TOTAL: 2		938.2 KB	14.6 KB	952.8 KB	2.3 KB	50:42:30

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	172.16.2.4	574	8	9.4 KB	4	0	00:00:33
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 2		578	8	9.4 KB	4	4	00:02:03

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	598	8	9.4 KB	4	0	00:01:14
2	*.monitoring.internet-measurement.com	2	0	0.0 KB	0	0	00:00:03
3	*.stretchoid.com	4	0	0.0 KB	0	0	00:00:20
4	*.man.lodz.pl	2884	0	0.0 KB	0	4	00:00:25
TOTAL: 4		3488	8	9.4 KB	4	4	00:02:03

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
172.16.2.4	1.344	3.042	00:00:33
nms1.man.lodz.pl	6.202	14.382	00:00:24
azpdsgli2n2r.stretchoid.com	0.012	0.016	00:00:20
165.154.14.113	0.006	0.008	00:00:11
205.210.31.206	0.006	0.008	00:00:08
167.94.146.56	0.076	0.030	00:00:08
80.111.142.213	0.018	0.046	00:00:06
205.210.31.200	0.002	0.012	00:00:04
fortified.monitoring.internet-measurement.com	0.002	0.012	00:00:03
66.132.153.140	0.064	0.010	00:00:00
147.185.132.66	0.004	0.008	00:00:00
isvcs01.man.lodz.pl	0.020	0.014	00:00:00
TOTAL: 12	7.756	17.588	00:02:03

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	2880
80.111.142.213	8
167.94.146.56	6
azpdsgli2n2r.stretchoid.com	4
205.210.31.206	2
147.185.132.66	2
165.154.14.113	2
fortified.monitoring.internet-measurement.com	2
205.210.31.200	2
66.132.153.140	2
TOTAL: 10	2910

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
165.154.14.113	12
66.132.153.140	2
167.94.146.56	2
azpdsgli2n2r.stretchoid.com	2
TOTAL: 4	18

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
EHLO www.censys.io	4
Accept: /	2
Connection: Close	2
MGLNDD_212.191.2.21_119	2
User-Agent: Mozilla/5.0 (Windows NT 10.0...	2
Accept-Language: zh-CN,zh;q=0.9,zh-TW;q=...	2
Host: 212.191.2.21:119	2
GET / HTTP/1.1	2
TOTAL: 8	18

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.146.56	2	4
TOTAL: 1	2	10

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	pl	8	100.0%
TOTAL: 1		8	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	8
TOTAL: 1		8

Daily Usenet report

Oct 13 04:15:01 -- Oct 14 04:15:01