Daily Usenet report: Oct 16 15:00:05

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 16 15:01:21 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Oct 16 20:00:03 colo-sc-1 pgpverify[30140]: pgpverify: verification failed
Oct 16 20:00:03 colo-sc-1 controlchan[9047]: skipping newgroup y group-admin@isc.org (pgpverify failed) in <cmsg-20231016200002$5a6b@isc.org>
Oct 16 20:00:06 colo-sc-1 pgpverify[30186]: pgpverify: verification failed
Oct 16 20:00:06 colo-sc-1 controlchan[9047]: skipping newgroup y group-admin@isc.org (pgpverify failed) in <cmsg-20231016200003$1896@isc.org>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	61431	53.4%	9.4 MB	51.5%
innd	44123	38.3%	7.3 MB	40.3%
cnfsstat	8088	7.0%	1.2 MB	6.9%
innfeed	1268	1.1%	214.9 KB	1.2%
nnrpd	157	0.1%	18.1 KB	0.1%
controlchan	3	0.0%	0.2 KB	0.0%
pgpverify	2	0.0%	0.3 KB	0.0%
overchan	2	0.0%	0.4 KB	0.0%
TOTAL: 8	115074	100.0%	18.2 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	101935	44.1%
Positive hits	70336	30.5%
Do not exist	57919	25.1%
Cache misses	697	0.3%
TOTAL: 4	230887	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.023	0.0%	44	0.000	0.523	4.000
article cleanup	00:00:00.377	0.0%	61255	0.000	0.006	0.016
article logging	00:00:02.873	0.0%	61274	0.004	0.047	0.864
article parse	00:00:01.200	0.0%	173529	0.001	0.007	0.021
article write	00:00:03.212	0.0%	14839	0.000	0.216	5.155
artlog/artcncl	00:00:00.000	0.0%	25	0.000	0.000	0.000
data move	00:00:03.580	0.0%	266113	0.000	0.013	0.041
hisgrep/artcncl	00:00:00.007	0.0%	35	0.000	0.200	1.500
hishave/artcncl	00:00:00.003	0.0%	44	0.000	0.068	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:32.464	0.0%	231290	0.001	0.140	1.496
history sync	00:00:00.011	0.0%	327	0.000	0.034	1.000
history write	00:00:06.020	0.0%	57853	0.018	0.104	1.365
hiswrite/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
idle	11:40:37.638	48.8%	224892	0.000	186.924	374.144
nntp read	00:00:02.145	0.0%	254761	0.003	0.008	0.039
overview write	00:00:00.047	0.0%	14839	0.000	0.003	0.026
perl filter	12:15:00.462	51.2%	57853	118.208	762.285	1383.476
python filter	00:00:01.439	0.0%	57853	0.005	0.025	0.064
site send	00:00:02.851	0.0%	44519	0.025	0.064	0.132
TOTAL: 23:56:57.693	23:56:34.352	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.030	0.0%	14717	0.000	0.002	0.035
article prepare	00:00:00.000	0.0%	6025	0.000	0.000	0.000
article read	00:00:00.321	0.0%	4918	0.000	0.065	1.250
backlog stats	00:00:00.066	0.0%	86398	0.000	0.001	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.361	0.0%	54708	0.000	0.007	0.019
data write	00:00:01.029	0.0%	40862	0.000	0.025	0.103
idle	23:49:05.678	100.0%	86398	273.834	992.450	2318.390
status file	00:00:00.551	0.0%	169	0.000	3.260	98.000
TOTAL: 23:49:11.017	23:49:08.036	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:04:51.221	93.3%	327	726.811	890.584	2747.818
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:05.698	1.8%	379710	0.000	0.015	1.000
readart	00:00:01.404	0.4%	286	1.294	4.909	5.138
TOTAL: 00:05:12.135	00:04:58.323	95.6%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	4
reserve	2
shutdown	3
TOTAL: 12	175

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	28	45833	11597	25247	8989	25%	63:36:34
2	news.nntp4.net	9	52796	1907	21072	29817	3%	41:54:51
3	usenet.blueworldhosting.com	289	29950	1380	20884	7686	4%	26:49:28
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		327	128579	14884	67203	46492	11%	132:20:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	35.2 MB	13.3 MB	55.2 MB	103.8 MB	33%	5.2 KB
2	news.nntp4.net	6.1 MB	5.5 MB	252.3 MB	263.9 MB	2%	8.5 KB
3	usenet.blueworldhosting.com	4.6 MB	1.9 MB	38.2 MB	44.7 MB	10%	5.0 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		45.9 MB	20.7 MB	345.7 MB	412.3 MB	11%	6.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 16 15:00:05 - 15:59:59	737	5.0%	0.21	2.1 MB	4.6%	0.60
Oct 16 16:00:00 - 16:59:59	581	3.9%	0.16	1.9 MB	4.1%	0.53
Oct 16 17:00:00 - 17:59:59	574	3.9%	0.16	1.7 MB	3.7%	0.49
Oct 16 18:00:00 - 18:59:59	612	4.1%	0.17	2.1 MB	4.6%	0.60
Oct 16 19:00:00 - 19:59:59	549	3.7%	0.15	2.0 MB	4.3%	0.56
Oct 16 20:00:00 - 20:59:59	568	3.8%	0.16	2.1 MB	4.5%	0.59
Oct 16 21:00:00 - 21:59:59	542	3.6%	0.15	2.0 MB	4.4%	0.57
Oct 16 22:00:00 - 22:59:59	1400	9.4%	0.39	3.1 MB	6.8%	0.89
Oct 16 23:00:00 - 23:59:59	641	4.3%	0.18	1.8 MB	3.9%	0.52
Oct 17 00:00:00 - 00:59:59	358	2.4%	0.10	1.3 MB	2.8%	0.37
Oct 17 01:00:00 - 01:59:59	333	2.2%	0.09	1.3 MB	2.8%	0.36
Oct 17 02:00:00 - 02:59:59	305	2.1%	0.08	1.1 MB	2.4%	0.31
Oct 17 03:00:00 - 03:59:59	271	1.8%	0.08	1.1 MB	2.3%	0.30
Oct 17 04:00:00 - 04:59:59	359	2.4%	0.10	1.4 MB	3.0%	0.39
Oct 17 05:00:00 - 05:59:59	310	2.1%	0.09	1.2 MB	2.5%	0.33
Oct 17 06:00:00 - 06:59:59	522	3.5%	0.14	1.6 MB	3.5%	0.46
Oct 17 07:00:00 - 07:59:59	547	3.7%	0.15	1.6 MB	3.5%	0.46
Oct 17 08:00:00 - 08:59:59	572	3.8%	0.16	1.9 MB	4.1%	0.54
Oct 17 09:00:00 - 09:59:59	586	3.9%	0.16	1.9 MB	4.2%	0.54
Oct 17 10:00:00 - 10:59:59	798	5.4%	0.22	2.5 MB	5.4%	0.71
Oct 17 11:00:00 - 11:59:59	701	4.7%	0.19	2.3 MB	4.9%	0.64
Oct 17 12:00:00 - 12:59:59	1077	7.2%	0.30	3.1 MB	6.8%	0.89
Oct 17 13:00:00 - 13:59:59	831	5.6%	0.23	2.3 MB	5.0%	0.65
Oct 17 14:00:00 - 15:00:01	1091	7.3%	0.30	2.7 MB	5.9%	0.77
TOTAL: 23:59:56	14865	100.0%	0.17	45.9 MB	100.0%	0.54

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
EIGHT	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
FIVE	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
FOUR	DEFAULT	1024.0 MB	418.9 MB	40.9%	24	0.60	20.10
ONE	DEFAULT	1024.0 MB	582.2 MB	56.9%	26	0.62	19.42
SEVEN	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
SIX	BIG	4.0 GB	2.9 GB	72.8%	1	0.00	0.00
THREE	DEFAULT	1024.0 MB	424.8 MB	41.5%	24	0.61	20.06
TWO	DEFAULT	1024.0 MB	412.4 MB	40.3%	24	0.59	20.64
TOTAL: 8	-	20.0 GB	13.4 GB	67.1%	102	0.61	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	29798	3	890	28905
2	hasname-out.news.weretis.net	9001	6	2215	6780
3	usenet.blueworldhosting.com	7742	1803	297	5642
TOTAL: 3		46541	1812	3402	41327

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.sci.announce	512
linux.kernel.netdev	445
de.sci.medizin	380
kraft.competent	61
fido7.ukrnews	59
kraft.vehicles	55
kraft.talks	50
fido7.pushkin.local	46
linux.kernel.git	34
odessa.news	28
panix.chat.politics	15
fido7.starper.limited	14
fido7.altyn.local	13
perl.cpan	13
fido7.lorapvt.horo	12
alt.stupid	9
kraft.politics	9
fido7.f715.techinfo	6
fido7.fidonet.online	5
kraft.marketplace.free	4
TOTAL: 45	1812

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4340
Reject Google Groups posting to comp.protocols.dicom by SpamAssassin (score 7.602)	4065
Reject Google Groups posting to comp.lang.c by SpamAssassin (score 7.602)	2277
Reject Google Groups posting to comp.protocols.dicom by SpamAssassin (score 6.623)	2129
Reject Google Groups posting to comp.lang.c by SpamAssassin (score 6.623)	1360
Reject Google Groups posting to comp.protocols.dicom by SpamAssassin (score 7.601)	1162
Reject Google Groups posting to sci.crypt by SpamAssassin (score 7.602)	1111
Reject Google Groups posting to comp.lang.c by SpamAssassin (score 6.622)	1026
Reject Google Groups posting to bit.listserv.ibm-main by SpamAssassin (score 6.622)	974
Reject Google Groups posting to comp.lang.c by SpamAssassin (score 7.601)	925
Reject Google Groups posting to bit.listserv.ibm-main by SpamAssassin (score 7.602)	922
EMP (phn path)	848
Reject Google Groups posting to comp.protocols.dicom by SpamAssassin	718
Reject Google Groups posting to bit.listserv.ibm-main by SpamAssassin (score 8.128)	717
Reject Google Groups posting to bit.listserv.ibm-main by SpamAssassin	635
Reject Google Groups posting to comp.protocols.dicom by SpamAssassin (score 9.108)	623
Reject Google Groups posting to comp.lang.c by SpamAssassin	565
Reject Google Groups posting to sci.crypt by SpamAssassin (score 6.622)	533
Reject Google Groups posting to sci.crypt by SpamAssassin (score 7.601)	504
Reject Google Groups posting to comp.protocols.dicom by SpamAssassin (score 6.622)	437
TOTAL: 1632	41308

INND no permission servers:

System	Conn
80.66.88.215	1
TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	10
	hasname-out.news.weretis.net	7
	news.nntp4.net	2
	TOTAL: 3	19
TOTAL: 1		19

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	4793	4791	0	2	0	99%	23:59:32
2	nntp4	13206	209	12703	38	0	1%	23:59:34
3	weretis	3096	17	2626	54	16	0%	23:57:13
4	blueworldhosting	15413	3	12980	3	35	0%	23:59:34
5	aioe	0	0	0	0	14736	0%	23:59:33
TOTAL: 5		36508	5020	28309	97	14787	13%	119:55:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	bbsgslincom	23.6 MB	5.3 KB	23.6 MB	0.3 KB/s	5.0 KB	23:59:32
2	nntp4	537.8 KB	125.9 KB	663.7 KB	0.0 KB/s	2.7 KB	23:59:34
3	weretis	47.2 KB	82.8 KB	129.9 KB	0.0 KB/s	1.8 KB	23:57:13
4	blueworldhosting	4.6 KB	9.1 KB	13.7 KB	0.0 KB/s	2.3 KB	23:59:34
5	aioe	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:33
TOTAL: 5		24.1 MB	223.0 KB	24.4 MB	0.1 KB/s	4.9 KB	119:55:26

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	114-34-121-114.hinet-ip.hinet.net	3	286	2.0 MB	7	0	0	00:05:11
TOTAL: 1		3	286	2.0 MB	7	0	0	00:05:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.hinet-ip.hinet.net	3	286	2.0 MB	7	0	0	00:05:11
TOTAL: 1		3	286	2.0 MB	7	0	0	00:05:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
114-34-121-114.hinet-ip.hinet.net	1.382	3.702	00:05:11
172-104-4-17.ip.linodeusercontent.com	0.017	0.037	00:00:00
einstein.census.shodan.io	0.002	0.002	00:00:00
162.243.142.57	0.000	0.002	00:00:00
94.232.43.50	0.001	0.003	00:00:00
TOTAL: 5	1.402	3.746	00:05:12

NNRP no permission clients:

System	Conn
172-104-4-17.ip.linodeusercontent.com	27
einstein.census.shodan.io	2
94.232.43.50	2
162.243.142.57	1
TOTAL: 4	32

Newsgroup request counts (by category):

Category		Count	Pct
1	sci	247	86.4%
2	comp	34	11.9%
3	news	5	1.7%
TOTAL: 3		286	100.0%

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

Newsgroup		Count
1	sci.crypt	247
2	comp.lang.c	32
3	news.software.nntp	4
4	comp.lang.python	2
5	news.software.readers	1
TOTAL: 5		286

Daily Usenet report

Oct 16 15:00:05 -- Oct 17 15:00:01