Daily Usenet report: Nov 18 04:15:03

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 18 07:14:36 newsfeed nnrpd[14731]: SERVER perl filter not defined
Nov 18 08:51:32 newsfeed nnrpd[17958]: SERVER perl filter not defined
Nov 18 10:29:27 newsfeed nnrpd[21359]: SERVER perl filter not defined
Nov 18 10:33:27 newsfeed nnrpd[21435]: SERVER perl filter not defined
Nov 18 11:40:14 newsfeed nnrpd[23810]: SERVER perl filter not defined
Nov 18 12:47:56 newsfeed nnrpd[26238]: SERVER perl filter not defined
Nov 18 13:27:28 newsfeed nnrpd[27628]: SERVER perl filter not defined
Nov 18 23:17:21 newsfeed nnrpd[15613]: SERVER perl filter not defined
Nov 19 00:08:25 newsfeed nnrpd[17363]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2167785	98.4%	252.4 MB	98.1%
innd	26439	1.2%	3.8 MB	1.5%
nnrpd	4879	0.2%	494.2 KB	0.2%
innfeed	4835	0.2%	670.8 KB	0.3%
TOTAL: 4	2203938	100.0%	257.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2162412	95.7%
Negative hits	83434	3.7%
Positive hits	13494	0.6%
Cache misses	122	0.0%
TOTAL: 4	2259462	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.368	0.0%	219	0.000	6.247	240.000
article cleanup	00:00:35.863	0.0%	2166306	0.005	0.017	0.029
article logging	00:01:10.308	0.1%	2166892	0.017	0.032	0.543
article parse	01:09:49.377	4.9%	151155541	0.013	0.028	0.067
article write	00:21:58.946	1.5%	2153364	0.388	0.613	3.319
artlog/artcncl	00:00:00.005	0.0%	218	0.000	0.023	1.000
data move	00:04:12.149	0.3%	164943665	0.000	0.002	0.004
hisgrep/artcncl	00:00:00.191	0.0%	201	0.000	0.950	36.000
hishave/artcncl	00:00:00.054	0.0%	219	0.000	0.247	1.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:24:05.138	1.7%	2260151	0.128	0.639	9.518
history sync	00:00:00.020	0.0%	290	0.000	0.069	1.000
history write	00:36:41.180	2.5%	2163207	0.209	1.018	10.834
hiswrite/artcncl	00:00:00.029	0.0%	18	0.000	1.611	13.000
idle	14:36:49.400	60.9%	95533409	0.344	0.551	1.075
nntp read	01:11:03.899	4.9%	149343909	0.013	0.029	0.047
overview write	00:00:14.048	0.0%	2153364	0.001	0.007	0.016
perl filter	05:02:14.280	21.0%	2163207	6.353	8.383	11.120
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:58.731	0.3%	4335352	0.037	0.055	0.085
TOTAL: 23:59:12.927	23:32:54.986	98.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.129	0.0%	35984	0.000	0.004	0.167
article prepare	00:00:00.006	0.0%	27052	0.000	0.000	0.008
article read	00:00:37.942	0.0%	6772	0.000	5.603	881.500
backlog stats	00:00:00.146	0.0%	170316	0.000	0.001	0.037
callbacks	00:00:00.000	0.0%	6	0.000	0.000	0.000
data read	00:00:01.298	0.0%	94150	0.000	0.014	0.115
data write	00:00:04.625	0.0%	72719	0.000	0.064	0.261
idle	23:58:59.782	99.9%	170316	78.042	506.939	5490.455
status file	00:00:00.622	0.0%	864	0.000	0.720	3.500
TOTAL: 23:59:49.346	23:59:44.550	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:33:02.304	99.4%	3150	0.000	629.303	600518.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.161	0.0%	6989	0.000	0.023	1.000
readart	00:00:00.742	0.0%	87	0.000	8.529	74.778
TOTAL: 00:33:14.205	00:33:03.207	99.4%	-	-	-	-

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	645	2154453	2144603	6004	3846	99%	324:40:50
2	news.nask.pl	2	22348	9296	4025	9027	41%	23:41:39
3	news.icm.edu.pl	46	289	13	255	21	4%	15:57:12
4	localhost	10	9	9	0	0	100%	00:00:00
TOTAL: 4		703	2177099	2153921	10284	12894	98%	364:19:41

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	728.8 GB	32.2 MB	196.4 MB	729.1 GB	99%	355.8 KB
2	news.nask.pl	49.2 MB	753.7 KB	103.1 MB	153.0 MB	32%	8.6 KB
3	news.icm.edu.pl	465.1 KB	0.0 KB	1.0 MB	1.5 MB	30%	44.9 KB
4	localhost	12.1 KB	0.0 KB	0.0 KB	12.1 KB	100%	1.3 KB
TOTAL: 4		728.9 GB	32.9 MB	300.6 MB	729.2 GB	99%	352.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 18 04:15:03 - 04:59:59	91436	4.2%	33.90	32.3 GB	4.4%	12556.82
Nov 18 05:00:00 - 05:59:59	122598	5.7%	34.05	43.7 GB	6.0%	12723.85
Nov 18 06:00:00 - 06:59:59	94914	4.4%	26.36	34.1 GB	4.7%	9937.97
Nov 18 07:00:00 - 07:59:59	112883	5.2%	31.36	41.1 GB	5.7%	11977.08
Nov 18 08:00:00 - 08:59:59	83780	3.9%	23.27	30.3 GB	4.2%	8834.75
Nov 18 09:00:00 - 09:59:59	80008	3.7%	22.22	28.7 GB	3.9%	8363.36
Nov 18 10:00:00 - 10:59:59	87401	4.1%	24.28	28.3 GB	3.9%	8232.61
Nov 18 11:00:00 - 11:59:59	81245	3.8%	22.57	27.0 GB	3.7%	7851.08
Nov 18 12:00:00 - 12:59:59	83297	3.9%	23.14	27.7 GB	3.8%	8070.98
Nov 18 13:00:00 - 13:59:59	86859	4.0%	24.13	30.3 GB	4.2%	8826.41
Nov 18 14:00:00 - 14:59:59	84384	3.9%	23.44	28.7 GB	4.0%	8373.88
Nov 18 15:00:00 - 15:59:59	88617	4.1%	24.62	30.0 GB	4.1%	8752.16
Nov 18 16:00:00 - 16:59:59	88374	4.1%	24.55	28.8 GB	4.0%	8376.83
Nov 18 17:00:00 - 17:59:59	96348	4.5%	26.76	30.4 GB	4.2%	8863.04
Nov 18 18:00:00 - 18:59:59	94582	4.4%	26.27	29.7 GB	4.1%	8637.92
Nov 18 19:00:00 - 19:59:59	93588	4.3%	26.00	29.0 GB	4.0%	8457.28
Nov 18 20:00:00 - 20:59:59	94362	4.4%	26.21	29.9 GB	4.1%	8719.52
Nov 18 21:00:00 - 21:59:59	93344	4.3%	25.93	30.8 GB	4.2%	8968.32
Nov 18 22:00:00 - 22:59:59	96143	4.5%	26.71	31.6 GB	4.3%	9203.28
Nov 18 23:00:00 - 23:59:59	82985	3.9%	23.05	28.4 GB	3.9%	8265.32
Nov 19 00:00:00 - 00:59:59	69327	3.2%	19.26	24.3 GB	3.3%	7069.97
Nov 19 01:00:00 - 01:59:59	85877	4.0%	23.85	29.1 GB	4.0%	8470.11
Nov 19 02:00:00 - 02:59:59	78511	3.6%	21.81	25.5 GB	3.5%	7425.17
Nov 19 03:00:00 - 03:59:59	66768	3.1%	18.55	22.3 GB	3.1%	6504.47
Nov 19 04:00:00 - 04:15:02	16416	0.8%	18.20	5.6 GB	0.8%	6553.37
TOTAL: 23:59:59	2154047	100.0%	24.93	727.7 GB	100.0%	8831.54

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	9240	16	267	2	8955
2	newsfeed.pionier.net.pl	4258	144	2834	0	1280
3	news.icm.edu.pl	22	0	0	0	22
TOTAL: 3		13520	160	3101	2	10257

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	103
comp.mobile.android	17
it.comp.os.win.windows10	17
it.tlc.cellulari.android	7
it.comp.os.linux.ubuntu	5
hr.rec.glazba.hifi	3
de.comp.lang.vbclassic	2
it.tlc.cellulari.iphone	1
uk.net.providers.gradwell	1
openwatcom.users.assembler	1
it.comp.os.win.windows7	1
hr.ponuda.hardver.periferije	1
comp.sys.mac.vintage	1
TOTAL: 13	160

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

Groups	Count
pl.praca.oferowana	1
bit.listserv.catholic	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8499
Binary in non-binary group	1009
Scoring filter (8)	67
EMP (phl)	23
Too many newsgroups	19
Scoring filter (9)	19
EMP (fsl)	11
Scoring filter (13)	9
Scoring filter (10)	7
HTML post	5
Scoring filter (11)	2
Attached HTML file	1
TOTAL: 12	9671

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	7608	2030	3546	674	17	29759	26%	24:03:11
2	icm	35277	170	23216	3550	1	0	0%	23:52:48
3	nask	9103	64	6217	6	0	0	0%	23:59:58
4	poznan	13046	48	9188	19	0	0	0%	23:55:15
5	okapi	0	0	0	0	0	2225	0%	24:00:03
TOTAL: 5		65034	2312	42167	4249	18	31984	3%	119:51:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	7.5 MB	3.6 MB	11.0 MB	0.1 KB/s	4.2 KB	24:03:11
2	icm	6.0 MB	849.3 MB	855.3 MB	10.2 KB/s	235.4 KB	23:52:48
3	nask	462.6 KB	41.1 KB	503.7 KB	0.0 KB/s	7.2 KB	23:59:58
4	poznan	197.6 KB	138.5 KB	336.1 KB	0.0 KB/s	5.0 KB	23:55:15
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		14.2 MB	853.0 MB	867.1 MB	2.1 KB/s	135.3 KB	119:51:15

Backlog files shrunk by innfeed:

Server	Size
panorama	1.4 MB
TOTAL: 1	1.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	62	54.9 KB	30	0	00:00:21
2	lze200.lze.lodz.pl	2	9	21.3 KB	1	0	00:02:41
3	isvcs01.man.lodz.pl	9	0	0.0 KB	0	9	00:00:00
TOTAL: 3		299	71	76.2 KB	31	9	00:33:13

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	681	62	54.9 KB	30	9	00:00:26
2	*.lze.lodz.pl	2	9	21.3 KB	1	0	00:02:41
3	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	00:30:01
4	unresolved	3	0	0.0 KB	0	0	00:00:04
TOTAL: 4		687	71	76.2 KB	31	9	00:33:13

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
brk161.neoplus.adsl.tpnet.pl	0.005	0.014	00:30:01
lze200.lze.lodz.pl	0.007	0.038	00:02:41
web.man.lodz.pl	1.056	4.155	00:00:21
mon.man.lodz.pl	0.877	4.106	00:00:03
196.52.18.48	0.007	0.007	00:00:03
185.100.87.191	0.011	0.026	00:00:01
david.man.lodz.pl	0.353	1.144	00:00:01
isvcs01.man.lodz.pl	0.035	0.125	00:00:00
TOTAL: 8	2.351	9.615	00:33:13

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.100.87.191	2
196.52.18.48	1
brk161.neoplus.adsl.tpnet.pl	1
TOTAL: 5	388

NNRP client timeouts [Top 20]:

System	Conn	Peer
brk161.neoplus.adsl.tpnet.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	52
2	pl.comp.os.ms-windows.winnt	10
3	pl.misc.telefonia.gsm	9
TOTAL: 3		71

Daily Usenet report

Nov 18 04:15:03 -- Nov 19 04:15:02