Daily Usenet report: Oct 15 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Oct 15 07:49:57 newsfeed nnrpd[572680]: SERVER perl filter not defined
Oct 15 08:03:26 newsfeed nnrpd[573252]: SERVER perl filter not defined
Oct 15 08:04:09 newsfeed nnrpd[573261]: SERVER perl filter not defined
Oct 15 14:12:24 newsfeed overchan[562744]: input line too long, skipping
Oct 15 14:13:02 newsfeed overchan[562744]: input line too long, skipping
Oct 15 17:00:05 newsfeed pgpverify[597488]: pgpverify: /usr/bin/gpg1: no such file
Oct 15 17:00:14 newsfeed pgpverify[597503]: pgpverify: /usr/bin/gpg1: no such file
Oct 15 20:09:09 newsfeed overchan[562744]: input line too long, skipping
Oct 15 21:35:09 newsfeed overchan[562744]: input line too long, skipping
Oct 15 22:09:24 newsfeed overchan[562744]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	143627	86.2%	17.1 MB	86.6%
innd	13493	8.1%	1.7 MB	8.6%
nnrpd	7659	4.6%	773.8 KB	3.8%
innfeed	1724	1.0%	192.4 KB	1.0%
controlchan	23	0.0%	4.9 KB	0.0%
overchan	5	0.0%	0.7 KB	0.0%
pgpverify	2	0.0%	0.4 KB	0.0%
TOTAL: 7	166533	100.0%	19.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	142463	90.7%
Negative hits	13292	8.5%
Positive hits	1180	0.8%
Cache misses	57	0.0%
TOTAL: 4	156992	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.964	0.0%	89	0.000	22.067	57.000
article cleanup	00:00:01.046	0.0%	144323	0.002	0.007	0.021
article logging	00:00:03.454	0.0%	144338	0.012	0.024	0.041
article parse	00:00:07.807	0.0%	1036331	0.004	0.008	0.012
article write	00:00:25.356	0.0%	132418	0.060	0.191	1.462
artlog/artcncl	00:00:00.004	0.0%	81	0.000	0.049	1.000
data move	00:00:01.154	0.0%	1316488	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.718	0.0%	88	0.000	8.159	26.000
hishave/artcncl	00:00:00.433	0.0%	89	0.000	4.865	15.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:18:37.971	1.3%	158712	2.585	7.044	13.479
history sync	00:00:00.016	0.0%	355	0.000	0.045	0.500
history write	00:10:46.665	0.7%	144141	1.880	4.486	9.211
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:26:45.141	97.6%	1163017	4.483	72.574	294.698
nntp read	00:00:16.301	0.0%	1044180	0.009	0.016	0.029
overview write	00:00:00.419	0.0%	132418	0.000	0.003	0.010
perl filter	00:03:02.665	0.2%	144141	0.759	1.267	1.866
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:04.375	0.0%	287596	0.008	0.015	0.023
TOTAL: 24:00:53.291	24:00:15.489	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.054	0.0%	22691	0.000	0.002	0.024
article prepare	00:00:00.000	0.0%	272	0.000	0.000	0.000
article read	00:00:00.001	0.0%	68	0.000	0.015	0.167
backlog stats	00:00:00.032	0.0%	98664	0.000	0.000	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.509	0.0%	54248	0.000	0.009	0.034
data write	00:00:01.237	0.0%	31590	0.005	0.039	0.090
idle	23:55:29.286	100.0%	98664	214.388	872.956	3687.245
status file	00:00:00.444	0.0%	509	0.000	0.872	8.296
TOTAL: 23:55:33.030	23:55:31.563	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:32.646	62.7%	4197	0.000	7.778	9582.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.177	0.3%	10185	0.000	0.017	0.500
readart	00:00:00.002	0.0%	20	0.000	0.100	0.500
TOTAL: 00:00:52.100	00:00:32.825	63.0%	-	-	-	-

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

Control Channel:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	77	131828	131509	15	304	99%	45:46:17
2	news.icm.edu.pl	2	12754	185	955	11614	1%	24:02:35
3	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 3		83	144585	131697	970	11918	91%	69:48:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	2.3 GB	9.7 MB	10.1 MB	2.3 GB	99%	18.4 KB
2	news.icm.edu.pl	11.4 MB	380.8 KB	132.6 MB	144.5 MB	7%	12.5 KB
3	localhost	4.3 KB	0.0 KB	0.0 KB	4.3 KB	100%	1.4 KB
TOTAL: 3		2.3 GB	10.1 MB	142.7 MB	2.5 GB	93%	17.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 15 04:15:02 - 04:59:59	3912	3.0%	1.45	33.2 MB	1.4%	12.58
Oct 15 05:00:00 - 05:59:59	3891	3.0%	1.08	40.4 MB	1.7%	11.49
Oct 15 06:00:00 - 06:59:59	4486	3.4%	1.25	45.5 MB	1.9%	12.93
Oct 15 07:00:00 - 07:59:59	5343	4.1%	1.48	86.0 MB	3.6%	24.45
Oct 15 08:00:00 - 08:59:59	5782	4.4%	1.61	112.9 MB	4.8%	32.12
Oct 15 09:00:00 - 09:59:59	5681	4.3%	1.58	112.0 MB	4.7%	31.85
Oct 15 10:00:00 - 10:59:59	5132	3.9%	1.43	83.4 MB	3.5%	23.71
Oct 15 11:00:00 - 11:59:59	5535	4.2%	1.54	78.0 MB	3.3%	22.20
Oct 15 12:00:00 - 12:59:59	8343	6.3%	2.32	290.6 MB	12.3%	82.67
Oct 15 13:00:00 - 13:59:59	6302	4.8%	1.75	154.0 MB	6.5%	43.81
Oct 15 14:00:00 - 14:59:59	9365	7.1%	2.60	476.0 MB	20.1%	135.39
Oct 15 15:00:00 - 15:59:59	7511	5.7%	2.09	193.3 MB	8.2%	54.99
Oct 15 16:00:00 - 16:59:59	5357	4.1%	1.49	84.8 MB	3.6%	24.11
Oct 15 17:00:00 - 17:59:59	5420	4.1%	1.51	83.1 MB	3.5%	23.64
Oct 15 18:00:00 - 18:59:59	5574	4.2%	1.55	65.6 MB	2.8%	18.65
Oct 15 19:00:00 - 19:59:59	4024	3.1%	1.12	41.4 MB	1.8%	11.77
Oct 15 20:00:00 - 20:59:59	5584	4.2%	1.55	51.5 MB	2.2%	14.64
Oct 15 21:00:00 - 21:59:59	4522	3.4%	1.26	39.9 MB	1.7%	11.34
Oct 15 22:00:00 - 22:59:59	4019	3.1%	1.12	39.1 MB	1.7%	11.12
Oct 15 23:00:00 - 23:59:59	5745	4.4%	1.60	60.3 MB	2.6%	17.15
Oct 16 00:00:00 - 00:59:59	5188	3.9%	1.44	47.7 MB	2.0%	13.57
Oct 16 01:00:00 - 01:59:59	5404	4.1%	1.50	48.7 MB	2.1%	13.84
Oct 16 02:00:00 - 02:59:59	4403	3.3%	1.22	44.6 MB	1.9%	12.70
Oct 16 03:00:00 - 03:59:59	3592	2.7%	1.00	33.2 MB	1.4%	9.45
Oct 16 04:00:00 - 04:15:01	1559	1.2%	1.73	17.4 MB	0.7%	19.73
TOTAL: 23:59:59	131674	100.0%	1.52	2.3 GB	100.0%	28.00

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.icm.edu.pl	11554	0	20	0	11534
2	newsfeed.pionier.net.pl	318	136	161	1	20
TOTAL: 2		11872	136	181	1	11554

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.misc.actualite.covid19	30
uk.railway	23
it.tlc.cellulari.android	17
comp.mobile.ipad	12
eternal-september.support	12
it.comp.os.win.windows10	7
fr.misc.automobile.electrique	6
nl.comp.os.linux.techniek	4
comp.infosystems.gemini	4
alt.comp.software.firefox	4
rocksolid.nodes	3
comp.sys.raspberry-pi	3
rocksolid.programming	2
comp.lang.go	2
it.comp.virtualizzazione	1
alt.comp.software.seamonkey	1
grisbi.test	1
comp.mobile.android	1
rocksolid.shared.i2p	1
it.discussioni.energia	1
TOTAL: 21	136

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

Groups	Count
fr.bienvenue	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	11477
Scoring filter (9)	18
Scoring filter (10)	16
EMP (md5)	14
Scoring filter (8)	11
Scoring filter (12)	3
TOTAL: 6	11539

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	31366	58	22400	10	0	0%	23:59:43
2	poznan	237	0	182	0	1	0%	20:21:47
3	okapi	0	0	0	0	645	0%	23:50:03
4	nask	0	0	0	0	18139	0%	23:50:03
5	panorama	0	0	0	0	22642	0%	23:50:03
TOTAL: 5		31603	58	22582	10	41427	0%	115:51:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	151.2 KB	34.8 KB	186.1 KB	2.7 KB	23:59:43
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	20:21:47
3	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:50:03
4	nask	0.0 KB	0.0 KB	0.0 KB	0	23:50:03
5	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:50:03
TOTAL: 5		151.2 KB	34.8 KB	186.1 KB	2.7 KB	115:51:39

Backlog files shrunk by innfeed:

Server	Size
panorama	1.9 MB
TOTAL: 1	1.9 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	287	20	21.6 KB	10	0	00:00:09
2	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 2		290	20	21.6 KB	10	3	00:00:52

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	1730	20	21.6 KB	10	3	00:00:24
2	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
3	*.internet-census.org	1	0	0.0 KB	0	0	00:00:10
4	*.monitoring.internet-measurement.com	1	0	0.0 KB	0	0	00:00:01
5	*.dynamic.inetia.pl	1	0	0.0 KB	0	0	00:00:00
6	unresolved	103	0	0.0 KB	0	0	00:00:14
TOTAL: 6		1837	20	21.6 KB	10	3	00:00:52

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms2.man.lodz.pl	4.783	8.808	00:00:14
zl-ams-nl-gp1-wk129e.internet-census.org	0.000	0.011	00:00:10
107.170.233.41	0.007	0.005	00:00:09
web.man.lodz.pl	1.033	1.702	00:00:09
80.111.142.213	0.010	0.026	00:00:02
magnanimous.monitoring.internet-measurement.com	0.006	0.006	00:00:01
212.51.192.185	0.365	0.576	00:00:01
207.90.244.2	0.004	0.008	00:00:01
scanner-09.ch1.censys-scanner.com	0.000	0.007	00:00:00
45.227.254.8	0.003	0.003	00:00:00
77-254-43-177.dynamic.inetia.pl	0.000	0.010	00:00:00
isvcs01.man.lodz.pl	0.011	0.041	00:00:00
TOTAL: 12	6.222	11.203	00:00:52

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	1440
212.51.192.185	96
80.111.142.213	4
zl-ams-nl-gp1-wk129e.internet-census.org	1
45.227.254.8	1
magnanimous.monitoring.internet-measurement.com	1
scanner-09.ch1.censys-scanner.com	1
77-254-43-177.dynamic.inetia.pl	1
207.90.244.2	1
107.170.233.41	1
TOTAL: 10	1547

NNRP unrecognized commands (by host):

System	Conn
45.227.254.8	1
scanner-09.ch1.censys-scanner.com	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	1
#003	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
45.227.254.8	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	18
2	pl.comp.os.ms-windows.winnt	2
TOTAL: 2		20

Daily Usenet report

Oct 15 04:15:02 -- Oct 16 04:15:01