Daily Usenet report: Oct 23 04:15:03

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Oct 23 09:55:15 newsfeed nnrpd[17143]: SERVER perl filter not defined
Oct 23 10:07:46 newsfeed nnrpd[17647]: SERVER perl filter not defined
Oct 23 10:10:52 newsfeed nnrpd[17730]: SERVER perl filter not defined
Oct 23 12:34:15 newsfeed nnrpd[22297]: SERVER perl filter not defined
Oct 23 15:03:42 newsfeed nnrpd[27202]: SERVER perl filter not defined
Oct 23 19:36:40 newsfeed nnrpd[3746]: SERVER perl filter not defined
Oct 24 00:14:17 newsfeed overchan[2232]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2067157	98.1%	234.2 MB	97.6%
innd	23988	1.1%	3.7 MB	1.5%
nnrpd	10026	0.5%	1.0 MB	0.4%
innfeed	6789	0.3%	1.0 MB	0.4%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	2107961	100.0%	239.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2059510	93.6%
Negative hits	100787	4.6%
Positive hits	40663	1.8%
Cache misses	244	0.0%
TOTAL: 4	2201204	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.048	0.0%	283	0.000	35.505	340.000
article cleanup	00:00:26.668	0.0%	2066377	0.004	0.013	0.029
article logging	00:01:01.399	0.1%	2066542	0.013	0.030	0.579
article parse	01:03:15.202	4.4%	58953115	0.018	0.064	0.096
article write	00:20:10.948	1.4%	2052236	0.328	0.590	1.836
artlog/artcncl	00:00:00.005	0.0%	281	0.000	0.018	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:04:26.008	0.3%	70919133	0.001	0.004	0.043
hisgrep/artcncl	00:00:01.248	0.0%	245	0.000	5.094	45.000
hishave/artcncl	00:00:01.546	0.0%	283	0.000	5.463	168.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	04:15:10.218	17.7%	2203088	0.008	6.949	48.717
history sync	00:00:00.030	0.0%	291	0.000	0.103	6.000
history write	05:12:19.937	21.7%	2061134	0.175	9.092	39.770
hiswrite/artcncl	00:00:00.557	0.0%	38	0.000	14.658	278.000
idle	06:45:15.899	28.1%	23509083	0.192	1.034	2.906
nntp read	00:31:03.771	2.2%	57271954	0.013	0.033	0.051
overview write	00:00:12.661	0.0%	2052236	0.000	0.006	0.014
perl filter	05:24:17.129	22.5%	2061133	5.461	9.440	12.165
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:01.435	0.3%	4155154	0.031	0.058	0.170
TOTAL: 23:59:49.321	23:41:54.709	98.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.211	0.0%	50734	0.000	0.004	0.118
article prepare	00:00:00.040	0.0%	97912	0.000	0.000	0.068
article read	00:00:09.459	0.0%	22845	0.000	0.414	70.562
backlog stats	00:00:00.298	0.0%	363705	0.000	0.001	0.018
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.681	0.0%	210120	0.000	0.013	0.083
data write	00:00:11.950	0.0%	195245	0.000	0.061	17.000
idle	24:00:05.467	100.0%	363705	0.000	237.570	18090.000
status file	00:00:01.570	0.0%	220	0.000	7.136	556.000
TOTAL: 24:00:40.711	24:00:31.676	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	52:41:32.259	100.0%	14149	0.000	13406.761	451402.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.589	0.0%	30539	0.000	0.019	2.667
readart	00:00:00.883	0.0%	512	0.000	1.725	38.750
TOTAL: 52:42:13.512	52:41:33.731	100.0%	-	-	-	-

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	713	2052671	2039307	2290	11074	99%	485:21:08
2	news.nask.pl	2	17985	7227	9792	966	40%	24:10:58
3	news.task.gda.pl	16	30955	6194	22727	2034	20%	43:42:32
4	news.icm.edu.pl	47	212	10	200	2	4%	15:48:52
5	localhost	7	6	6	0	0	100%	00:00:01
TOTAL: 5		785	2101829	2052744	35009	14076	97%	569:03:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	741.7 GB	160.2 MB	1.1 GB	743.0 GB	99%	380.0 KB
2	news.nask.pl	212.7 MB	3.2 MB	4.1 MB	219.9 MB	96%	27.5 KB
3	news.task.gda.pl	12.0 MB	134.7 KB	5.0 MB	17.1 MB	70%	2.1 KB
4	news.icm.edu.pl	288.9 KB	0.0 KB	247.6 KB	536.5 KB	53%	44.7 KB
5	localhost	9.6 KB	0.0 KB	0.0 KB	9.6 KB	100%	1.6 KB
TOTAL: 5		742.0 GB	163.5 MB	1.1 GB	743.2 GB	99%	377.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 23 04:15:03 - 04:59:59	68080	3.3%	25.24	24.7 GB	3.3%	9610.52
Oct 23 05:00:00 - 05:59:59	94153	4.6%	26.15	34.3 GB	4.6%	9994.02
Oct 23 06:00:00 - 06:59:59	78994	3.8%	21.94	32.3 GB	4.4%	9421.49
Oct 23 07:00:00 - 07:59:59	88649	4.3%	24.62	34.4 GB	4.6%	10015.13
Oct 23 08:00:00 - 08:59:59	65816	3.2%	18.28	25.9 GB	3.5%	7545.69
Oct 23 09:00:00 - 09:59:59	65123	3.2%	18.09	22.2 GB	3.0%	6472.91
Oct 23 10:00:00 - 10:59:59	56743	2.8%	15.76	19.4 GB	2.6%	5646.67
Oct 23 11:00:00 - 11:59:59	60253	2.9%	16.74	20.6 GB	2.8%	5996.50
Oct 23 12:00:00 - 12:59:59	68191	3.3%	18.94	23.2 GB	3.1%	6765.95
Oct 23 13:00:00 - 13:59:59	102247	5.0%	28.40	35.1 GB	4.7%	10234.74
Oct 23 14:00:00 - 14:59:59	92605	4.5%	25.72	34.5 GB	4.7%	10057.07
Oct 23 15:00:00 - 15:59:59	97378	4.7%	27.05	35.4 GB	4.8%	10318.63
Oct 23 16:00:00 - 16:59:59	100778	4.9%	27.99	36.8 GB	5.0%	10731.74
Oct 23 17:00:00 - 17:59:59	88255	4.3%	24.52	32.5 GB	4.4%	9470.39
Oct 23 18:00:00 - 18:59:59	91526	4.5%	25.42	32.9 GB	4.4%	9570.26
Oct 23 19:00:00 - 19:59:59	89964	4.4%	24.99	31.2 GB	4.2%	9090.07
Oct 23 20:00:00 - 20:59:59	86606	4.2%	24.06	30.5 GB	4.1%	8895.93
Oct 23 21:00:00 - 21:59:59	91442	4.5%	25.40	31.6 GB	4.3%	9200.73
Oct 23 22:00:00 - 22:59:59	94757	4.6%	26.32	32.7 GB	4.4%	9530.46
Oct 23 23:00:00 - 23:59:59	100955	4.9%	28.04	35.9 GB	4.8%	10457.67
Oct 24 00:00:00 - 00:59:59	76116	3.7%	21.14	26.1 GB	3.5%	7592.83
Oct 24 01:00:00 - 01:59:59	91173	4.4%	25.33	32.5 GB	4.4%	9451.97
Oct 24 02:00:00 - 02:59:59	91086	4.4%	25.30	34.7 GB	4.7%	10101.62
Oct 24 03:00:00 - 03:59:59	90167	4.4%	25.05	34.0 GB	4.6%	9893.17
Oct 24 04:00:00 - 04:15:04	21516	1.0%	23.80	8.4 GB	1.1%	9706.36
TOTAL: 24:00:01	2052573	100.0%	23.76	741.9 GB	100.0%	9003.77

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	11203	199	4249	2	6753
2	news.task.gda.pl	2118	1201	68	0	849
3	news.nask.pl	980	17	923	2	38
4	news.icm.edu.pl	2	0	0	0	2
TOTAL: 4		14303	1417	5240	4	7642

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	109
mailing.freebsd.svn-ports-head	109
uk.railway	95
mailing.freebsd.ports-bugs	63
mailing.gcc.gcc-cvs	57
mozilla.dev.tree-management	52
mailing.freebsd.current	47
alt.windows7.general	44
mailing.freebsd.svn-src-all	42
fa.freebsd.cvs-all	42
mailing.unix.spamassassin-talk	39
mailing.openbsd.source-changes	38
mailing.freebsd.svn-src-head	38
fr.usenet.abus.nocem	37
mailing.www.horde-general	27
mailing.openbsd.ports-changes	26
24hoursupport.helpdesk	26
hr.alt.cellular.gsm.iphone	26
mailing.freebsd.ports	25
mailing.database.pgsql-general	24
TOTAL: 83	1417

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

Groups	Count
pl.sci.historia	4
TOTAL: 1	4

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	6592
EMP (phl)	781
Attached HTML file	41
EMP (fsl)	26
HTML post	18
EMP (md5)	15
Angle-bracket bot	1
Scoring filter (10)	1
Scoring filter (8)	1
TOTAL: 9	7476

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	56901	11580	25159	8386	16	34	20%	24:07:43
2	panorama	51682	3124	46402	1029	0	0	6%	23:51:44
3	task	2042	245	933	22	0	0	11%	20:44:26
4	poznan	14046	64	11961	32	0	0	0%	23:51:20
5	nask	18476	12	14522	0	0	0	0%	23:58:58
6	okapi	0	0	0	0	0	2555	0%	24:00:00
TOTAL: 6		143147	15025	98977	9469	16	2589	10%	140:34:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	55.9 MB	3.0 GB	3.1 GB	36.8 KB/s	160.2 KB	24:07:43
2	panorama	11.4 MB	10.0 MB	21.4 MB	0.3 KB/s	5.3 KB	23:51:44
3	task	569.9 KB	39.6 KB	609.6 KB	0.0 KB/s	2.3 KB	20:44:26
4	poznan	258.4 KB	275.3 KB	533.7 KB	0.0 KB/s	5.6 KB	23:51:20
5	nask	23.1 KB	0.0 KB	23.1 KB	0.0 KB/s	1.9 KB	23:58:58
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		68.1 MB	3.0 GB	3.1 GB	6.4 KB/s	131.5 KB	140:34:11

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	vegas.cm.p.lodz.pl	288	324	476.0 KB	288	0	0	00:00:14
2	web.man.lodz.pl	290	97	102.0 KB	41	1	2	00:00:22
3	lze200.lze.lodz.pl	4	45	75.8 KB	10	0	0	00:45:33
4	212.191.78.190	257	38	65.6 KB	18	2	0	43:51:28
5	ip-176.105.135.22.tvsat364.lodz.pl	4	4	4.9 KB	1	0	0	00:44:02
6	router2.cbmm.lodz.pl	4	4	4.9 KB	1	0	0	00:43:16
7	kujawiak.man.lodz.pl	3	0	0.0 KB	0	3	0	00:00:00
TOTAL: 7		850	512	729.1 KB	359	6	2	52:42:10

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	324	476.0 KB	288	0	0	00:00:14
2	*.man.lodz.pl	677	97	102.0 KB	41	4	2	00:00:26
3	*.lze.lodz.pl	4	45	75.8 KB	10	0	0	00:45:33
4	unresolved	259	38	65.6 KB	18	2	0	43:51:56
5	*.cbmm.lodz.pl	4	4	4.9 KB	1	0	0	00:43:16
6	*.105.135.22.tvsat364.lodz.pl	4	4	4.9 KB	1	0	0	00:44:02
7	*.191.14.62.static.jazztel.es	8	0	0.0 KB	0	0	0	00:20:02
8	*.lodz.mm.pl	38	0	0.0 KB	0	0	0	06:15:59
9	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	0	00:00:35
10	*.toya.net.pl	53	0	0.0 KB	0	0	0	00:00:04
TOTAL: 10		1336	512	729.1 KB	359	6	2	52:42:10

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.636	3.032	43:51:28
host-89-228-165-199.lodz.mm.pl	0.088	0.472	06:15:59
lze200.lze.lodz.pl	0.020	0.068	00:45:33
ip-176.105.135.22.tvsat364.lodz.pl	0.008	0.044	00:44:02
router2.cbmm.lodz.pl	0.016	0.036	00:43:16
16.191.14.62.static.jazztel.es	0.424	0.768	00:20:02
ebw250.neoplus.adsl.tpnet.pl	0.004	0.012	00:00:35
212.51.203.199	0.008	0.016	00:00:28
web.man.lodz.pl	0.640	3.276	00:00:22
vegas.cm.p.lodz.pl	0.636	3.472	00:00:14
staticline41435.toya.net.pl	0.120	0.632	00:00:04
f-oper-v100.man.lodz.pl	0.380	2.132	00:00:02
david.man.lodz.pl	0.200	1.028	00:00:01
kujawiak.man.lodz.pl	0.012	0.032	00:00:00
TOTAL: 14	3.192	15.020	52:42:10

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	53
host-89-228-165-199.lodz.mm.pl	38
16.191.14.62.static.jazztel.es	8
212.51.203.199	2
ebw250.neoplus.adsl.tpnet.pl	1
TOTAL: 7	486

NNRP client timeouts [Top 20]:

System	Conn	Peer
212.191.78.190	4	0
lze200.lze.lodz.pl	1	0
router2.cbmm.lodz.pl	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 4	7	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	324	63.3%
2	pl	188	36.7%
TOTAL: 2		512	100.0%

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

Newsgroup		Count
1	lodman.info	324
2	pl.comp.os.ms-windows.winnt	81
3	pl.comp.pecet	26
4	pl.regionalne.lodz	21
5	pl.misc.kolej	15
6	pl.misc.telefonia.gsm	11
7	pl.rec.kuchnia	10
8	pl.rec.dom	5
9	pl.regionalne.warszawa	5
10	pl.rec.rowery	5
11	pl.soc.prawo	4
12	pl.rec.gory	4
13	pl.rec.mineraly	1
TOTAL: 13		512

Daily Usenet report

Oct 23 04:15:03 -- Oct 24 04:15:04