Daily Usenet report: Sep 18 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Sep 18 07:24:16 newsfeed nnrpd[8895]: SERVER perl filter not defined
Sep 18 07:26:21 newsfeed nnrpd[8947]: SERVER perl filter not defined
Sep 18 07:29:07 newsfeed nnrpd[8989]: SERVER perl filter not defined
Sep 18 08:30:10 newsfeed overchan[659]: input line too long, skipping
Sep 18 09:21:32 newsfeed overchan[659]: input line too long, skipping
Sep 18 12:07:53 newsfeed nnrpd[18323]: SERVER perl filter not defined
Sep 18 12:44:03 newsfeed overchan[659]: input line too long, skipping
Sep 18 13:49:42 newsfeed nnrpd[21652]: SERVER perl filter not defined
Sep 18 15:48:20 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:183 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 18 19:24:16 newsfeed overchan[659]: input line too long, skipping
Sep 18 22:11:34 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:183 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13434880 duplicate size 0 rejected size 0]
Sep 18 23:48:55 newsfeed overchan[659]: input line too long, skipping
Sep 19 00:19:01 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:183 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 19 01:03:03 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:183 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 19 02:50:23 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:183 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4674977	98.7%	515.0 MB	98.4%
innfeed	30347	0.6%	3.5 MB	0.7%
innd	26407	0.6%	4.5 MB	0.9%
nnrpd	4956	0.1%	531.2 KB	0.1%
overchan	6	0.0%	1.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	4736694	100.0%	523.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	4643930	99.5%
Negative hits	23028	0.5%
Positive hits	303	0.0%
Cache misses	41	0.0%
TOTAL: 4	4667302	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.939	0.0%	117	0.000	8.026	50.000
article cleanup	00:00:49.424	0.1%	4660210	0.008	0.011	0.015
article logging	00:02:35.466	0.2%	4660567	0.026	0.033	0.060
article parse	00:19:55.295	1.4%	52542576	0.013	0.023	0.029
article write	00:12:20.264	0.9%	4660030	0.121	0.159	0.629
artlog/artcncl	00:00:00.003	0.0%	117	0.000	0.026	1.000
data move	00:01:04.504	0.1%	66411286	0.000	0.001	0.001
hisgrep/artcncl	00:00:00.252	0.0%	113	0.000	2.230	28.500
hishave/artcncl	00:00:00.077	0.0%	117	0.000	0.658	12.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:30:49.888	2.1%	4683488	0.064	0.395	3.744
history sync	00:00:00.018	0.0%	297	0.000	0.061	0.667
history write	01:23:42.346	5.8%	4660182	0.249	1.078	10.683
hiswrite/artcncl	00:00:00.001	0.0%	4	0.000	0.250	1.000
idle	15:25:50.029	64.3%	41641164	0.755	1.334	17.654
nntp read	00:29:22.394	2.0%	48678695	0.030	0.036	0.051
overview write	00:00:19.411	0.0%	4660030	0.003	0.004	0.007
perl filter	05:05:31.311	21.2%	4660182	3.194	3.934	17.348
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:20.927	0.2%	9335122	0.018	0.022	0.029
TOTAL: 24:00:04.970	23:35:42.549	98.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.116	0.0%	43945	0.000	0.003	0.034
article prepare	00:00:00.000	0.0%	1244	0.000	0.000	0.000
article read	00:00:02.852	0.0%	311	0.000	9.170	354.400
backlog stats	00:00:00.091	0.0%	118837	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.047	0.0%	58249	0.000	0.018	0.037
data write	00:00:02.374	0.0%	43206	0.014	0.055	0.099
idle	23:54:22.428	100.0%	118837	454.579	724.206	1768.226
status file	00:00:11.653	0.0%	10911	0.000	1.068	10.250
TOTAL: 23:54:45.333	23:54:40.561	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:02:15.161	93.7%	3099	0.000	43.614	9628.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.239	0.2%	6828	0.000	0.035	0.842
readart	00:00:00.001	0.0%	26	0.000	0.038	0.500
TOTAL: 00:02:24.182	00:02:15.401	93.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
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	544	4672027	4671870	0	157	99%	224:44:18
2	news.icm.edu.pl	51	253	27	203	23	10%	17:28:54
3	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 3		601	4672285	4671902	203	180	99%	242:13:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	383.5 GB	974.8 KB	1.3 MB	383.5 GB	99%	86.1 KB
2	news.icm.edu.pl	915.6 KB	234.0 KB	1005.8 KB	2.1 MB	42%	43.1 KB
3	localhost	7.4 KB	0.0 KB	0.0 KB	7.4 KB	100%	1.5 KB
TOTAL: 3		383.5 GB	1.2 MB	2.3 MB	383.5 GB	99%	86.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 18 04:15:02 - 04:59:59	51735	1.1%	19.18	9.8 GB	2.5%	3790.41
Sep 18 05:00:00 - 05:59:59	47692	1.0%	13.25	16.1 GB	4.1%	4675.92
Sep 18 06:00:00 - 06:59:59	59667	1.3%	16.57	20.8 GB	5.4%	6046.33
Sep 18 07:00:00 - 07:59:59	100778	2.2%	27.99	18.2 GB	4.7%	5304.60
Sep 18 08:00:00 - 08:59:59	28140	0.6%	7.82	5.7 GB	1.5%	1667.35
Sep 18 09:00:00 - 09:59:59	24521	0.5%	6.81	4.0 GB	1.0%	1175.49
Sep 18 10:00:00 - 10:59:59	94587	2.0%	26.27	10.2 GB	2.6%	2970.14
Sep 18 11:00:00 - 11:59:59	143446	3.1%	39.85	13.0 GB	3.3%	3775.61
Sep 18 12:00:00 - 12:59:59	224373	4.8%	62.33	21.0 GB	5.4%	6116.40
Sep 18 13:00:00 - 13:59:59	260950	5.6%	72.49	20.9 GB	5.4%	6096.51
Sep 18 14:00:00 - 14:59:59	149763	3.2%	41.60	16.7 GB	4.3%	4850.52
Sep 18 15:00:00 - 15:59:59	193248	4.1%	53.68	13.2 GB	3.4%	3836.99
Sep 18 16:00:00 - 16:59:59	259343	5.5%	72.04	17.5 GB	4.5%	5108.57
Sep 18 17:00:00 - 17:59:59	300820	6.4%	83.56	22.1 GB	5.7%	6446.10
Sep 18 18:00:00 - 18:59:59	364222	7.8%	101.17	23.7 GB	6.1%	6888.56
Sep 18 19:00:00 - 19:59:59	323786	6.9%	89.94	22.1 GB	5.7%	6442.69
Sep 18 20:00:00 - 20:59:59	307387	6.6%	85.39	22.7 GB	5.8%	6597.85
Sep 18 21:00:00 - 21:59:59	267080	5.7%	74.19	16.8 GB	4.3%	4899.19
Sep 18 22:00:00 - 22:59:59	162358	3.5%	45.10	10.5 GB	2.7%	3069.02
Sep 18 23:00:00 - 23:59:59	160638	3.4%	44.62	10.3 GB	2.7%	3013.44
Sep 19 00:00:00 - 00:59:59	226569	4.8%	62.94	14.4 GB	3.7%	4197.39
Sep 19 01:00:00 - 01:59:59	334024	7.1%	92.78	21.1 GB	5.4%	6147.54
Sep 19 02:00:00 - 02:59:59	287020	6.1%	79.73	18.2 GB	4.7%	5308.44
Sep 19 03:00:00 - 03:59:59	233788	5.0%	64.94	14.5 GB	3.7%	4233.56
Sep 19 04:00:00 - 04:15:02	68388	1.5%	75.82	4.3 GB	1.1%	4958.85
TOTAL: 24:00:00	4674323	100.0%	54.10	387.8 GB	100.0%	4706.31

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	514	109	24	24	357
2	news.icm.edu.pl	23	0	4	0	19
TOTAL: 2		537	109	28	24	376

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.tlc.cellulari.android	38
uk.railway	31
nl.comp.os.linux.techniek	13
it.comp.os.win.windows10	13
comp.mobile.android	8
uk.rec.cycling.moderated	2
it.comp.os.linux.ubuntu	2
de.comp.lang.vbclassic	1
de.comp.lang.perl	1
TOTAL: 9	109

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

Groups	Count
pl.sci.matematyka	18
pl.praca.oferowana	6
TOTAL: 2	24

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12
Binary in non-binary group	2
Scoring filter (10)	2
Scoring filter (16)	1
Scoring filter (8)	1
Scoring filter (18)	1
TOTAL: 6	19

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	26296	251	14671	9	0	0%	23:59:57
2	panorama	31743	2	13641	29	30416	0%	23:59:57
3	nask	0	0	0	0	10016	0%	23:57:50
4	okapi	0	0	0	0	1029	0%	23:57:50
5	poznan	27	0	20	0	0	0%	02:49:34
TOTAL: 5		58066	253	28332	38	41461	0%	98:45:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	774.0 KB	90.4 KB	864.4 KB	3.3 KB	23:59:57
2	panorama	79.3 KB	101.8 KB	181.1 KB	5.8 KB	23:59:57
3	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:50
4	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:50
5	poznan	0.0 KB	0.0 KB	0.0 KB	0	02:49:34
TOTAL: 5		853.3 KB	192.2 KB	1.0 MB	3.6 KB	98:45:08

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	291	26	23.7 KB	12	0	00:00:16
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 2		296	26	23.7 KB	12	5	00:02:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	584	26	23.7 KB	12	5	00:00:19
2	*.dynamic.mm.pl	1	0	0.0 KB	0	0	00:00:23
3	*.toya.net.pl	12	0	0.0 KB	0	0	00:01:27
4	*.sfj.corp.censys.io	1	0	0.0 KB	0	0	00:00:00
5	unresolved	101	0	0.0 KB	0	0	00:00:12
TOTAL: 5		699	26	23.7 KB	12	5	00:02:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
staticline-31-183-129-240.toya.net.pl	0.048	0.200	00:01:27
host-89-229-237-32.dynamic.mm.pl	0.032	0.020	00:00:23
web.man.lodz.pl	1.400	5.472	00:00:16
159.203.201.194	0.008	0.012	00:00:09
mon.man.lodz.pl	1.200	4.740	00:00:03
80.111.142.213	0.028	0.068	00:00:02
212.51.192.185	0.396	1.504	00:00:00
isvcs01.man.lodz.pl	0.012	0.084	00:00:00
worker-18.sfj.corp.censys.io	0.004	0.012	00:00:00
TOTAL: 9	3.128	12.112	00:02:23

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	96
staticline-31-183-129-240.toya.net.pl	12
80.111.142.213	4
worker-18.sfj.corp.censys.io	1
host-89-229-237-32.dynamic.mm.pl	1
159.203.201.194	1
TOTAL: 7	403

NNRP client timeouts [Top 20]:

System	Conn	Peer
worker-18.sfj.corp.censys.io	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Sep 18 04:15:02 -- Sep 19 04:15:02