Daily Usenet report: Mar 6 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Mar 6 09:25:32 newsfeed nnrpd[13035]: SERVER perl filter not defined
Mar 6 09:48:25 newsfeed nnrpd[13700]: SERVER perl filter not defined
Mar 6 13:57:46 newsfeed nnrpd[21748]: SERVER perl filter not defined
Mar 6 13:58:33 newsfeed nnrpd[21749]: SERVER perl filter not defined
Mar 7 00:12:38 newsfeed nnrpd[9123]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1575738	98.1%	181.6 MB	97.6%
innd	17150	1.1%	2.8 MB	1.5%
nnrpd	7180	0.4%	740.8 KB	0.4%
innfeed	6839	0.4%	1.0 MB	0.5%
TOTAL: 4	1606907	100.0%	186.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1567441	93.9%
Negative hits	55218	3.3%
Positive hits	46475	2.8%
Cache misses	937	0.1%
TOTAL: 4	1670071	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:12.715	0.0%	347	0.000	36.643	1127.000
article cleanup	00:00:30.159	0.0%	1576130	0.007	0.019	0.043
article logging	00:01:03.088	0.1%	1576359	0.015	0.040	0.590
article parse	01:02:12.717	4.3%	94769986	0.010	0.039	0.088
article write	00:18:50.042	1.3%	1564063	0.342	0.723	2.163
artlog/artcncl	00:00:00.011	0.0%	334	0.000	0.033	1.000
artlog/artparse	00:00:00.000	0.0%	5	0.000	0.000	0.000
data move	00:02:22.637	0.2%	104131848	0.000	0.001	0.004
hisgrep/artcncl	00:00:02.327	0.0%	286	0.000	8.136	201.000
hishave/artcncl	00:00:01.611	0.0%	347	0.000	4.643	115.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:53:17.826	12.0%	1671335	1.391	6.221	11.876
history sync	00:00:00.017	0.0%	292	0.000	0.058	1.000
history write	03:58:36.896	16.6%	1568833	4.782	9.126	23.200
hiswrite/artcncl	00:00:00.879	0.0%	61	0.000	14.410	104.667
idle	10:16:36.834	42.8%	57034225	0.223	0.649	1.181
nntp read	00:49:11.559	3.4%	93510146	0.013	0.032	0.046
overview write	00:00:11.848	0.0%	1564063	0.000	0.008	0.022
perl filter	03:59:53.074	16.7%	1568828	5.880	9.174	11.459
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:04.165	0.3%	3182995	0.009	0.077	0.112
TOTAL: 24:00:39.130	23:27:08.405	97.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.231	0.0%	55050	0.000	0.004	0.100
article prepare	00:00:00.040	0.0%	111062	0.000	0.000	0.042
article read	00:00:15.742	0.0%	27235	0.000	0.578	46.552
backlog stats	00:00:00.442	0.0%	424437	0.000	0.001	0.012
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:03.258	0.0%	232084	0.000	0.014	1.000
data write	00:00:18.620	0.0%	227890	0.000	0.082	43.000
idle	23:59:08.666	99.9%	424437	0.000	203.443	21100.000
status file	00:00:01.385	0.0%	237	0.000	5.844	238.500
TOTAL: 23:59:59.104	23:59:48.384	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:08:50.827	99.5%	8161	0.000	947.289	600058.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.402	0.0%	18132	0.000	0.022	5.333
readart	00:00:01.506	0.0%	420	0.000	3.586	250.000
TOTAL: 02:09:32.120	02:08:52.735	99.5%	-	-	-	-

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	616	1564660	1553625	1282	9753	99%	360:53:41
2	news.task.gda.pl	16	32760	6232	25141	1387	19%	45:56:42
3	news.nask.pl	3	20060	5539	13574	947	27%	24:01:03
4	news.icm.edu.pl	40	538	7	480	51	1%	25:53:58
5	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 5		681	1618023	1565408	40477	12138	96%	456:45:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	504.3 GB	1.2 GB	1.6 GB	507.0 GB	99%	340.1 KB
2	news.nask.pl	48.2 MB	3.4 MB	3.4 MB	55.0 MB	87%	8.7 KB
3	news.task.gda.pl	13.7 MB	72.1 KB	4.1 MB	17.9 MB	76%	2.4 KB
4	news.icm.edu.pl	152.8 KB	8.6 KB	1022.3 KB	1.2 MB	12%	20.4 KB
5	localhost	8.4 KB	0.0 KB	0.0 KB	8.4 KB	100%	1.7 KB
TOTAL: 5		504.3 GB	1.2 GB	1.6 GB	507.1 GB	99%	337.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 6 04:15:02 - 04:59:59	64156	4.1%	23.78	21.2 GB	4.2%	8254.20
Mar 6 05:00:00 - 05:59:59	89737	5.7%	24.93	29.9 GB	5.9%	8718.00
Mar 6 06:00:00 - 06:59:59	92604	5.9%	25.72	31.2 GB	6.2%	9076.43
Mar 6 07:00:00 - 07:59:59	86814	5.6%	24.11	29.6 GB	5.9%	8608.52
Mar 6 08:00:00 - 08:59:59	100186	6.4%	27.83	30.8 GB	6.1%	8968.55
Mar 6 09:00:00 - 09:59:59	95113	6.1%	26.42	30.5 GB	6.1%	8874.14
Mar 6 10:00:00 - 10:59:59	64716	4.1%	17.98	21.4 GB	4.3%	6244.08
Mar 6 11:00:00 - 11:59:59	45018	2.9%	12.51	14.1 GB	2.8%	4115.64
Mar 6 12:00:00 - 12:59:59	74200	4.7%	20.61	17.8 GB	3.5%	5180.37
Mar 6 13:00:00 - 13:59:59	44579	2.9%	12.38	14.4 GB	2.9%	4195.33
Mar 6 14:00:00 - 14:59:59	44699	2.9%	12.42	14.8 GB	2.9%	4320.06
Mar 6 15:00:00 - 15:59:59	47229	3.0%	13.12	15.3 GB	3.0%	4452.13
Mar 6 16:00:00 - 16:59:59	50113	3.2%	13.92	16.7 GB	3.3%	4852.86
Mar 6 17:00:00 - 17:59:59	47084	3.0%	13.08	15.6 GB	3.1%	4548.40
Mar 6 18:00:00 - 18:59:59	47209	3.0%	13.11	15.2 GB	3.0%	4420.10
Mar 6 19:00:00 - 19:59:59	45318	2.9%	12.59	14.0 GB	2.8%	4075.46
Mar 6 20:00:00 - 20:59:59	37585	2.4%	10.44	11.4 GB	2.3%	3329.32
Mar 6 21:00:00 - 21:59:59	29076	1.9%	8.08	8.6 GB	1.7%	2513.67
Mar 6 22:00:00 - 22:59:59	39361	2.5%	10.93	12.7 GB	2.5%	3697.26
Mar 6 23:00:00 - 23:59:59	50163	3.2%	13.93	16.5 GB	3.3%	4812.29
Mar 7 00:00:00 - 00:59:59	68840	4.4%	19.12	23.3 GB	4.6%	6791.37
Mar 7 01:00:00 - 01:59:59	86407	5.5%	24.00	29.1 GB	5.8%	8484.16
Mar 7 02:00:00 - 02:59:59	93977	6.0%	26.10	31.5 GB	6.3%	9182.73
Mar 7 03:00:00 - 03:59:59	91972	5.9%	25.55	29.5 GB	5.9%	8590.69
Mar 7 04:00:00 - 04:15:04	26984	1.7%	29.85	8.3 GB	1.7%	9684.40
TOTAL: 24:00:02	1563140	100.0%	18.09	503.5 GB	100.0%	6111.09

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	9885	177	6326	3	3379
2	news.task.gda.pl	1369	1107	40	5	217
3	news.nask.pl	977	7	934	7	29
4	news.icm.edu.pl	33	0	1	0	32
TOTAL: 4		12264	1291	7301	15	3657

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	173
mailing.freebsd.svn-ports-head	163
uk.railway	101
mailing.freebsd.svn-src-all	65
mailing.freebsd.ports-bugs	63
fa.freebsd.cvs-all	61
alt.windows7.general	53
mozilla.dev.tree-management	49
mailing.unix.samba	38
mailing.freebsd.svn-src-head	35
mailing.openbsd.misc	32
mailing.gcc.gcc-cvs	30
mailing.openbsd.source-changes	29
alt.politics.scorched-earth	25
gmane.linux.alsa.devel	23
mailing.database.pgsql-general	23
mailing.unix.dovecot	22
mozilla.dev.gaia	21
mailing.freebsd.current	20
mailing.postfix.users	18
TOTAL: 74	1291

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

Groups	Count
pl.sci.historia	10
fr.comp.lang.php	3
fr.comp.applications.libres	2
TOTAL: 3	15

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	3181
EMP (fsl)	162
EMP (md5)	38
EMP (phl)	33
HTML post	8
Scoring filter (12)	1
TOTAL: 6	3423

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	66704	10861	28799	14477	5	188	16%	24:05:26
2	panorama	55916	1981	52697	323	0	0	3%	24:08:48
3	poznan	13115	43	11203	21	0	0	0%	24:01:34
4	task	2689	16	1435	7	0	0	0%	23:00:10
5	nask	23116	11	15839	0	0	0	0%	24:05:30
6	okapi	0	0	0	0	0	3064	0%	24:00:00
TOTAL: 6		161540	12912	109973	14828	5	3252	7%	143:21:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	508.6 MB	3.6 GB	4.1 GB	50.1 KB/s	171.4 KB	24:05:26
2	panorama	12.3 MB	2.5 MB	14.8 MB	0.2 KB/s	6.6 KB	24:08:48
3	poznan	482.7 KB	42.5 KB	525.2 KB	0.0 KB/s	8.2 KB	24:01:34
4	task	37.0 KB	18.8 KB	55.8 KB	0.0 KB/s	2.4 KB	23:00:10
5	nask	36.7 KB	0.0 KB	36.7 KB	0.0 KB/s	3.3 KB	24:05:30
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		521.4 MB	3.6 GB	4.2 GB	8.4 KB/s	157.2 KB	143:21:28

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	vegas.cm.p.lodz.pl	288	338	522.4 KB	288	0	00:00:19
2	web.man.lodz.pl	288	82	76.7 KB	34	0	00:00:32
3	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:01
TOTAL: 3		581	420	599.1 KB	322	5	02:09:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	338	522.4 KB	288	0	00:00:19
2	*.man.lodz.pl	677	82	76.7 KB	34	5	00:00:43
3	*.hsi8.kabel-badenwuerttemberg.de	1	0	0.0 KB	0	0	00:00:10
4	*.cbmm.lodz.pl	1	0	0.0 KB	0	0	00:00:20
5	unresolved	2	0	0.0 KB	0	0	00:00:10
6	*.wroclaw.mm.pl	2	0	0.0 KB	0	0	00:10:19
7	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	00:02:05
8	*.181.14.62.static.jazztel.es	6	0	0.0 KB	0	0	00:08:12
9	*.105.135.22.tvsat364.lodz.pl	6	0	0.0 KB	0	0	01:45:08
10	*.toya.net.pl	64	0	0.0 KB	0	0	00:02:00
TOTAL: 10		1048	420	599.1 KB	322	5	02:09:31

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ip-176.105.135.22.tvsat364.lodz.pl	0.016	0.100	01:45:08
host-89-231-50-15.wroclaw.mm.pl	0.004	0.036	00:10:19
113.181.14.62.static.jazztel.es	0.272	0.408	00:08:12
ebx198.neoplus.adsl.tpnet.pl	0.000	0.016	00:02:05
staticline41435.toya.net.pl	0.188	0.984	00:02:00
web.man.lodz.pl	0.688	4.884	00:00:32
router2.cbmm.lodz.pl	0.000	0.020	00:00:20
vegas.cm.p.lodz.pl	0.732	4.360	00:00:19
212.51.203.199	0.004	0.036	00:00:10
hsi-kbw-046-005-234-103.hsi8.kabel-badenwuerttemberg.de	0.004	0.016	00:00:10
mon.man.lodz.pl	0.620	3.952	00:00:07
david.man.lodz.pl	0.168	1.500	00:00:01
isvcs01.man.lodz.pl	0.036	0.088	00:00:01
TOTAL: 13	2.732	16.400	02:09:31

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	64
ip-176.105.135.22.tvsat364.lodz.pl	6
113.181.14.62.static.jazztel.es	6
212.51.203.199	2
host-89-231-50-15.wroclaw.mm.pl	2
hsi-kbw-046-005-234-103.hsi8.kabel-badenwuerttemberg.de	1
ebx198.neoplus.adsl.tpnet.pl	1
router2.cbmm.lodz.pl	1
TOTAL: 10	467

NNRP client timeouts [Top 20]:

System	Conn	Peer
113.181.14.62.static.jazztel.es	1	1
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 2	2	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	338	80.5%
2	pl	82	19.5%
TOTAL: 2		420	100.0%

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

Newsgroup		Count
1	lodman.info	338
2	pl.comp.pecet	72
3	pl.comp.os.ms-windows.winnt	8
4	pl.internet.polip	2
TOTAL: 4		420

Daily Usenet report

Mar 6 04:15:02 -- Mar 7 04:15:04