Daily Usenet report: May 21 04:15:03

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

May 21 04:39:06 newsfeed pgpverify[10371]: pgpverify: verification failed
May 21 05:41:42 newsfeed nnrpd[12615]: SERVER perl filter not defined
May 21 12:32:55 newsfeed nnrpd[26753]: SERVER perl filter not defined
May 21 22:00:04 newsfeed pgpverify[13657]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1562457	98.2%	180.0 MB	97.7%
innd	13201	0.8%	2.3 MB	1.2%
nnrpd	7802	0.5%	855.7 KB	0.5%
innfeed	7198	0.5%	1.1 MB	0.6%
controlchan	4	0.0%	0.5 KB	0.0%
pgpverify	2	0.0%	0.1 KB	0.0%
TOTAL: 6	1590664	100.0%	184.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1555768	94.1%
Negative hits	53545	3.2%
Positive hits	41602	2.5%
Cache misses	1977	0.1%
TOTAL: 4	1652892	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:14.199	0.0%	335	0.000	42.385	441.000
article cleanup	00:00:21.414	0.0%	1562982	0.000	0.014	0.031
article logging	00:00:43.637	0.1%	1563130	0.012	0.028	0.472
article parse	00:53:15.532	3.7%	220273323	0.005	0.015	0.051
article write	00:15:52.963	1.1%	1556228	0.222	0.612	3.085
artlog/artcncl	00:00:00.003	0.0%	331	0.000	0.009	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:23.942	0.2%	231175366	0.000	0.001	0.004
hisgrep/artcncl	00:00:01.802	0.0%	292	0.000	6.171	204.000
hishave/artcncl	00:00:01.796	0.0%	335	0.000	5.361	298.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:46:24.248	11.6%	1654958	0.008	6.033	14.115
history sync	00:00:00.006	0.0%	291	0.000	0.021	1.000
history write	03:35:23.653	15.0%	1558034	0.361	8.295	25.135
hiswrite/artcncl	00:00:00.792	0.0%	43	0.000	18.419	274.000
idle	11:33:45.156	48.2%	169171424	0.133	0.246	0.540
nntp read	00:54:09.275	3.8%	219109920	0.007	0.015	0.036
overview write	00:00:08.710	0.0%	1556228	0.000	0.006	0.019
perl filter	03:14:26.155	13.5%	1558033	3.924	7.488	10.338
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:55.483	0.2%	3163952	0.013	0.055	0.078
TOTAL: 24:00:32.638	23:20:08.766	97.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.182	0.0%	51519	0.000	0.004	0.200
article prepare	00:00:00.007	0.0%	22322	0.000	0.000	0.083
article read	00:00:00.696	0.0%	5416	0.000	0.129	1.143
backlog stats	00:00:00.241	0.0%	342824	0.000	0.001	0.016
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.960	0.0%	198910	0.000	0.010	0.077
data write	00:00:05.709	0.0%	163690	0.000	0.035	10.000
idle	24:00:24.741	100.0%	342824	0.000	252.097	16338.000
status file	00:00:00.742	0.0%	198	0.000	3.747	152.000
TOTAL: 24:00:40.755	24:00:34.278	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	26:21:55.336	99.9%	807733	0.000	117.508	29915.773
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:23.587	0.0%	1617417	0.000	0.015	3.000
readart	00:00:00.717	0.0%	391	0.000	1.834	22.929
TOTAL: 26:23:20.321	26:22:19.640	99.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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
group-admin@isc.org	0	0	0	1	0	0
nl-admin@nic.surfnet.nl	0	0	0	1	0	0
TOTAL	0	0	0	2	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	324	1552741	1544599	3503	4639	99%	192:31:53
2	news.task.gda.pl	15	30761	5920	23585	1256	19%	47:16:46
3	news.nask.pl	2	17973	4891	12162	920	27%	24:28:55
4	news.icm.edu.pl	50	268	6	243	19	2%	18:18:07
5	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 5		394	1601745	1555418	39493	6834	97%	282:35:41

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	541.6 GB	511.7 MB	531.6 MB	542.6 GB	99%	367.3 KB
2	news.nask.pl	20.5 MB	3.3 MB	3.3 MB	27.1 MB	75%	4.8 KB
3	news.task.gda.pl	13.2 MB	65.9 KB	4.0 MB	17.3 MB	76%	2.5 KB
4	news.icm.edu.pl	61.3 KB	9.3 KB	539.9 KB	610.5 KB	10%	24.4 KB
5	localhost	2.7 KB	0.0 KB	0.0 KB	2.7 KB	100%	1.3 KB
TOTAL: 5		541.6 GB	515.0 MB	539.4 MB	542.7 GB	99%	364.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 21 04:15:03 - 04:59:59	44199	2.8%	16.39	17.2 GB	3.2%	6700.55
May 21 05:00:00 - 05:59:59	45230	2.9%	12.56	17.3 GB	3.2%	5026.91
May 21 06:00:00 - 06:59:59	56680	3.6%	15.74	20.8 GB	3.8%	6057.44
May 21 07:00:00 - 07:59:59	77943	5.0%	21.65	28.9 GB	5.3%	8429.08
May 21 08:00:00 - 08:59:59	36379	2.3%	10.11	13.4 GB	2.5%	3896.44
May 21 09:00:00 - 09:59:59	54273	3.5%	15.08	20.3 GB	3.7%	5898.65
May 21 10:00:00 - 10:59:59	67241	4.3%	18.68	26.8 GB	4.9%	7794.30
May 21 11:00:00 - 11:59:59	67961	4.4%	18.88	26.4 GB	4.9%	7696.75
May 21 12:00:00 - 12:59:59	71071	4.6%	19.74	27.3 GB	5.0%	7944.30
May 21 13:00:00 - 13:59:59	85261	5.5%	23.68	30.5 GB	5.6%	8879.92
May 21 14:00:00 - 14:59:59	84508	5.4%	23.47	31.6 GB	5.8%	9206.26
May 21 15:00:00 - 15:59:59	91159	5.9%	25.32	32.9 GB	6.1%	9580.83
May 21 16:00:00 - 16:59:59	63265	4.1%	17.57	23.6 GB	4.4%	6886.17
May 21 17:00:00 - 17:59:59	45907	3.0%	12.75	18.1 GB	3.3%	5271.36
May 21 18:00:00 - 18:59:59	39941	2.6%	11.09	15.0 GB	2.8%	4365.18
May 21 19:00:00 - 19:59:59	38836	2.5%	10.79	15.0 GB	2.8%	4377.93
May 21 20:00:00 - 20:59:59	41921	2.7%	11.64	14.9 GB	2.7%	4336.29
May 21 21:00:00 - 21:59:59	43764	2.8%	12.16	15.5 GB	2.9%	4523.73
May 21 22:00:00 - 22:59:59	46265	3.0%	12.85	16.0 GB	3.0%	4665.45
May 21 23:00:00 - 23:59:59	43501	2.8%	12.08	14.6 GB	2.7%	4254.04
May 22 00:00:00 - 00:59:59	70851	4.6%	19.68	24.4 GB	4.5%	7095.55
May 22 01:00:00 - 01:59:59	70522	4.5%	19.59	23.5 GB	4.3%	6833.72
May 22 02:00:00 - 02:59:59	111577	7.2%	30.99	28.0 GB	5.2%	8161.69
May 22 03:00:00 - 03:59:59	126564	8.1%	35.16	32.4 GB	6.0%	9446.33
May 22 04:00:00 - 04:15:02	30400	2.0%	33.70	7.8 GB	1.4%	9029.40
TOTAL: 23:59:59	1555219	100.0%	18.00	542.1 GB	100.0%	6579.68

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.pionier.net.pl	4770	182	4047	541
2	news.task.gda.pl	1205	981	26	198
3	news.nask.pl	913	4	880	29
4	news.icm.edu.pl	19	0	1	18
TOTAL: 4		6907	1167	4954	786

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.ports-bugs	98
uk.railway	84
alt.windows7.general	65
mailing.gcc.gcc-cvs	62
mailing.freebsd.svn-ports-all	61
mailing.freebsd.svn-ports-head	55
mozilla.dev.tree-management	54
mailing.freebsd.svn-src-all	41
fa.freebsd.cvs-all	40
fr.usenet.abus.nocem	32
mozilla.dev.gaia	30
mailing.freebsd.svn-src-head	29
mozilla.dev.platform	26
mailing.unix.samba	24
mailing.database.pgsql-general	24
mailing.openbsd.misc	24
mailing.unix.samba-technical	23
mailing.freebsd.ports	22
mailing.unix.dovecot	21
mailing.openbsd.source-changes	21
TOTAL: 78	1167

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	368
EMP (fsl)	176
EMP (md5)	45
Attached HTML file	31
HTML post	16
Scoring filter (12)	1
TOTAL: 6	637

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	56012	1994	49132	383	1	0	3%	23:59:35
2	icm	60844	1080	32889	1991	2	21	1%	24:00:10
3	nask	21943	88	13931	0	0	0	0%	24:05:27
4	poznan	12391	41	10391	17	0	0	0%	23:54:07
5	task	2236	7	1195	3	0	0	0%	22:10:06
6	okapi	0	0	0	0	0	2669	0%	24:00:00
TOTAL: 6		153426	3210	107538	2394	3	2690	2%	142:09:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	82.9 MB	640.4 MB	723.3 MB	8.6 KB/s	241.2 KB	24:00:10
2	panorama	9.3 MB	1.7 MB	11.0 MB	0.1 KB/s	4.7 KB	23:59:35
3	poznan	254.0 KB	27.1 KB	281.1 KB	0.0 KB/s	4.8 KB	23:54:07
4	nask	221.3 KB	0.0 KB	221.3 KB	0.0 KB/s	2.5 KB	24:05:27
5	task	56.2 KB	6.3 KB	62.5 KB	0.0 KB/s	6.2 KB	22:10:06
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		92.8 MB	642.1 MB	734.9 MB	1.5 KB/s	134.3 KB	142:09:25

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	312	429.0 KB	288	0	00:00:09
2	web.man.lodz.pl	288	62	49.7 KB	28	0	00:00:26
3	ip-176.105.135.22.tvsat364.lodz.pl	1	14	21.7 KB	2	0	00:10:59
4	212.51.203.199	2	3	3.7 KB	1	0	00:00:58
5	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:01
TOTAL: 5		581	391	504.1 KB	319	2	26:23:19

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	312	429.0 KB	288	0	00:00:09
2	*.man.lodz.pl	674	62	49.7 KB	28	2	00:00:33
3	*.105.135.22.tvsat364.lodz.pl	1	14	21.7 KB	2	0	00:10:59
4	unresolved	3	3	3.7 KB	1	0	00:01:42
5	*.pa.nsw.optusnet.com.au	189	0	0.0 KB	0	0	00:05:17
6	*.toya.net.pl	56	0	0.0 KB	0	0	00:00:04
TOTAL: 6		1211	391	504.1 KB	319	2	26:23:19

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
242.191.14.62.static.jazztel.es	37.360	49.064	26:04:32
ip-176.105.135.22.tvsat364.lodz.pl	0.004	0.012	00:10:59
pa49-181-246-88.pa.nsw.optusnet.com.au	0.320	2.168	00:05:17
212.51.203.199	0.004	0.036	00:00:58
194.33.77.50	0.000	0.008	00:00:44
web.man.lodz.pl	0.580	4.396	00:00:26
pc-skrzep2.cm.p.lodz.pl	0.552	3.832	00:00:09
staticline41435.toya.net.pl	0.076	0.704	00:00:04
mon.man.lodz.pl	0.492	3.956	00:00:04
david.man.lodz.pl	0.168	1.216	00:00:01
isvcs01.man.lodz.pl	0.000	0.052	00:00:01
TOTAL: 11	39.556	65.444	26:23:19

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
pa49-181-246-88.pa.nsw.optusnet.com.au	189
david.man.lodz.pl	96
staticline41435.toya.net.pl	56
194.33.77.50	1
TOTAL: 5	630

NNRP client timeouts [Top 20]:

System	Conn	Peer
242.191.14.62.static.jazztel.es	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	312	79.8%
2	pl	79	20.2%
TOTAL: 2		391	100.0%

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

Newsgroup		Count
1	lodman.info	312
2	pl.comp.pecet	34
3	pl.comp.os.ms-windows.winnt	28
4	pl.soc.prawo	12
5	pl.rec.radio.amatorskie	3
6	pl.regionalne.lodz	2
TOTAL: 6		391

Daily Usenet report

May 21 04:15:03 -- May 22 04:15:02