Daily Usenet report: May 15 04:15:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

May 15 17:00:13 newsfeed pgpverify[1775361]: pgpverify: /usr/bin/gpg1: no such file
May 15 17:00:13 newsfeed pgpverify[1775361]: pgpverify: /usr/bin/gpg1: no such file
May 15 17:00:36 newsfeed pgpverify[1775739]: pgpverify: /usr/bin/gpg1: no such file
May 15 17:00:36 newsfeed pgpverify[1775739]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	218074	83.8%	24.1 MB	85.7%
innd	24454	9.4%	2.3 MB	8.2%
nnrpd	16476	6.3%	1.6 MB	5.5%
innfeed	1218	0.5%	158.7 KB	0.6%
controlchan	46	0.0%	10.2 KB	0.0%
pgpverify	4	0.0%	0.3 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 7	260274	100.0%	28.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	435402	99.8%
Negative hits	752	0.2%
Positive hits	80	0.0%
Cache misses	12	0.0%
TOTAL: 4	436246	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.166	0.0%	98	0.000	1.694	41.000
article cleanup	00:00:02.468	0.0%	436102	0.000	0.006	0.012
article logging	00:00:08.984	0.0%	436140	0.010	0.021	0.037
article parse	00:00:20.848	0.0%	1281464	0.008	0.016	0.023
article write	00:01:53.194	0.1%	436090	0.192	0.260	0.643
artlog/artcncl	00:00:00.002	0.0%	30	0.000	0.067	1.000
data move	00:00:01.858	0.0%	1907280	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.026	0.0%	128	0.000	0.203	0.500
hishave/artcncl	00:00:00.000	0.0%	30	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:36.256	0.0%	436968	0.002	0.083	0.593
history sync	00:00:00.034	0.0%	654	0.000	0.052	0.500
history write	00:00:52.090	0.0%	436102	0.044	0.119	0.515
idle	47:48:03.086	99.5%	1519938	56.072	113.217	335.098
nntp read	00:00:21.810	0.0%	1199814	0.012	0.018	0.027
overview write	00:00:01.324	0.0%	436090	0.000	0.003	0.008
perl filter	00:07:37.002	0.3%	436102	0.699	1.048	1.397
python filter	00:00:00.130	0.0%	436102	0.000	0.000	0.002
site send	00:00:11.138	0.0%	883572	0.005	0.013	0.019
TOTAL: 48:01:14.766	48:00:10.416	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	11324	0.000	0.002	0.050
article prepare	00:00:00.000	0.0%	872	0.000	0.000	0.000
article read	00:00:00.002	0.0%	218	0.000	0.009	0.500
backlog stats	00:00:00.022	0.0%	70670	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.364	0.0%	32344	0.000	0.011	0.059
data write	00:00:01.192	0.0%	20942	0.000	0.057	0.141
idle	47:39:54.334	100.0%	70670	1066.218	2428.107	7153.821
status file	00:00:00.110	0.0%	312	0.000	0.353	1.000
TOTAL: 47:39:56.830	47:39:56.050	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:10.700	65.8%	8916	0.000	7.930	3837.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.348	0.3%	30136	0.000	0.012	0.500
readart	00:00:00.002	0.0%	4	0.500	0.500	0.500
TOTAL: 00:01:47.380	00:01:11.050	66.2%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
group-admin@isc.org	0	0	4	4	0	4
TOTAL	0	0	4	4	0	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	108	435816	435816	0	0	100%	68:28:40
2	news.icm.edu.pl	50	80	4	64	12	5%	10:01:36
3	localhost	2	0	0	0	0	0%	00:00:00
TOTAL: 3		160	435896	435820	64	12	99%	78:30:16

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	4.1 GB	0.0 KB	4.1 GB	100%	9.9 KB
2	news.icm.edu.pl	273.4 KB	1.0 MB	1.3 MB	20%	82.8 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		4.1 GB	1.0 MB	4.1 GB	99%	9.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 15 04:15:01 - 04:59:59	3257	1.5%	1.21	33.2 MB	1.6%	12.60
May 15 05:00:00 - 05:59:59	6172	2.8%	1.71	63.1 MB	3.0%	17.94
May 15 06:00:00 - 06:59:59	6104	2.8%	1.70	67.1 MB	3.2%	19.07
May 15 07:00:00 - 07:59:59	6589	3.0%	1.83	64.3 MB	3.0%	18.29
May 15 08:00:00 - 08:59:59	7158	3.3%	1.99	72.8 MB	3.4%	20.70
May 15 09:00:00 - 09:59:59	7291	3.3%	2.03	75.9 MB	3.6%	21.60
May 15 10:00:00 - 10:59:59	10529	4.8%	2.92	97.2 MB	4.6%	27.66
May 15 11:00:00 - 11:59:59	9372	4.3%	2.60	104.3 MB	4.9%	29.67
May 15 12:00:00 - 12:59:59	11514	5.3%	3.20	133.1 MB	6.3%	37.85
May 15 13:00:00 - 13:59:59	11677	5.4%	3.24	121.7 MB	5.8%	34.61
May 15 14:00:00 - 14:59:59	10426	4.8%	2.90	97.0 MB	4.6%	27.60
May 15 15:00:00 - 15:59:59	11674	5.4%	3.24	109.7 MB	5.2%	31.21
May 15 16:00:00 - 16:59:59	11390	5.2%	3.16	93.6 MB	4.4%	26.61
May 15 17:00:00 - 17:59:59	9596	4.4%	2.67	88.7 MB	4.2%	25.22
May 15 18:00:00 - 18:59:59	10869	5.0%	3.02	111.6 MB	5.3%	31.75
May 15 19:00:00 - 19:59:59	9245	4.2%	2.57	82.5 MB	3.9%	23.47
May 15 20:00:00 - 20:59:59	9771	4.5%	2.71	89.7 MB	4.3%	25.52
May 15 21:00:00 - 21:59:59	9411	4.3%	2.61	92.0 MB	4.4%	26.18
May 15 22:00:00 - 22:59:59	8529	3.9%	2.37	83.7 MB	4.0%	23.79
May 15 23:00:00 - 23:59:59	8864	4.1%	2.46	93.1 MB	4.4%	26.48
May 16 00:00:00 - 00:59:59	10203	4.7%	2.83	91.6 MB	4.3%	26.05
May 16 01:00:00 - 01:59:59	8776	4.0%	2.44	84.9 MB	4.0%	24.15
May 16 02:00:00 - 02:59:59	8771	4.0%	2.44	65.5 MB	3.1%	18.64
May 16 03:00:00 - 03:59:59	8686	4.0%	2.41	75.7 MB	3.6%	21.52
May 16 04:00:00 - 04:15:01	2160	1.0%	2.40	18.5 MB	0.9%	21.06
TOTAL: 24:00:00	218034	100.0%	2.52	2.1 GB	100.0%	25.01

Sites sending bad articles:

Server		Total	Other
1	newsfeed.pionier.net.pl	19	19
2	news.icm.edu.pl	6	6
TOTAL: 2		25	25

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	10
Scoring filter (16)	2
TOTAL: 2	12

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	icm	21000	200	11148	18	0%	47:59:56
2	poznan	2	0	2	0	0%	00:40:00
TOTAL: 2		21002	200	11150	18	0%	48:39:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	532.6 KB	154.0 KB	686.6 KB	3.1 KB	47:59:56
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:40:00
TOTAL: 2		532.6 KB	154.0 KB	686.6 KB	3.1 KB	48:39:56

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	172.16.2.4	576	4	7.2 KB	2	0	0	00:00:34
TOTAL: 1		576	4	7.2 KB	2	0	0	00:01:47

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	796	4	7.2 KB	2	00:01:16
2	*.scanner.modat.io	2	0	0.0 KB	0	00:00:00
3	*.man.lodz.pl	2880	0	0.0 KB	0	00:00:31
TOTAL: 3		3678	4	7.2 KB	2	00:01:47

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
172.16.2.4	2.246	4.366	00:00:34
nms1.man.lodz.pl	10.902	20.124	00:00:31
167.94.138.182	0.094	0.028	00:00:12
199.45.155.74	0.090	0.056	00:00:10
198.235.24.23	0.008	0.006	00:00:07
80.111.142.213	0.028	0.044	00:00:04
198.235.24.166	0.006	0.008	00:00:04
212.51.192.185	0.754	1.506	00:00:02
20.64.106.39	0.004	0.010	00:00:00
205.210.31.56	0.006	0.020	00:00:00
b6.scanner.modat.io	0.010	0.018	00:00:00
TOTAL: 11	14.148	26.186	00:01:47

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	2880
212.51.192.185	192
80.111.142.213	8
167.94.138.182	6
199.45.155.74	6
b6.scanner.modat.io	2
20.64.106.39	2
198.235.24.166	2
198.235.24.23	2
205.210.31.56	2
TOTAL: 10	3102

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

System	Conn
167.94.138.182	2
20.64.106.39	2
199.45.155.74	2
TOTAL: 3	6

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

Command	Count
EHLO www.censys.io	4
MGLNDD_212.191.2.21_119	2
TOTAL: 2	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.138.182	2	4
199.45.155.74	2	4
TOTAL: 2	4	14

Newsgroup request counts (by hierarchy):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	4
TOTAL: 1		4

Daily Usenet report

May 15 04:15:01 -- May 16 04:15:01