Daily Usenet report: Feb 22 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Feb 22 12:28:59 newsfeed nnrpd[14636]: SERVER perl filter not defined
Feb 22 15:30:52 newsfeed nnrpd[21013]: SERVER perl filter not defined
Feb 22 17:00:14 newsfeed nnrpd[24112]: SERVER perl filter not defined
Feb 22 18:20:02 newsfeed controlchan[2608]: Unknown "forwarded" control by robomod@news.nic.it
Feb 22 19:40:06 newsfeed nnrpd[29603]: SERVER perl filter not defined
Feb 22 22:32:57 newsfeed nnrpd[3111]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3185433	98.6%	368.7 MB	98.3%
innd	36910	1.1%	5.2 MB	1.4%
nnrpd	4820	0.1%	496.7 KB	0.1%
innfeed	4672	0.1%	657.2 KB	0.2%
controlchan	2	0.0%	0.2 KB	0.0%
TOTAL: 5	3231837	100.0%	375.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3177157	96.6%
Negative hits	96144	2.9%
Positive hits	14316	0.4%
Cache misses	124	0.0%
TOTAL: 4	3287741	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.547	0.0%	224	0.000	11.371	915.000
article cleanup	00:00:47.572	0.1%	3182807	0.006	0.015	0.023
article logging	00:01:53.408	0.1%	3183707	0.017	0.036	1.495
article parse	01:29:32.315	6.2%	194755503	0.015	0.028	0.081
article write	00:37:09.196	2.6%	3165924	0.343	0.704	2.112
artlog/artcncl	00:00:00.004	0.0%	206	0.000	0.019	1.000
artlog/artparse	00:00:00.002	0.0%	42	0.000	0.048	1.000
data move	00:03:37.152	0.3%	214413027	0.001	0.001	0.007
hisgrep/artcncl	00:00:00.119	0.0%	210	0.000	0.567	20.000
hishave/artcncl	00:00:00.042	0.0%	224	0.000	0.188	20.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:33:50.101	2.4%	3289044	0.103	0.617	7.874
history sync	00:00:00.025	0.0%	290	0.000	0.086	3.000
history write	00:50:01.006	3.5%	3178452	0.242	0.944	9.835
hiswrite/artcncl	00:00:00.023	0.0%	14	0.000	1.643	10.000
idle	11:20:09.550	47.3%	122579214	0.152	0.333	10.895
nntp read	01:19:36.514	5.5%	192226050	0.013	0.025	0.039
overview write	00:00:19.145	0.0%	3165924	0.002	0.006	0.012
perl filter	07:01:20.881	29.3%	3178410	5.093	7.954	10.238
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:37.930	0.4%	6369879	0.036	0.053	0.080
TOTAL: 23:58:22.846	23:23:57.532	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.172	0.0%	38503	0.000	0.004	0.133
article prepare	00:00:00.018	0.0%	40898	0.000	0.000	0.083
article read	00:00:05.466	0.0%	10151	0.000	0.538	64.667
backlog stats	00:00:00.204	0.0%	197575	0.000	0.001	0.024
callbacks	00:00:00.001	0.0%	2	0.000	0.500	1.000
data read	00:00:01.849	0.0%	114671	0.000	0.016	0.083
data write	00:00:06.426	0.0%	80179	0.000	0.080	0.462
idle	23:58:34.216	100.0%	197575	113.372	436.868	1886.562
status file	00:00:01.300	0.0%	1550	0.000	0.839	4.500
TOTAL: 23:58:55.764	23:58:49.652	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:28.170	52.4%	3107	0.000	9.067	747.688
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.170	0.3%	6998	0.000	0.024	0.500
readart	00:00:13.050	24.3%	10415	0.000	1.253	1.262
TOTAL: 00:00:53.809	00:00:41.390	76.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	189

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1382	3166397	3155106	5656	5635	99%	422:21:46
2	news.nask.pl	3	25635	10712	3821	11102	41%	23:42:39
3	news.icm.edu.pl	42	292	25	259	8	8%	16:39:02
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		1433	3192329	3165848	9736	16745	99%	462:43:27

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	983.6 GB	72.9 MB	320.9 MB	984.0 GB	99%	326.4 KB
2	news.nask.pl	57.8 MB	1.2 MB	170.6 MB	229.6 MB	25%	10.8 KB
3	news.icm.edu.pl	627.2 KB	0.0 KB	97.2 KB	724.4 KB	86%	22.0 KB
4	localhost	7.1 KB	0.0 KB	0.0 KB	7.1 KB	100%	1.4 KB
TOTAL: 4		983.7 GB	74.1 MB	491.7 MB	984.2 GB	99%	324.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 22 04:15:02 - 04:59:59	89553	2.8%	33.19	31.2 GB	3.2%	12112.96
Feb 22 05:00:00 - 05:59:59	100803	3.2%	28.00	38.5 GB	3.9%	11223.33
Feb 22 06:00:00 - 06:59:59	122287	3.9%	33.97	42.2 GB	4.3%	12292.59
Feb 22 07:00:00 - 07:59:59	127843	4.0%	35.51	42.4 GB	4.3%	12351.00
Feb 22 08:00:00 - 08:59:59	126399	4.0%	35.11	41.8 GB	4.3%	12162.78
Feb 22 09:00:00 - 09:59:59	135268	4.3%	37.57	43.5 GB	4.4%	12677.18
Feb 22 10:00:00 - 10:59:59	133882	4.2%	37.19	42.2 GB	4.3%	12298.68
Feb 22 11:00:00 - 11:59:59	132910	4.2%	36.92	41.9 GB	4.3%	12207.71
Feb 22 12:00:00 - 12:59:59	132531	4.2%	36.81	41.9 GB	4.3%	12216.12
Feb 22 13:00:00 - 13:59:59	133534	4.2%	37.09	42.5 GB	4.3%	12383.50
Feb 22 14:00:00 - 14:59:59	130755	4.1%	36.32	41.9 GB	4.3%	12216.68
Feb 22 15:00:00 - 15:59:59	134445	4.2%	37.35	42.1 GB	4.3%	12268.42
Feb 22 16:00:00 - 16:59:59	137878	4.4%	38.30	42.0 GB	4.3%	12230.58
Feb 22 17:00:00 - 17:59:59	136120	4.3%	37.81	41.3 GB	4.2%	12028.01
Feb 22 18:00:00 - 18:59:59	138654	4.4%	38.52	43.0 GB	4.4%	12523.68
Feb 22 19:00:00 - 19:59:59	141030	4.5%	39.17	42.8 GB	4.4%	12454.51
Feb 22 20:00:00 - 20:59:59	148639	4.7%	41.29	43.2 GB	4.4%	12578.66
Feb 22 21:00:00 - 21:59:59	154701	4.9%	42.97	42.3 GB	4.3%	12313.86
Feb 22 22:00:00 - 22:59:59	149427	4.7%	41.51	43.4 GB	4.4%	12653.20
Feb 22 23:00:00 - 23:59:59	147559	4.7%	40.99	43.2 GB	4.4%	12581.22
Feb 23 00:00:00 - 00:59:59	115686	3.7%	32.13	33.4 GB	3.4%	9724.89
Feb 23 01:00:00 - 01:59:59	128838	4.1%	35.79	37.2 GB	3.8%	10839.93
Feb 23 02:00:00 - 02:59:59	121252	3.8%	33.68	35.0 GB	3.6%	10207.07
Feb 23 03:00:00 - 03:59:59	115005	3.6%	31.95	33.5 GB	3.4%	9770.86
Feb 23 04:00:00 - 04:15:01	32394	1.0%	35.95	9.4 GB	1.0%	10903.21
TOTAL: 23:59:59	3167393	100.0%	36.66	981.9 GB	100.0%	11917.28

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	11510	67	323	9	11111
2	newsfeed.pionier.net.pl	6312	171	4074	2	2065
3	news.icm.edu.pl	12	0	0	0	12
TOTAL: 3		17834	238	4397	11	13188

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	77
comp.mobile.android	72
it.tlc.cellulari.android	35
it.comp.os.win.windows10	32
comp.mobile.ipad	12
uk.rec.cycling.moderated	6
comp.sys.raspberry-pi	3
de.rec.sf.startrek	1
TOTAL: 8	238

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

Groups	Count
pl.sci.matematyka	6
pl.praca.oferowana	4
bit.listserv.catholic	1
TOTAL: 3	11

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10144
Binary in non-binary group	1749
Scoring filter (8)	123
Scoring filter (10)	96
Scoring filter (9)	58
EMP (phl)	31
Poison newsgroup	17
Scoring filter (12)	6
HTML post	6
Scoring filter (19)	4
Scoring filter (17)	4
Scoring filter (11)	3
Scoring filter (15)	2
Too many newsgroups	2
Scoring filter (18)	1
TOTAL: 15	12246

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	17910	1928	12741	787	13	23017	10%	24:00:03
2	poznan	16631	244	10498	26	0	0	1%	23:56:54
3	nask	7779	105	5229	2	0	0	1%	23:59:36
4	icm	36099	56	23841	6859	0	0	0%	24:00:37
5	okapi	0	0	0	0	0	1800	0%	23:40:02
TOTAL: 5		78419	2333	52309	7674	13	24817	2%	119:37:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	6.3 MB	3.1 MB	9.4 MB	0.1 KB/s	3.6 KB	24:00:03
2	poznan	1.5 MB	292.6 KB	1.8 MB	0.0 KB/s	6.8 KB	23:56:54
3	nask	283.5 KB	4.9 KB	288.3 KB	0.0 KB/s	2.7 KB	23:59:36
4	icm	220.5 KB	1.3 GB	1.3 GB	15.5 KB/s	193.1 KB	24:00:37
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:40:02
TOTAL: 5		8.3 MB	1.3 GB	1.3 GB	3.1 KB/s	134.6 KB	119:37:12

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	288	78	80.5 KB	32	0	00:00:22
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 2		293	78	80.5 KB	32	5	00:00:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	677	78	80.5 KB	32	5	00:00:27
2	*.dyn.optonline.net	1	0	0.0 KB	0	0	00:00:25
TOTAL: 2		678	78	80.5 KB	32	5	00:00:53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ool-ae2c99f9.dyn.optonline.net	0.305	0.816	00:00:25
web.man.lodz.pl	1.151	4.411	00:00:22
mon.man.lodz.pl	0.913	3.766	00:00:04
david.man.lodz.pl	0.324	1.270	00:00:01
isvcs01.man.lodz.pl	0.047	0.079	00:00:00
TOTAL: 5	2.740	10.342	00:00:53

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
ool-ae2c99f9.dyn.optonline.net	1
TOTAL: 3	385

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	44
2	pl.comp.os.ms-windows.winnt	34
TOTAL: 2		78

Daily Usenet report

Feb 22 04:15:02 -- Feb 23 04:15:01