Daily Usenet report: Apr 9 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Apr 9 12:04:42 newsfeed nnrpd[18389]: SERVER perl filter not defined
Apr 9 12:10:49 newsfeed nnrpd[18672]: SERVER perl filter not defined
Apr 9 12:11:06 newsfeed nnrpd[18679]: SERVER perl filter not defined
Apr 9 15:04:57 newsfeed nnrpd[24668]: SERVER perl filter not defined
Apr 9 15:06:48 newsfeed nnrpd[24728]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1086883	97.8%	123.8 MB	97.2%
innd	10683	1.0%	1.8 MB	1.4%
nnrpd	7323	0.7%	782.6 KB	0.6%
innfeed	6991	0.6%	1.0 MB	0.8%
TOTAL: 4	1111880	100.0%	127.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1082169	92.7%
Negative hits	44552	3.8%
Positive hits	40291	3.5%
Cache misses	217	0.0%
TOTAL: 4	1167229	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.116	0.0%	291	0.000	24.454	341.000
article cleanup	00:00:19.566	0.0%	1086953	0.000	0.018	0.043
article logging	00:00:37.463	0.0%	1087171	0.003	0.034	0.338
article parse	00:49:59.469	3.5%	119054692	0.003	0.025	0.068
article write	00:10:55.028	0.8%	1081903	0.162	0.605	1.660
artlog/artcncl	00:00:00.009	0.0%	277	0.000	0.032	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:02:48.002	0.2%	126366334	0.000	0.001	0.035
hisgrep/artcncl	00:00:01.610	0.0%	259	0.000	6.216	47.000
hishave/artcncl	00:00:01.081	0.0%	291	0.000	3.715	62.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:53:20.512	7.9%	1168691	0.007	5.819	13.515
history sync	00:00:00.017	0.0%	293	0.000	0.058	1.000
history write	02:33:51.250	10.7%	1083780	0.101	8.518	24.947
hiswrite/artcncl	00:00:00.388	0.0%	32	0.000	12.125	285.000
idle	14:24:56.874	60.0%	89516938	0.258	0.580	1.435
nntp read	00:47:20.353	3.3%	118211175	0.004	0.024	0.050
overview write	00:00:07.600	0.0%	1081903	0.000	0.007	0.027
perl filter	02:40:27.919	11.1%	1083777	3.126	8.884	12.790
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:30.968	0.2%	2202685	0.016	0.069	0.107
TOTAL: 24:00:23.862	23:27:25.225	97.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.148	0.0%	38908	0.000	0.004	0.091
article prepare	00:00:00.015	0.0%	66990	0.000	0.000	0.083
article read	00:00:02.223	0.0%	15937	0.000	0.139	45.286
backlog stats	00:00:00.231	0.0%	296352	0.000	0.001	0.015
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:01.994	0.0%	180933	0.000	0.011	1.000
data write	00:00:04.530	0.0%	148271	0.000	0.031	0.496
idle	23:59:45.040	100.0%	296352	0.000	291.495	12239.000
status file	00:00:00.593	0.0%	210	0.000	2.824	105.667
TOTAL: 24:00:01.798	23:59:54.774	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:03:04.278	99.7%	30481	0.000	360.365	600071.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.731	0.0%	62833	0.000	0.012	1.463
readart	00:00:00.644	0.0%	398	0.000	1.618	32.455
TOTAL: 03:03:39.643	03:03:05.653	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	273	1074114	1070009	883	3222	99%	186:52:10
2	news.task.gda.pl	16	30772	6509	23058	1205	21%	45:02:20
3	news.nask.pl	2	17452	3961	12869	622	22%	23:42:40
4	news.icm.edu.pl	45	236	8	215	13	3%	17:02:21
5	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 5		342	1122579	1080492	37025	5062	96%	272:39:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	392.3 GB	16.2 MB	31.4 MB	392.3 GB	99%	383.3 KB
2	news.nask.pl	16.1 MB	1.8 MB	1.9 MB	19.7 MB	81%	4.4 KB
3	news.task.gda.pl	14.3 MB	46.7 KB	3.7 MB	18.0 MB	79%	2.4 KB
4	news.icm.edu.pl	109.2 KB	0.0 KB	321.7 KB	430.8 KB	25%	20.5 KB
5	localhost	10.1 KB	0.0 KB	0.0 KB	10.1 KB	100%	2.0 KB
TOTAL: 5		392.3 GB	18.0 MB	37.3 MB	392.4 GB	99%	379.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 9 04:15:03 - 04:59:59	51794	4.8%	19.20	18.6 GB	4.7%	7214.10
Apr 9 05:00:00 - 05:59:59	62980	5.8%	17.49	22.8 GB	5.8%	6638.19
Apr 9 06:00:00 - 06:59:59	41488	3.8%	11.52	16.5 GB	4.2%	4805.08
Apr 9 07:00:00 - 07:59:59	40348	3.7%	11.21	15.0 GB	3.8%	4375.43
Apr 9 08:00:00 - 08:59:59	38930	3.6%	10.81	13.9 GB	3.5%	4044.51
Apr 9 09:00:00 - 09:59:59	41914	3.9%	11.64	16.4 GB	4.2%	4787.71
Apr 9 10:00:00 - 10:59:59	40117	3.7%	11.14	14.9 GB	3.8%	4334.02
Apr 9 11:00:00 - 11:59:59	36931	3.4%	10.26	13.9 GB	3.5%	4036.68
Apr 9 12:00:00 - 12:59:59	31145	2.9%	8.65	11.8 GB	3.0%	3437.65
Apr 9 13:00:00 - 13:59:59	32207	3.0%	8.95	11.5 GB	2.9%	3360.02
Apr 9 14:00:00 - 14:59:59	39361	3.6%	10.93	14.1 GB	3.6%	4105.05
Apr 9 15:00:00 - 15:59:59	40622	3.8%	11.28	14.1 GB	3.6%	4093.36
Apr 9 16:00:00 - 16:59:59	36943	3.4%	10.26	12.7 GB	3.2%	3713.55
Apr 9 17:00:00 - 17:59:59	41135	3.8%	11.43	15.1 GB	3.8%	4399.30
Apr 9 18:00:00 - 18:59:59	41291	3.8%	11.47	15.0 GB	3.8%	4372.48
Apr 9 19:00:00 - 19:59:59	39407	3.6%	10.95	12.9 GB	3.3%	3744.26
Apr 9 20:00:00 - 20:59:59	46777	4.3%	12.99	15.6 GB	4.0%	4535.97
Apr 9 21:00:00 - 21:59:59	24722	2.3%	6.87	8.2 GB	2.1%	2380.78
Apr 9 22:00:00 - 22:59:59	23661	2.2%	6.57	7.7 GB	2.0%	2242.63
Apr 9 23:00:00 - 23:59:59	38920	3.6%	10.81	13.8 GB	3.5%	4028.04
Apr 10 00:00:00 - 00:59:59	65477	6.1%	18.19	22.4 GB	5.7%	6531.80
Apr 10 01:00:00 - 01:59:59	70950	6.6%	19.71	25.4 GB	6.5%	7398.88
Apr 10 02:00:00 - 02:59:59	69236	6.4%	19.23	25.5 GB	6.5%	7428.88
Apr 10 03:00:00 - 03:59:59	68291	6.3%	18.97	27.6 GB	7.0%	8039.65
Apr 10 04:00:00 - 04:15:03	16691	1.5%	18.48	7.3 GB	1.8%	8422.36
TOTAL: 24:00:00	1081338	100.0%	12.52	392.6 GB	100.0%	4764.63

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3404	180	2558	0	666
2	news.task.gda.pl	1214	981	25	1	207
3	news.nask.pl	637	6	590	2	39
4	news.icm.edu.pl	13	0	0	0	13
TOTAL: 4		5268	1167	3173	3	925

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	109
mailing.freebsd.svn-ports-head	109
uk.railway	76
mozilla.dev.tree-management	45
mailing.freebsd.ports	39
mailing.freebsd.ports-bugs	39
mailing.database.pgsql-general	36
mailing.openbsd.source-changes	36
gmane.linux.alsa.devel	34
mailing.openbsd.misc	34
alt.windows7.general	33
fa.freebsd.cvs-all	32
mailing.unix.dovecot	30
mailing.freebsd.svn-src-all	28
mailing.unix.samba-technical	26
24hoursupport.helpdesk	24
mailing.gcc.gcc-cvs	23
it.comp.os.win.windows8	20
mailing.unix.samba	19
mozilla.dev.gaia	19
TOTAL: 80	1167

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

Groups	Count
pl.sci.historia	2
christnet.christnews	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	489
EMP (fsl)	154
EMP (md5)	38
Excessively crossposted test article	12
HTML post	6
Attached HTML file	3
Scoring filter (12)	1
Scoring filter (8)	1
TOTAL: 8	704

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	55176	10569	24161	3693	17	33	19%	23:55:41
2	panorama	40047	1980	36588	422	0	0	4%	24:07:45
3	poznan	11804	24	10332	12	0	0	0%	23:57:59
4	nask	23381	17	15624	0	0	0	0%	23:52:13
5	task	1811	14	946	2	0	0	0%	21:27:20
6	okapi	0	0	0	0	0	2341	0%	24:00:02
TOTAL: 6		132219	12604	87651	4129	17	2374	9%	141:21:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	47.9 MB	194.0 MB	241.9 MB	2.9 KB/s	17.4 KB	23:55:41
2	panorama	7.8 MB	1.9 MB	9.8 MB	0.1 KB/s	4.2 KB	24:07:45
3	poznan	101.7 KB	18.6 KB	120.3 KB	0.0 KB/s	3.3 KB	23:57:59
4	nask	72.5 KB	0.0 KB	72.5 KB	0.0 KB/s	4.3 KB	23:52:13
5	task	29.2 KB	4.0 KB	33.2 KB	0.0 KB/s	2.1 KB	21:27:20
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 6		55.9 MB	196.0 MB	251.9 MB	0.5 KB/s	15.4 KB	141:21:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	230	270	618.4 KB	230	0	00:00:11
2	web.man.lodz.pl	288	78	71.1 KB	35	0	00:00:25
3	router2.cbmm.lodz.pl	1	11	18.7 KB	2	0	00:01:32
4	ip-176.105.135.22.tvsat364.lodz.pl	7	6	11.1 KB	1	0	00:42:14
5	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 5		531	365	719.2 KB	268	5	03:03:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	230	270	618.4 KB	230	0	00:00:11
2	*.man.lodz.pl	677	78	71.1 KB	35	5	00:00:31
3	*.cbmm.lodz.pl	1	11	18.7 KB	2	0	00:01:32
4	*.105.135.22.tvsat364.lodz.pl	7	6	11.1 KB	1	0	00:42:14
5	*.pa.nsw.optusnet.com.au	107	0	0.0 KB	0	0	00:18:40
6	*.geo.uni.lodz.pl	1	0	0.0 KB	0	0	00:30:00
7	*.neoplus.adsl.tpnet.pl	4	0	0.0 KB	0	0	00:09:16
8	*.206.15.62.static.jazztel.es	2	0	0.0 KB	0	0	01:21:04
9	*.toya.net.pl	98	0	0.0 KB	0	0	00:00:06
TOTAL: 9		1127	365	719.2 KB	268	5	03:03:38

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
130.206.15.62.static.jazztel.es	1.056	0.828	01:21:04
ip-176.105.135.22.tvsat364.lodz.pl	0.024	0.056	00:42:14
pc225.geo.uni.lodz.pl	0.004	0.012	00:30:00
pa49-181-247-44.pa.nsw.optusnet.com.au	0.240	1.052	00:18:40
abeg107.neoplus.adsl.tpnet.pl	0.128	0.044	00:05:46
ecb108.neoplus.adsl.tpnet.pl	0.004	0.008	00:02:20
router2.cbmm.lodz.pl	0.004	0.016	00:01:32
bxn225.neoplus.adsl.tpnet.pl	0.028	0.016	00:01:09
web.man.lodz.pl	0.624	2.876	00:00:25
vegas.cm.p.lodz.pl	0.568	2.104	00:00:11
staticline41435.toya.net.pl	0.256	0.832	00:00:06
mon.man.lodz.pl	0.576	2.620	00:00:04
david.man.lodz.pl	0.240	0.788	00:00:01
isvcs01.man.lodz.pl	0.016	0.068	00:00:00
TOTAL: 14	3.768	11.320	03:03:38

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
pa49-181-247-44.pa.nsw.optusnet.com.au	107
staticline41435.toya.net.pl	98
david.man.lodz.pl	96
abeg107.neoplus.adsl.tpnet.pl	2
130.206.15.62.static.jazztel.es	2
ecb108.neoplus.adsl.tpnet.pl	1
bxn225.neoplus.adsl.tpnet.pl	1
pc225.geo.uni.lodz.pl	1
TOTAL: 9	596

NNRP client timeouts [Top 20]:

System	Conn	Peer
pa49-181-247-44.pa.nsw.optusnet.com.au	2	0
pc225.geo.uni.lodz.pl	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 3	4	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	270	74.0%
2	pl	95	26.0%
TOTAL: 2		365	100.0%

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

Newsgroup		Count
1	lodman.info	270
2	pl.comp.os.ms-windows.winnt	40
3	pl.comp.pecet	38
4	pl.sci.chemia	10
5	pl.soc.prawo	6
6	pl.regionalne.lodz	1
TOTAL: 6		365

Daily Usenet report

Apr 9 04:15:03 -- Apr 10 04:15:03