Daily Usenet report: May 7 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

May 7 11:46:50 newsfeed nnrpd[10494]: SERVER perl filter not defined
May 7 11:48:17 newsfeed nnrpd[10508]: SERVER perl filter not defined
May 7 11:54:04 newsfeed nnrpd[10602]: SERVER perl filter not defined
May 7 12:36:58 newsfeed nnrpd[12174]: SERVER perl filter not defined
May 7 14:40:50 newsfeed nnrpd[19552]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1356594	98.0%	154.8 MB	97.5%
innd	13156	1.0%	2.2 MB	1.4%
nnrpd	7424	0.5%	796.4 KB	0.5%
innfeed	7113	0.5%	1.0 MB	0.7%
TOTAL: 4	1384287	100.0%	158.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1350550	92.9%
Negative hits	60942	4.2%
Positive hits	42430	2.9%
Cache misses	203	0.0%
TOTAL: 4	1454125	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.222	0.0%	302	0.000	27.225	575.000
article cleanup	00:00:23.516	0.0%	1356833	0.003	0.017	0.040
article logging	00:00:40.857	0.0%	1356969	0.012	0.030	0.358
article parse	01:03:46.788	4.4%	128932863	0.012	0.030	0.076
article write	00:16:34.315	1.2%	1349982	0.317	0.737	3.572
artlog/artcncl	00:00:00.009	0.0%	289	0.000	0.031	1.000
artlog/artparse	00:00:00.000	0.0%	5	0.000	0.000	0.000
data move	00:03:21.157	0.2%	137891886	0.001	0.001	0.024
hisgrep/artcncl	00:00:02.682	0.0%	280	0.000	9.579	328.000
hishave/artcncl	00:00:00.264	0.0%	302	0.000	0.874	22.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:15:18.458	5.2%	1456213	0.009	3.103	8.623
history sync	00:00:00.366	0.0%	292	0.000	1.253	346.000
history write	02:41:48.723	11.2%	1352357	0.182	7.179	19.333
hiswrite/artcncl	00:00:00.372	0.0%	22	0.000	16.909	274.000
idle	13:37:48.632	56.8%	90115680	0.241	0.545	1.181
nntp read	00:56:19.632	3.9%	127874646	0.013	0.026	0.039
overview write	00:00:09.547	0.0%	1349982	0.000	0.007	0.025
perl filter	03:26:53.961	14.4%	1352352	5.531	9.180	13.084
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:07.135	0.2%	2754024	0.025	0.068	0.162
TOTAL: 24:00:22.773	23:26:24.636	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.212	0.0%	54040	0.000	0.004	0.111
article prepare	00:00:00.006	0.0%	29418	0.000	0.000	0.042
article read	00:00:00.897	0.0%	6857	0.000	0.131	8.067
backlog stats	00:00:00.242	0.0%	343240	0.000	0.001	0.015
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.326	0.0%	207191	0.000	0.011	1.000
data write	00:00:04.957	0.0%	162216	0.000	0.031	2.000
idle	23:59:17.131	100.0%	343240	0.000	251.594	10048.000
status file	00:00:00.738	0.0%	242	0.000	3.050	30.333
TOTAL: 23:59:41.831	23:59:26.509	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:43:42.444	99.7%	5425	0.000	1810.589	600055.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.294	0.0%	12752	0.000	0.023	1.053
readart	00:00:00.167	0.0%	430	0.000	0.388	9.733
TOTAL: 02:44:09.743	02:43:42.905	99.7%	-	-	-	-

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	573	1345021	1338799	2269	3953	99%	270:45:10
2	news.task.gda.pl	17	30893	6129	23206	1558	19%	46:27:47
3	news.nask.pl	2	19471	5773	12407	1291	29%	23:55:30
4	news.icm.edu.pl	44	309	7	236	66	2%	18:10:08
5	localhost	6	5	5	0	0	100%	00:00:01
TOTAL: 5		642	1395699	1350713	38118	6868	96%	359:18:36

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	473.1 GB	34.6 MB	104.3 MB	473.3 GB	99%	369.6 KB
2	news.nask.pl	36.2 MB	3.8 MB	4.3 MB	44.3 MB	81%	6.4 KB
3	news.task.gda.pl	13.6 MB	62.1 KB	5.2 MB	18.9 MB	72%	2.5 KB
4	news.icm.edu.pl	208.4 KB	0.0 KB	886.4 KB	1.1 MB	19%	15.0 KB
5	localhost	12.2 KB	0.0 KB	0.0 KB	12.2 KB	100%	2.4 KB
TOTAL: 5		473.2 GB	38.5 MB	114.6 MB	473.3 GB	99%	365.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 7 04:15:02 - 04:59:59	61185	4.5%	22.68	21.3 GB	4.5%	8285.24
May 7 05:00:00 - 05:59:59	68907	5.1%	19.14	27.4 GB	5.8%	7970.58
May 7 06:00:00 - 06:59:59	79456	5.9%	22.07	28.9 GB	6.1%	8423.99
May 7 07:00:00 - 07:59:59	52907	3.9%	14.70	20.7 GB	4.4%	6026.97
May 7 08:00:00 - 08:59:59	38411	2.8%	10.67	14.8 GB	3.1%	4304.21
May 7 09:00:00 - 09:59:59	36633	2.7%	10.18	14.5 GB	3.1%	4237.17
May 7 10:00:00 - 10:59:59	36473	2.7%	10.13	14.1 GB	3.0%	4108.10
May 7 11:00:00 - 11:59:59	50127	3.7%	13.92	14.7 GB	3.1%	4281.49
May 7 12:00:00 - 12:59:59	52652	3.9%	14.63	15.5 GB	3.3%	4517.96
May 7 13:00:00 - 13:59:59	37719	2.8%	10.48	14.0 GB	3.0%	4071.27
May 7 14:00:00 - 14:59:59	42736	3.2%	11.87	15.9 GB	3.4%	4629.88
May 7 15:00:00 - 15:59:59	43669	3.2%	12.13	15.7 GB	3.3%	4581.25
May 7 16:00:00 - 16:59:59	47588	3.5%	13.22	16.8 GB	3.6%	4898.61
May 7 17:00:00 - 17:59:59	46056	3.4%	12.79	16.2 GB	3.4%	4727.27
May 7 18:00:00 - 18:59:59	44929	3.3%	12.48	15.9 GB	3.4%	4618.49
May 7 19:00:00 - 19:59:59	53462	4.0%	14.85	15.5 GB	3.3%	4502.25
May 7 20:00:00 - 20:59:59	55660	4.1%	15.46	15.8 GB	3.4%	4611.54
May 7 21:00:00 - 21:59:59	40058	3.0%	11.13	13.8 GB	2.9%	4029.27
May 7 22:00:00 - 22:59:59	61295	4.5%	17.03	20.3 GB	4.3%	5912.65
May 7 23:00:00 - 23:59:59	75791	5.6%	21.05	24.8 GB	5.3%	7232.00
May 8 00:00:00 - 00:59:59	69742	5.2%	19.37	24.0 GB	5.1%	6992.01
May 8 01:00:00 - 01:59:59	67255	5.0%	18.68	23.7 GB	5.0%	6892.59
May 8 02:00:00 - 02:59:59	84193	6.2%	23.39	30.1 GB	6.4%	8756.58
May 8 03:00:00 - 03:59:59	82416	6.1%	22.89	30.5 GB	6.5%	8882.72
May 8 04:00:00 - 04:15:03	19992	1.5%	22.14	7.6 GB	1.6%	8800.19
TOTAL: 24:00:01	1349312	100.0%	15.62	472.5 GB	100.0%	5734.33

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4052	294	3184	2	572
2	news.task.gda.pl	1575	1394	34	1	146
3	news.nask.pl	1300	16	1263	3	18
4	news.icm.edu.pl	66	0	0	0	66
TOTAL: 4		6993	1704	4481	6	802

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	191
mailing.freebsd.svn-src-all	142
fa.freebsd.cvs-all	136
mailing.freebsd.svn-ports-all	99
mailing.freebsd.svn-ports-head	99
mailing.freebsd.ports-bugs	91
mozilla.dev.tree-management	84
mailing.gcc.gcc-cvs	66
alt.windows7.general	65
mailing.openbsd.misc	51
mailing.freebsd.svn-src-head	49
mailing.openbsd.source-changes	48
gmane.linux.alsa.devel	40
mailing.unix.dovecot	35
fr.usenet.abus.nocem	32
mailing.postfix.users	31
de.rec.sf.startrek	31
mozilla.dev.platform	30
mailing.database.pgsql-general	30
mailing.unix.samba-technical	28
TOTAL: 70	1704

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

Groups	Count
pl.sci.matematyka	2
pl.sci.historia	2
bit.listserv.catholic	1
fr.comp.applications.libres	1
TOTAL: 4	6

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	438
EMP (fsl)	112
EMP (md5)	75
HTML post	24
Attached HTML file	7
Scoring filter (8)	4
Scoring filter (11)	1
TOTAL: 7	661

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	64194	2425	33525	2105	7	15	3%	24:00:02
2	panorama	55468	2277	51698	218	0	0	4%	23:59:33
3	task	1885	239	840	21	0	0	12%	22:03:44
4	poznan	14031	52	11513	29	0	0	0%	23:54:06
5	nask	24224	28	16065	0	0	0	0%	24:06:28
6	okapi	0	0	0	0	0	2899	0%	24:00:02
TOTAL: 6		159802	5021	113641	2373	7	2914	3%	142:03:55

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	219.7 MB	43.9 MB	263.6 MB	3.1 KB/s	59.6 KB	24:00:02
2	panorama	17.5 MB	1.8 MB	19.2 MB	0.2 KB/s	7.9 KB	23:59:33
3	task	509.8 KB	35.8 KB	545.6 KB	0.0 KB/s	2.1 KB	22:03:44
4	nask	258.8 KB	0.0 KB	258.8 KB	0.0 KB/s	9.2 KB	24:06:28
5	poznan	195.0 KB	51.0 KB	246.0 KB	0.0 KB/s	3.0 KB	23:54:06
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 6		238.1 MB	45.8 MB	283.9 MB	0.6 KB/s	39.3 KB	142:03:55

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	338	632.7 KB	288	0	00:00:11
2	web.man.lodz.pl	288	92	99.5 KB	38	0	00:00:23
3	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 3		581	430	732.2 KB	326	5	02:44:08

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	338	632.7 KB	288	0	00:00:11
2	*.man.lodz.pl	677	92	99.5 KB	38	5	00:00:30
3	*.pa.nsw.optusnet.com.au	33	0	0.0 KB	0	0	00:01:00
4	*.191.14.62.static.jazztel.es	3	0	0.0 KB	0	0	00:02:26
5	*.105.135.22.tvsat364.lodz.pl	2	0	0.0 KB	0	0	00:48:00
6	*.wroclaw.mm.pl	12	0	0.0 KB	0	0	01:51:49
7	*.toya.net.pl	93	0	0.0 KB	0	0	00:00:09
TOTAL: 7		1108	430	732.2 KB	326	5	02:44:08

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
host-89-231-50-15.wroclaw.mm.pl	0.024	0.132	01:51:49
ip-176.105.135.22.tvsat364.lodz.pl	0.008	0.016	00:48:00
242.191.14.62.static.jazztel.es	0.092	0.072	00:02:26
pa49-181-246-27.pa.nsw.optusnet.com.au	0.092	0.304	00:01:00
web.man.lodz.pl	0.728	2.716	00:00:23
pc-skrzep2.cm.p.lodz.pl	0.760	2.764	00:00:11
staticline41435.toya.net.pl	0.236	0.884	00:00:09
mon.man.lodz.pl	0.764	2.692	00:00:04
david.man.lodz.pl	0.248	0.840	00:00:01
isvcs01.man.lodz.pl	0.024	0.056	00:00:00
TOTAL: 10	2.976	10.476	02:44:08

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	93
pa49-181-246-27.pa.nsw.optusnet.com.au	33
host-89-231-50-15.wroclaw.mm.pl	12
242.191.14.62.static.jazztel.es	3
ip-176.105.135.22.tvsat364.lodz.pl	2
TOTAL: 7	527

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	338	78.6%
2	pl	92	21.4%
TOTAL: 2		430	100.0%

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

Newsgroup		Count
1	lodman.info	338
2	pl.comp.pecet	80
3	pl.comp.os.ms-windows.winnt	12
TOTAL: 3		430

Daily Usenet report

May 7 04:15:02 -- May 8 04:15:03