Daily Usenet report: Dec 8 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Dec 8 09:30:49 newsfeed nnrpd[1048027]: SERVER perl filter not defined
Dec 8 09:47:14 newsfeed nnrpd[1048765]: SERVER perl filter not defined
Dec 8 09:47:26 newsfeed nnrpd[1048766]: SERVER perl filter not defined
Dec 8 09:51:08 newsfeed nnrpd[1048899]: SERVER perl filter not defined
Dec 8 09:55:36 newsfeed nnrpd[1049183]: SERVER perl filter not defined
Dec 8 10:23:40 newsfeed nnrpd[1050273]: SERVER perl filter not defined
Dec 8 17:30:52 newsfeed overchan[1030505]: input line too long, skipping
Dec 8 17:31:16 newsfeed overchan[1030505]: input line too long, skipping
Dec 8 20:43:17 newsfeed overchan[1030505]: input line too long, skipping
Dec 8 20:44:31 newsfeed overchan[1030505]: input line too long, skipping
Dec 8 21:40:23 newsfeed overchan[1030505]: input line too long, skipping
Dec 8 23:31:42 newsfeed overchan[1030505]: input line too long, skipping
Dec 9 00:09:13 newsfeed overchan[1030505]: input line too long, skipping
Dec 9 00:25:30 newsfeed overchan[1030505]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	229872	91.2%	26.7 MB	91.1%
innd	13084	5.2%	1.7 MB	5.7%
nnrpd	7658	3.0%	790.6 KB	2.6%
innfeed	1409	0.6%	150.4 KB	0.5%
overchan	8	0.0%	1.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	252032	100.0%	29.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	227561	90.7%
Negative hits	13144	5.2%
Positive hits	10220	4.1%
Cache misses	105	0.0%
TOTAL: 4	251030	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.760	0.0%	413	0.000	4.262	22.727
article cleanup	00:00:01.593	0.0%	228444	0.002	0.007	0.012
article logging	00:00:05.369	0.0%	228461	0.014	0.024	0.048
article parse	00:00:08.721	0.0%	766375	0.005	0.011	0.019
article write	00:00:49.862	0.1%	214206	0.118	0.233	3.061
artlog/artcncl	00:00:00.010	0.0%	412	0.000	0.024	1.000
data move	00:00:01.306	0.0%	1133828	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.427	0.0%	413	0.000	1.034	6.409
hishave/artcncl	00:00:00.257	0.0%	413	0.000	0.622	13.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:10:22.111	0.7%	250988	0.670	2.479	6.636
history sync	00:00:00.018	0.0%	298	0.000	0.060	1.000
history write	00:16:36.338	1.2%	227895	1.897	4.372	8.065
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:16:40.084	97.6%	976377	21.561	85.828	180.788
nntp read	00:00:17.804	0.0%	780497	0.013	0.023	0.031
overview write	00:00:00.720	0.0%	214206	0.000	0.003	0.009
perl filter	00:04:21.888	0.3%	227895	0.728	1.149	1.491
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:07.810	0.0%	471401	0.010	0.017	0.024
TOTAL: 23:50:24.211	23:49:36.078	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.092	0.0%	43041	0.000	0.002	0.012
article prepare	00:00:00.000	0.0%	488	0.000	0.000	0.000
article read	00:00:00.004	0.0%	122	0.000	0.033	1.000
backlog stats	00:00:00.078	0.0%	186943	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.008	0.0%	104409	0.000	0.010	0.020
data write	00:00:02.656	0.0%	61313	0.014	0.043	0.089
idle	23:53:04.977	100.0%	186943	298.238	459.953	804.764
status file	00:00:00.180	0.0%	336	0.000	0.536	2.000
TOTAL: 23:53:11.420	23:53:08.995	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:10.300	38.2%	4202	0.000	2.451	1872.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.180	0.7%	10113	0.000	0.018	0.500
TOTAL: 00:00:26.998	00:00:10.480	38.8%	-	-	-	-

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	63	217680	214454	24	3202	98%	43:22:11
2	news.icm.edu.pl	2	21033	508	9414	11111	2%	23:59:33
3	localhost	7	6	6	0	0	100%	00:00:00
TOTAL: 3		72	238719	214968	9438	14313	90%	67:21:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	2.2 GB	9.4 MB	40.5 MB	2.2 GB	97%	10.8 KB
2	news.icm.edu.pl	10.9 MB	773.5 KB	175.6 MB	187.3 MB	5%	16.5 KB
3	localhost	8.8 KB	0.0 KB	0.0 KB	8.8 KB	100%	1.5 KB
TOTAL: 3		2.2 GB	10.1 MB	216.1 MB	2.4 GB	90%	11.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 8 04:15:02 - 04:59:59	5616	2.6%	2.08	60.4 MB	2.7%	22.94
Dec 8 05:00:00 - 05:59:59	9826	4.6%	2.73	118.9 MB	5.3%	33.81
Dec 8 06:00:00 - 06:59:59	9127	4.2%	2.54	122.5 MB	5.4%	34.85
Dec 8 07:00:00 - 07:59:59	7676	3.6%	2.13	83.8 MB	3.7%	23.84
Dec 8 08:00:00 - 08:59:59	8159	3.8%	2.27	84.2 MB	3.7%	23.95
Dec 8 09:00:00 - 09:59:59	10006	4.7%	2.78	105.2 MB	4.7%	29.93
Dec 8 10:00:00 - 10:59:59	11275	5.2%	3.13	122.9 MB	5.4%	34.97
Dec 8 11:00:00 - 11:59:59	10392	4.8%	2.89	101.2 MB	4.5%	28.78
Dec 8 12:00:00 - 12:59:59	9818	4.6%	2.73	100.1 MB	4.4%	28.49
Dec 8 13:00:00 - 13:59:59	9987	4.6%	2.77	140.9 MB	6.2%	40.07
Dec 8 14:00:00 - 14:59:59	8162	3.8%	2.27	64.4 MB	2.9%	18.32
Dec 8 15:00:00 - 15:59:59	7803	3.6%	2.17	64.6 MB	2.9%	18.38
Dec 8 16:00:00 - 16:59:59	9692	4.5%	2.69	159.2 MB	7.1%	45.28
Dec 8 17:00:00 - 17:59:59	8746	4.1%	2.43	66.9 MB	3.0%	19.03
Dec 8 18:00:00 - 18:59:59	9340	4.3%	2.59	85.0 MB	3.8%	24.17
Dec 8 19:00:00 - 19:59:59	8027	3.7%	2.23	68.1 MB	3.0%	19.37
Dec 8 20:00:00 - 20:59:59	8752	4.1%	2.43	80.1 MB	3.5%	22.79
Dec 8 21:00:00 - 21:59:59	8321	3.9%	2.31	71.1 MB	3.1%	20.22
Dec 8 22:00:00 - 22:59:59	9681	4.5%	2.69	86.9 MB	3.8%	24.72
Dec 8 23:00:00 - 23:59:59	9282	4.3%	2.58	97.8 MB	4.3%	27.83
Dec 9 00:00:00 - 00:59:59	8401	3.9%	2.33	90.6 MB	4.0%	25.77
Dec 9 01:00:00 - 01:59:59	11412	5.3%	3.17	136.5 MB	6.0%	38.83
Dec 9 02:00:00 - 02:59:59	6835	3.2%	1.90	55.6 MB	2.5%	15.82
Dec 9 03:00:00 - 03:59:59	7240	3.4%	2.01	75.4 MB	3.3%	21.46
Dec 9 04:00:00 - 04:15:02	1558	0.7%	1.73	14.8 MB	0.7%	16.83
TOTAL: 24:00:00	215134	100.0%	2.49	2.2 GB	100.0%	26.75

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.icm.edu.pl	11099	16	58	11025
2	newsfeed.pionier.net.pl	3227	2712	495	20
TOTAL: 2		14326	2728	553	11045

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.android	2493
comp.sys.raspberry-pi	60
uk.railway	57
hr.sci.med	25
alt.binaries.erotica.divx	24
eternal-september.support	17
alt.comp.software.firefox	9
fr.comp.os.android	7
it.comp.os.win.windows10	7
it.tlc.cellulari.android	5
fr.misc.actualite.covid19	5
uw.cs.cs349	4
comp.infosystems.gemini	2
rocksolid.nodes.help	2
alt.comp.software.seamonkey	2
fido7.ru.microchip	1
aioe.news.helpdesk	1
fido7.r50.crisis	1
grisbi.test	1
xs4all.voip	1
TOTAL: 24	2728

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	9658
Scoring filter (9)	1147
Scoring filter (8)	90
Scoring filter (10)	52
Scoring filter (11)	50
EMP (md5)	19
Scoring filter (12)	12
TOTAL: 7	11028

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	61014	103	42232	19	0	0%	23:58:36
2	okapi	0	0	0	0	753	0%	23:57:48
3	nask	0	0	0	0	36804	0%	23:57:48
4	poznan	674	0	500	0	0	0%	23:52:27
5	panorama	0	0	0	0	43157	0%	23:57:48
TOTAL: 5		61688	103	42732	19	80714	0%	119:44:27

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	567.8 KB	179.9 KB	747.7 KB	6.1 KB	23:58:36
2	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
3	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
4	poznan	0.0 KB	0.0 KB	0.0 KB	0	23:52:27
5	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
TOTAL: 5		567.8 KB	179.9 KB	747.7 KB	6.1 KB	119:44:27

Backlog files shrunk by innfeed:

Server	Size
panorama	3.8 MB
TOTAL: 1	3.8 MB

NNRP readership statistics:

System		Conn	Post	Elapsed
1	192.241.196.95	1	0	00:00:00
2	reliable.monitoring.internet-measurement.com	1	0	00:00:01
3	212.51.192.185	96	0	00:00:01
4	80.111.142.213	4	0	00:00:02
5	198.199.98.85	1	0	00:00:00
6	nms2.man.lodz.pl	1441	0	00:00:13
7	web.man.lodz.pl	288	0	00:00:07
8	isvcs01.man.lodz.pl	6	6	00:00:00
TOTAL: 8		1838	6	00:00:27

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	*.man.lodz.pl	1735	6	00:00:21
2	*.monitoring.internet-measurement.com	1	0	00:00:01
3	unresolved	102	0	00:00:03
TOTAL: 3		1838	6	00:00:27

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms2.man.lodz.pl	5.277	8.367	00:00:13
web.man.lodz.pl	0.989	1.641	00:00:07
80.111.142.213	0.019	0.040	00:00:02
reliable.monitoring.internet-measurement.com	0.005	0.009	00:00:01
212.51.192.185	0.367	0.563	00:00:01
198.199.98.85	0.004	0.008	00:00:00
192.241.196.95	0.007	0.007	00:00:00
isvcs01.man.lodz.pl	0.024	0.052	00:00:00
TOTAL: 8	6.692	10.687	00:00:27

NNRP unrecognized commands (by host):

System	Conn
198.199.98.85	1
192.241.196.95	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_212.191.2.21_119	2
TOTAL: 1	2

Daily Usenet report

Dec 8 04:15:02 -- Dec 9 04:15:02