Daily Usenet report: Aug 19 04:15:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Aug 19 08:44:12 newsfeed nnrpd[21065]: SERVER perl filter not defined
Aug 19 08:51:53 newsfeed nnrpd[21378]: SERVER perl filter not defined
Aug 19 10:43:59 newsfeed nnrpd[25298]: SERVER perl filter not defined
Aug 19 10:44:14 newsfeed nnrpd[25299]: SERVER perl filter not defined
Aug 19 13:32:32 newsfeed nnrpd[31154]: SERVER perl filter not defined
Aug 19 13:32:45 newsfeed nnrpd[31155]: SERVER perl filter not defined
Aug 19 15:01:00 newsfeed nnrpd[1787]: SERVER perl filter not defined
Aug 19 15:01:12 newsfeed nnrpd[1793]: SERVER perl filter not defined
Aug 19 18:13:35 newsfeed nnrpd[8444]: SERVER perl filter not defined
Aug 19 18:14:03 newsfeed nnrpd[8445]: SERVER perl filter not defined
Aug 19 20:50:37 newsfeed nnrpd[13906]: SERVER perl filter not defined
Aug 19 20:50:55 newsfeed nnrpd[13910]: SERVER perl filter not defined
Aug 19 23:35:20 newsfeed nnrpd[19513]: SERVER perl filter not defined
Aug 20 00:40:53 newsfeed nnrpd[21833]: SERVER perl filter not defined
Aug 20 01:14:17 newsfeed nnrpd[22908]: SERVER perl filter not defined
Aug 20 02:00:16 newsfeed nnrpd[24449]: SERVER perl filter not defined
Aug 20 02:00:36 newsfeed nnrpd[24456]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2719562	98.6%	314.3 MB	98.3%
innd	28862	1.0%	4.3 MB	1.3%
nnrpd	4938	0.2%	513.3 KB	0.2%
innfeed	4852	0.2%	671.0 KB	0.2%
TOTAL: 4	2758214	100.0%	319.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2714300	96.3%
Negative hits	88481	3.1%
Positive hits	14651	0.5%
Cache misses	113	0.0%
TOTAL: 4	2817545	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.504	0.0%	185	0.000	8.130	642.000
article cleanup	00:00:40.213	0.0%	2719222	0.006	0.015	0.040
article logging	00:01:15.777	0.1%	2719758	0.015	0.028	0.523
article parse	01:16:36.344	5.3%	245365887	0.009	0.019	0.061
article write	00:23:20.681	1.6%	2707133	0.299	0.517	2.486
artlog/artcncl	00:00:00.004	0.0%	184	0.000	0.022	1.000
data move	00:02:45.256	0.2%	263313153	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.549	0.0%	155	0.000	3.542	386.000
hishave/artcncl	00:00:00.069	0.0%	185	0.000	0.373	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:21:09.171	1.5%	2818629	0.056	0.450	7.732
history sync	00:00:00.013	0.0%	293	0.000	0.044	1.000
history write	00:31:36.965	2.2%	2715454	0.139	0.699	9.242
hiswrite/artcncl	00:00:00.048	0.0%	30	0.000	1.600	21.000
idle	13:50:30.072	57.7%	179897488	0.186	0.277	2.822
nntp read	01:11:15.960	4.9%	243233399	0.010	0.018	0.040
overview write	00:00:14.392	0.0%	2707133	0.000	0.005	0.012
perl filter	05:33:48.381	23.2%	2715454	5.173	7.376	10.653
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:27.953	0.3%	5447564	0.033	0.049	0.094
TOTAL: 24:00:13.072	23:17:43.352	97.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.137	0.0%	39827	0.000	0.003	0.250
article prepare	00:00:00.014	0.0%	41512	0.000	0.000	0.026
article read	00:00:14.502	0.0%	10390	0.000	1.396	339.000
backlog stats	00:00:00.180	0.0%	195673	0.000	0.001	0.047
callbacks	00:00:00.000	0.0%	18	0.000	0.000	0.000
data read	00:00:01.236	0.0%	102374	0.000	0.012	0.143
data write	00:00:07.226	0.0%	92756	0.000	0.078	0.233
idle	23:58:49.063	100.0%	195673	21.013	441.190	5279.846
status file	00:00:00.654	0.0%	885	0.000	0.739	4.000
TOTAL: 23:59:17.893	23:59:13.012	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:15:05.898	99.7%	10040	0.000	448.795	144560.615
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.653	0.1%	20697	0.000	0.128	77.828
readart	00:00:00.680	0.0%	70	0.000	9.714	24.875
TOTAL: 01:15:20.853	01:15:09.231	99.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1004	2707306	2695952	7429	3925	99%	275:02:50
2	news.nask.pl	2	22148	10923	3156	8069	49%	23:52:37
3	localhost	18	17	17	0	0	100%	00:00:00
4	news.icm.edu.pl	45	314	13	258	43	4%	17:06:39
TOTAL: 4		1069	2729785	2706905	10843	12037	99%	316:02:06

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	880.9 GB	39.0 MB	74.9 MB	881.1 GB	99%	342.2 KB
2	news.nask.pl	56.5 MB	2.9 MB	88.1 MB	147.6 MB	38%	8.0 KB
3	news.icm.edu.pl	290.9 KB	0.0 KB	457.5 KB	748.5 KB	38%	13.4 KB
4	localhost	34.2 KB	0.0 KB	0.0 KB	34.2 KB	100%	2.0 KB
TOTAL: 4		881.0 GB	41.9 MB	163.5 MB	881.2 GB	99%	339.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 19 04:15:02 - 04:59:59	76142	2.8%	28.22	29.2 GB	3.3%	11339.28
Aug 19 05:00:00 - 05:59:59	101182	3.7%	28.11	37.2 GB	4.2%	10836.54
Aug 19 06:00:00 - 06:59:59	96982	3.6%	26.94	36.4 GB	4.1%	10595.63
Aug 19 07:00:00 - 07:59:59	105690	3.9%	29.36	36.8 GB	4.2%	10711.49
Aug 19 08:00:00 - 08:59:59	112059	4.1%	31.13	38.7 GB	4.4%	11266.16
Aug 19 09:00:00 - 09:59:59	128189	4.7%	35.61	38.9 GB	4.4%	11344.25
Aug 19 10:00:00 - 10:59:59	89012	3.3%	24.73	32.1 GB	3.7%	9359.88
Aug 19 11:00:00 - 11:59:59	98234	3.6%	27.29	35.3 GB	4.0%	10284.99
Aug 19 12:00:00 - 12:59:59	113035	4.2%	31.40	37.9 GB	4.3%	11047.43
Aug 19 13:00:00 - 13:59:59	110861	4.1%	30.79	36.4 GB	4.1%	10595.97
Aug 19 14:00:00 - 14:59:59	109535	4.0%	30.43	38.2 GB	4.3%	11133.03
Aug 19 15:00:00 - 15:59:59	126258	4.7%	35.07	39.4 GB	4.5%	11470.78
Aug 19 16:00:00 - 16:59:59	114753	4.2%	31.88	39.3 GB	4.5%	11457.18
Aug 19 17:00:00 - 17:59:59	114457	4.2%	31.79	38.5 GB	4.4%	11221.49
Aug 19 18:00:00 - 18:59:59	117579	4.3%	32.66	39.1 GB	4.4%	11377.22
Aug 19 19:00:00 - 19:59:59	108996	4.0%	30.28	37.8 GB	4.3%	10996.19
Aug 19 20:00:00 - 20:59:59	118698	4.4%	32.97	38.7 GB	4.4%	11273.16
Aug 19 21:00:00 - 21:59:59	145846	5.4%	40.51	39.6 GB	4.5%	11525.41
Aug 19 22:00:00 - 22:59:59	121344	4.5%	33.71	36.3 GB	4.1%	10577.74
Aug 19 23:00:00 - 23:59:59	122160	4.5%	33.93	37.9 GB	4.3%	11033.26
Aug 20 00:00:00 - 00:59:59	99463	3.7%	27.63	29.6 GB	3.4%	8613.52
Aug 20 01:00:00 - 01:59:59	133717	4.9%	37.14	38.2 GB	4.3%	11115.19
Aug 20 02:00:00 - 02:59:59	97731	3.6%	27.15	28.6 GB	3.2%	8318.26
Aug 20 03:00:00 - 03:59:59	117170	4.3%	32.55	32.0 GB	3.6%	9310.46
Aug 20 04:00:00 - 04:15:02	27674	1.0%	30.68	7.7 GB	0.9%	8978.93
TOTAL: 24:00:00	2706767	100.0%	31.33	879.6 GB	100.0%	10675.55

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	8344	61	465	4	7814
2	newsfeed.pionier.net.pl	4224	373	3299	0	552
3	news.icm.edu.pl	43	0	0	0	43
TOTAL: 3		12611	434	3764	4	8409

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	189
it.tlc.cellulari.android	90
it.comp.os.win.windows10	64
comp.mobile.ipad	34
comp.mobile.android	34
it.comp.os.linux.ubuntu	5
uk.net.providers.gradwell	4
it.discussioni.energia	3
alt.sex.telephones	2
hr.ponuda.hardver.komponente	2
de.comp.lang.vbclassic	2
it.comp.os.win.windows7	2
rec.arts.tv.x-factor	1
uk.rec.cycling.moderated	1
comp.sys.raspberry-pi	1
TOTAL: 15	434

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

Groups	Count
pl.sci.historia	3
bit.listserv.catholic	1
TOTAL: 2	4

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	7202
Binary in non-binary group	384
EMP (phl)	114
Scoring filter (8)	49
Scoring filter (9)	29
Scoring filter (10)	27
Scoring filter (12)	16
Scoring filter (11)	14
Scoring filter (13)	13
Scoring filter (16)	9
Scoring filter (14)	3
HTML post	2
Scoring filter (17)	2
Scoring filter (23)	2
Scoring filter (15)	2
Scoring filter (18)	2
Scoring filter (22)	1
Angle-bracket bot	1
TOTAL: 18	7872

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	7885	952	5067	451	34	33353	12%	24:02:05
2	poznan	16222	199	10663	21	0	0	1%	23:58:54
3	icm	36970	148	22581	8442	0	0	0%	23:56:08
4	nask	6113	13	4344	1	0	0	0%	23:59:30
5	okapi	0	0	0	0	0	2308	0%	24:00:03
TOTAL: 5		67190	1312	42655	8915	34	35661	1%	119:56:40

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	5.9 MB	2.0 MB	7.8 MB	0.1 KB/s	5.7 KB	24:02:05
2	icm	4.7 MB	2.0 GB	2.1 GB	24.9 KB/s	250.3 KB	23:56:08
3	poznan	692.9 KB	59.1 KB	752.0 KB	0.0 KB/s	3.4 KB	23:58:54
4	nask	55.4 KB	2.6 KB	58.0 KB	0.0 KB/s	4.1 KB	23:59:30
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		11.3 MB	2.0 GB	2.1 GB	5.0 KB/s	211.1 KB	119:56:40

Backlog files shrunk by innfeed:

Server	Size
panorama	2.4 MB
TOTAL: 1	2.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	36	31.3 KB	18	0	00:00:19
2	lze200.lze.lodz.pl	2	24	38.4 KB	5	0	00:13:45
3	pc-mstarzak.cm.p.lodz.pl	2	9	14.6 KB	1	0	00:31:29
4	178-37-6-3.adsl.inetia.pl	2	1	1.5 KB	1	0	00:00:33
5	isvcs01.man.lodz.pl	17	0	0.0 KB	0	17	00:00:00
TOTAL: 5		311	70	85.7 KB	25	17	01:15:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	688	36	31.3 KB	18	17	00:00:24
2	*.lze.lodz.pl	2	24	38.4 KB	5	0	00:13:45
3	*.cm.p.lodz.pl	2	9	14.6 KB	1	0	00:31:29
4	*.adsl.inetia.pl	2	1	1.5 KB	1	0	00:00:33
5	unresolved	2	0	0.0 KB	0	0	00:29:07
TOTAL: 5		696	70	85.7 KB	25	17	01:15:20

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-mstarzak.cm.p.lodz.pl	0.004	0.033	00:31:29
185.48.194.66	0.382	0.479	00:29:07
lze200.lze.lodz.pl	0.016	0.044	00:13:45
178-37-6-3.adsl.inetia.pl	0.073	0.038	00:00:33
web.man.lodz.pl	0.847	4.302	00:00:19
mon.man.lodz.pl	0.877	3.595	00:00:03
david.man.lodz.pl	0.221	1.170	00:00:01
isvcs01.man.lodz.pl	0.076	0.252	00:00:00
TOTAL: 8	2.496	9.913	01:15:20

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	95
185.48.194.66	2
TOTAL: 3	385

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-mstarzak.cm.p.lodz.pl	1	0
185.48.194.66	1	1
TOTAL: 2	2	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	60	85.7%
2	lodman	10	14.3%
TOTAL: 2		70	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	32
2	pl.comp.pecet	18
3	lodman.info	10
4	pl.misc.telefonia.gsm	4
5	pl.comp.os.linux	4
6	pl.rec.dom	2
TOTAL: 6		70

Daily Usenet report

Aug 19 04:15:02 -- Aug 20 04:15:02