Daily Usenet report: Feb 14 04:15:03

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Feb 14 07:32:06 newsfeed nnrpd[1848]: SERVER perl filter not defined
Feb 14 07:37:32 newsfeed nnrpd[1938]: SERVER perl filter not defined
Feb 14 10:15:00 newsfeed nnrpd[7160]: SERVER perl filter not defined
Feb 14 10:54:22 newsfeed nnrpd[8436]: SERVER perl filter not defined
Feb 14 12:35:45 newsfeed nnrpd[11719]: SERVER perl filter not defined
Feb 14 16:05:32 newsfeed nnrpd[18644]: SERVER perl filter not defined
Feb 14 19:34:09 newsfeed nnrpd[25436]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1314886	97.6%	150.5 MB	97.2%
innd	13395	1.0%	2.2 MB	1.4%
nnrpd	11284	0.8%	1.2 MB	0.8%
innfeed	7046	0.5%	1.1 MB	0.7%
TOTAL: 4	1346611	100.0%	154.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1307648	94.4%
Positive hits	42305	3.1%
Negative hits	35567	2.6%
Cache misses	232	0.0%
TOTAL: 4	1385752	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.025	0.0%	310	0.000	29.113	521.000
article cleanup	00:00:21.435	0.0%	1313005	0.004	0.016	0.034
article logging	00:00:38.976	0.0%	1313183	0.012	0.030	0.236
article parse	00:52:24.300	3.6%	151408861	0.008	0.021	0.051
article write	00:11:27.094	0.8%	1305466	0.190	0.526	1.889
artlog/artcncl	00:00:00.004	0.0%	310	0.000	0.013	1.000
artlog/artparse	00:00:00.000	0.0%	14	0.000	0.000	0.000
data move	00:03:13.401	0.2%	160246099	0.000	0.001	0.056
hisgrep/artcncl	00:00:00.933	0.0%	262	0.000	3.561	90.000
hishave/artcncl	00:00:00.939	0.0%	310	0.000	3.029	148.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:08:47.706	8.9%	1385912	0.010	5.576	17.301
history sync	00:00:00.009	0.0%	291	0.000	0.031	2.000
history write	02:58:14.388	12.4%	1308003	0.052	8.176	30.357
hiswrite/artcncl	00:00:00.645	0.0%	48	0.000	13.438	196.000
idle	12:45:48.829	53.2%	121230892	0.237	0.379	6.494
nntp read	00:56:46.841	3.9%	150458521	0.010	0.023	0.050
overview write	00:00:08.725	0.0%	1305466	0.000	0.007	0.020
perl filter	03:14:07.373	13.5%	1307989	6.427	8.905	13.681
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:51.480	0.2%	2648592	0.036	0.065	0.096
TOTAL: 23:59:21.778	23:15:02.103	96.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.146	0.0%	37675	0.000	0.004	0.100
article prepare	00:00:00.010	0.0%	39182	0.000	0.000	0.125
article read	00:00:01.746	0.0%	9663	0.000	0.181	60.333
backlog stats	00:00:00.212	0.0%	294911	0.000	0.001	0.016
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.020	0.0%	176699	0.000	0.011	0.121
data write	00:00:04.287	0.0%	145467	0.000	0.029	0.165
idle	23:59:20.544	100.0%	294911	0.000	292.836	21972.000
status file	00:00:00.938	0.0%	223	0.000	4.206	220.500
TOTAL: 23:59:53.156	23:59:29.903	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	55:06:13.149	100.0%	7419	0.000	26738.529	600060.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.371	0.0%	17222	0.000	0.022	1.000
readart	00:00:00.391	0.0%	484	0.000	0.808	31.000
TOTAL: 55:07:01.848	55:06:13.911	100.0%	-	-	-	-

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	601	1301563	1297056	370	4137	99%	217:51:16
2	news.task.gda.pl	10	31119	6401	23244	1474	20%	46:49:53
3	news.nask.pl	3	18834	3099	13831	1904	16%	23:31:35
4	news.icm.edu.pl	40	323	11	269	43	3%	19:16:52
5	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 5		662	1351846	1306574	37714	7558	96%	307:29:36

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	429.6 GB	290.6 MB	356.9 MB	430.2 GB	99%	346.7 KB
2	news.nask.pl	15.7 MB	5.0 MB	5.0 MB	25.7 MB	61%	5.3 KB
3	news.task.gda.pl	14.1 MB	57.9 KB	4.2 MB	18.4 MB	76%	2.4 KB
4	news.icm.edu.pl	480.1 KB	8.3 KB	2.5 MB	3.0 MB	15%	57.3 KB
5	localhost	10.4 KB	0.0 KB	0.0 KB	10.4 KB	100%	1.5 KB
TOTAL: 5		429.6 GB	295.7 MB	368.6 MB	430.3 GB	99%	343.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 14 04:15:03 - 04:59:59	33979	2.6%	12.60	12.4 GB	2.9%	4820.33
Feb 14 05:00:00 - 05:59:59	42433	3.2%	11.79	15.6 GB	3.6%	4557.03
Feb 14 06:00:00 - 06:59:59	40736	3.1%	11.32	15.3 GB	3.6%	4441.99
Feb 14 07:00:00 - 07:59:59	48139	3.7%	13.37	17.2 GB	4.0%	5014.81
Feb 14 08:00:00 - 08:59:59	46984	3.6%	13.05	16.2 GB	3.8%	4718.31
Feb 14 09:00:00 - 09:59:59	49404	3.8%	13.72	17.5 GB	4.1%	5092.13
Feb 14 10:00:00 - 10:59:59	47902	3.7%	13.31	16.5 GB	3.8%	4801.15
Feb 14 11:00:00 - 11:59:59	48188	3.7%	13.39	17.3 GB	4.0%	5047.11
Feb 14 12:00:00 - 12:59:59	44867	3.4%	12.46	15.3 GB	3.6%	4466.01
Feb 14 13:00:00 - 13:59:59	44488	3.4%	12.36	15.2 GB	3.5%	4434.51
Feb 14 14:00:00 - 14:59:59	48000	3.7%	13.33	16.1 GB	3.8%	4695.96
Feb 14 15:00:00 - 15:59:59	48621	3.7%	13.51	16.3 GB	3.8%	4744.88
Feb 14 16:00:00 - 16:59:59	45083	3.4%	12.52	15.0 GB	3.5%	4380.43
Feb 14 17:00:00 - 17:59:59	48140	3.7%	13.37	16.2 GB	3.8%	4724.28
Feb 14 18:00:00 - 18:59:59	47637	3.6%	13.23	14.7 GB	3.4%	4282.58
Feb 14 19:00:00 - 19:59:59	52910	4.0%	14.70	16.7 GB	3.9%	4875.39
Feb 14 20:00:00 - 20:59:59	43958	3.4%	12.21	14.3 GB	3.3%	4176.22
Feb 14 21:00:00 - 21:59:59	38998	3.0%	10.83	12.5 GB	2.9%	3634.09
Feb 14 22:00:00 - 22:59:59	38483	2.9%	10.69	12.6 GB	2.9%	3656.13
Feb 14 23:00:00 - 23:59:59	44984	3.4%	12.50	15.4 GB	3.6%	4488.19
Feb 15 00:00:00 - 00:59:59	70927	5.4%	19.70	22.0 GB	5.1%	6396.92
Feb 15 01:00:00 - 01:59:59	97542	7.5%	27.09	29.3 GB	6.8%	8536.06
Feb 15 02:00:00 - 02:59:59	105897	8.1%	29.42	32.1 GB	7.5%	9335.37
Feb 15 03:00:00 - 03:59:59	100857	7.7%	28.02	29.4 GB	6.8%	8556.00
Feb 15 04:00:00 - 04:15:02	27688	2.1%	30.70	8.4 GB	2.0%	9797.89
TOTAL: 23:59:59	1306845	100.0%	15.13	429.6 GB	100.0%	5213.46

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4297	267	3078	2	950
2	news.nask.pl	1944	8	1902	10	24
3	news.task.gda.pl	1447	1228	35	0	184
4	news.icm.edu.pl	43	0	1	0	42
TOTAL: 4		7731	1503	5016	12	1200

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	157
mailing.freebsd.svn-ports-head	156
uk.railway	134
mailing.freebsd.ports-bugs	96
alt.windows7.general	51
mailing.openbsd.source-changes	51
mailing.unix.samba	46
mailing.freebsd.svn-src-all	45
fa.freebsd.cvs-all	45
mailing.unix.dovecot	43
alt.politics.scorched-earth	42
it.tlc.cellulari.android	39
mailing.freebsd.ports	38
24hoursupport.helpdesk	38
mailing.freebsd.svn-src-head	35
mozilla.dev.gaia	34
mailing.unix.samba-technical	32
it.comp.os.win.windows7	30
mozilla.dev.tree-management	30
mailing.gcc.gcc-cvs	23
TOTAL: 73	1503

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

Groups	Count
pl.sci.historia	9
pl.sci.matematyka	2
bit.listserv.catholic	1
TOTAL: 3	12

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	644
EMP (fsl)	164
Attached HTML file	147
EMP (md5)	51
HTML post	1
Scoring filter (12)	1
TOTAL: 6	1008

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	59065	5782	29322	2306	17	2	9%	23:56:18
2	panorama	39109	1364	36091	213	0	0	3%	23:58:46
3	nask	26133	49	16561	1	0	0	0%	23:59:21
4	poznan	10316	35	9227	12	0	0	0%	23:56:17
5	task	2148	21	1124	3	0	5	0%	22:00:51
6	okapi	0	0	0	0	0	2722	0%	24:00:02
TOTAL: 6		136771	7251	92325	2535	17	2729	5%	141:51:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	139.6 MB	104.9 MB	244.4 MB	2.9 KB/s	30.9 KB	23:56:18
2	panorama	5.6 MB	1.1 MB	6.6 MB	0.1 KB/s	4.3 KB	23:58:46
3	poznan	243.2 KB	24.3 KB	267.5 KB	0.0 KB/s	5.7 KB	23:56:17
4	nask	163.9 KB	178.4 KB	342.3 KB	0.0 KB/s	6.8 KB	23:59:21
5	task	52.0 KB	4.3 KB	56.2 KB	0.0 KB/s	2.3 KB	22:00:51
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 6		145.6 MB	106.1 MB	251.7 MB	0.5 KB/s	26.3 KB	141:51:35

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	360	540.0 KB	288	0	00:00:13
2	web.man.lodz.pl	288	90	187.3 KB	40	0	00:00:22
3	212.191.78.190	320	20	41.3 KB	12	1	48:40:22
4	ip-176.105.135.22.tvsat364.lodz.pl	15	12	20.5 KB	2	0	06:03:12
5	router2.cbmm.lodz.pl	4	2	80.9 KB	1	0	00:01:20
6	kujawiak.man.lodz.pl	6	0	0.0 KB	0	6	00:00:01
TOTAL: 6		921	484	869.9 KB	343	7	55:06:59

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	360	540.0 KB	288	0	00:00:13
2	*.man.lodz.pl	678	90	187.3 KB	40	6	00:00:33
3	unresolved	324	20	41.3 KB	12	1	48:40:42
4	*.105.135.22.tvsat364.lodz.pl	15	12	20.5 KB	2	0	06:03:12
5	*.cbmm.lodz.pl	4	2	80.9 KB	1	0	00:01:20
6	*.pa.nsw.optusnet.com.au	201	0	0.0 KB	0	0	00:08:36
7	*.wroclaw.mm.pl	2	0	0.0 KB	0	0	00:08:25
8	*.neoplus.adsl.tpnet.pl	2	0	0.0 KB	0	0	00:03:33
9	*.toya.net.pl	81	0	0.0 KB	0	0	00:00:21
TOTAL: 9		1595	484	869.9 KB	343	7	55:06:59

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.780	3.324	48:40:22
ip-176.105.135.22.tvsat364.lodz.pl	0.060	0.132	06:03:12
pa49-181-247-15.pa.nsw.optusnet.com.au	0.500	1.900	00:08:36
host-89-231-50-15.wroclaw.mm.pl	0.004	0.020	00:08:25
ebx107.neoplus.adsl.tpnet.pl	0.004	0.020	00:03:33
router2.cbmm.lodz.pl	0.000	0.052	00:01:20
web.man.lodz.pl	0.640	2.956	00:00:22
staticline41435.toya.net.pl	0.220	0.820	00:00:21
212.51.203.199	0.008	0.040	00:00:20
vegas.cm.p.lodz.pl	0.612	3.024	00:00:13
mon.man.lodz.pl	0.592	3.004	00:00:08
david.man.lodz.pl	0.212	0.988	00:00:01
kujawiak.man.lodz.pl	0.036	0.072	00:00:01
TOTAL: 13	3.668	16.352	55:06:59

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
pa49-181-247-15.pa.nsw.optusnet.com.au	201
david.man.lodz.pl	96
staticline41435.toya.net.pl	81
212.51.203.199	4
ebx107.neoplus.adsl.tpnet.pl	2
host-89-231-50-15.wroclaw.mm.pl	2
TOTAL: 7	674

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip-176.105.135.22.tvsat364.lodz.pl	6	0
212.191.78.190	3	11
pa49-181-247-15.pa.nsw.optusnet.com.au	1	1
TOTAL: 3	10	12

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	360	74.4%
2	pl	124	25.6%
TOTAL: 2		484	100.0%

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

Newsgroup		Count
1	lodman.info	360
2	pl.comp.pecet	48
3	pl.comp.os.ms-windows.winnt	42
4	pl.soc.prawo	17
5	pl.comp.os.linux	8
6	pl.misc.kolej	4
7	pl.sci.chemia	2
8	pl.rec.rowery	2
9	pl.rec.gory	1
TOTAL: 9		484

Daily Usenet report

Feb 14 04:15:03 -- Feb 15 04:15:02