Daily Usenet report: Jun 11 04:15:06

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Jun 11 09:37:35 newsfeed nnrpd[17345]: SERVER perl filter not defined
Jun 11 10:19:34 newsfeed nnrpd[18772]: SERVER perl filter not defined
Jun 11 10:19:46 newsfeed nnrpd[18773]: SERVER perl filter not defined
Jun 11 10:19:59 newsfeed nnrpd[18781]: SERVER perl filter not defined
Jun 11 11:03:52 newsfeed nnrpd[20133]: SERVER perl filter not defined
Jun 11 12:47:21 newsfeed nnrpd[23279]: SERVER perl filter not defined
Jun 11 17:53:53 newsfeed nnrpd[650]: SERVER perl filter not defined
Jun 11 18:00:58 newsfeed nnrpd[973]: SERVER perl filter not defined
Jun 11 18:04:19 newsfeed nnrpd[999]: SERVER perl filter not defined
Jun 11 22:43:28 newsfeed nnrpd[9823]: SERVER perl filter not defined
Jun 11 23:14:12 newsfeed nnrpd[10865]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2568479	98.6%	288.7 MB	98.2%
innd	18323	0.7%	3.1 MB	1.1%
nnrpd	10492	0.4%	1.1 MB	0.4%
innfeed	7132	0.3%	1.1 MB	0.4%
TOTAL: 4	2604426	100.0%	293.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2560604	94.3%
Negative hits	91442	3.4%
Positive hits	44675	1.6%
Cache misses	17966	0.7%
TOTAL: 4	2714687	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:17.506	0.0%	402	0.000	43.547	568.000
article cleanup	00:00:35.350	0.0%	2567048	0.003	0.014	0.628
article logging	00:01:32.907	0.1%	2567279	0.015	0.036	1.115
article parse	01:16:07.160	5.3%	63691970	0.031	0.072	0.172
article write	00:29:29.227	2.0%	2559999	0.382	0.691	4.632
artlog/artcncl	00:00:00.007	0.0%	380	0.000	0.018	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:48.025	0.2%	76963554	0.001	0.002	0.046
hisgrep/artcncl	00:00:04.629	0.0%	322	0.000	14.376	313.000
hishave/artcncl	00:00:01.901	0.0%	402	0.000	4.729	71.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	05:07:49.595	21.4%	2715630	0.109	6.801	33.584
history sync	00:00:00.027	0.0%	292	0.000	0.092	23.000
history write	06:38:10.578	27.7%	2561587	0.050	9.326	50.125
hiswrite/artcncl	00:00:00.844	0.0%	80	0.000	10.550	107.000
idle	02:34:13.459	10.7%	20996145	0.121	0.441	7.188
nntp read	00:37:28.969	2.6%	61471367	0.017	0.037	0.123
overview write	00:00:17.488	0.0%	2559999	0.001	0.007	0.164
perl filter	06:43:53.794	28.1%	2561575	5.841	9.461	20.698
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:08:14.767	0.6%	5169755	0.012	0.096	0.825
TOTAL: 23:59:29.142	23:41:06.233	98.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.227	0.0%	50913	0.000	0.004	0.250
article prepare	00:00:00.012	0.0%	55308	0.000	0.000	0.083
article read	00:00:16.545	0.0%	13411	0.000	1.234	33.267
backlog stats	00:00:00.292	0.0%	339286	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.928	0.0%	208654	0.000	0.014	0.551
data write	00:00:08.974	0.0%	174924	0.000	0.051	8.879
idle	23:58:24.455	99.9%	339286	0.000	254.371	18182.000
status file	00:00:06.102	0.0%	227	0.667	26.881	291.000
TOTAL: 23:59:11.725	23:58:59.535	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	50:16:17.481	100.0%	6899	0.000	26232.422	450228.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.769	0.0%	16430	0.000	0.108	62.889
readart	00:00:06.184	0.0%	678	0.000	9.121	542.000
TOTAL: 50:17:09.337	50:16:25.434	100.0%	-	-	-	-

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	344	2572890	2547544	20237	5109	99%	538:28:41
2	news.nask.pl	3	18988	7666	9936	1386	40%	24:22:04
3	news.task.gda.pl	14	34717	5886	28237	594	16%	47:23:16
4	localhost	12	11	11	0	0	100%	00:00:01
5	news.icm.edu.pl	46	290	3	270	17	1%	19:19:31
TOTAL: 5		419	2626896	2561110	58680	7106	97%	629:33:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	814.7 GB	18.0 MB	39.2 MB	814.7 GB	99%	334.7 KB
2	news.nask.pl	26.4 MB	3.9 MB	5.3 MB	35.5 MB	74%	4.0 KB
3	news.task.gda.pl	13.1 MB	229.5 KB	1.5 MB	14.9 MB	88%	2.3 KB
4	news.icm.edu.pl	78.0 KB	45.6 KB	222.8 KB	346.4 KB	22%	17.3 KB
5	localhost	19.9 KB	0.0 KB	0.0 KB	19.9 KB	100%	1.8 KB
TOTAL: 5		814.7 GB	22.1 MB	46.2 MB	814.8 GB	99%	332.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 11 04:15:06 - 04:59:59	49962	2.0%	18.55	16.1 GB	2.0%	6283.75
Jun 11 05:00:00 - 05:59:59	90329	3.5%	25.09	28.8 GB	3.5%	8375.47
Jun 11 06:00:00 - 06:59:59	89135	3.5%	24.76	28.6 GB	3.5%	8318.59
Jun 11 07:00:00 - 07:59:59	101571	4.0%	28.21	32.2 GB	4.0%	9381.25
Jun 11 08:00:00 - 08:59:59	91440	3.6%	25.40	29.6 GB	3.6%	8615.95
Jun 11 09:00:00 - 09:59:59	97941	3.8%	27.21	32.7 GB	4.0%	9528.07
Jun 11 10:00:00 - 10:59:59	111846	4.4%	31.07	37.6 GB	4.6%	10945.12
Jun 11 11:00:00 - 11:59:59	117255	4.6%	32.57	38.3 GB	4.7%	11168.06
Jun 11 12:00:00 - 12:59:59	116523	4.6%	32.37	39.3 GB	4.8%	11440.63
Jun 11 13:00:00 - 13:59:59	119047	4.6%	33.07	32.9 GB	4.0%	9595.22
Jun 11 14:00:00 - 14:59:59	126785	5.0%	35.22	37.0 GB	4.5%	10777.72
Jun 11 15:00:00 - 15:59:59	100168	3.9%	27.82	36.0 GB	4.4%	10479.28
Jun 11 16:00:00 - 16:59:59	114949	4.5%	31.93	40.3 GB	4.9%	11740.20
Jun 11 17:00:00 - 17:59:59	105081	4.1%	29.19	36.9 GB	4.5%	10738.68
Jun 11 18:00:00 - 18:59:59	127192	5.0%	35.33	37.5 GB	4.6%	10933.91
Jun 11 19:00:00 - 19:59:59	115373	4.5%	32.05	37.3 GB	4.6%	10875.04
Jun 11 20:00:00 - 20:59:59	116677	4.6%	32.41	38.4 GB	4.7%	11182.32
Jun 11 21:00:00 - 21:59:59	113122	4.4%	31.42	33.9 GB	4.2%	9868.20
Jun 11 22:00:00 - 22:59:59	94062	3.7%	26.13	30.6 GB	3.8%	8912.31
Jun 11 23:00:00 - 23:59:59	107081	4.2%	29.74	33.8 GB	4.1%	9845.92
Jun 12 00:00:00 - 00:59:59	93858	3.7%	26.07	31.2 GB	3.8%	9077.52
Jun 12 01:00:00 - 01:59:59	104564	4.1%	29.05	32.0 GB	3.9%	9308.31
Jun 12 02:00:00 - 02:59:59	113827	4.4%	31.62	33.6 GB	4.1%	9796.53
Jun 12 03:00:00 - 03:59:59	113640	4.4%	31.57	31.9 GB	3.9%	9287.67
Jun 12 04:00:00 - 04:15:04	29388	1.1%	32.51	8.3 GB	1.0%	9642.86
TOTAL: 23:59:58	2560816	100.0%	29.64	814.8 GB	100.0%	9888.38

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	5285	310	4187	8	780
2	news.nask.pl	1408	172	1166	9	61
3	news.task.gda.pl	573	293	107	0	173
4	news.icm.edu.pl	17	0	3	0	14
TOTAL: 4		7283	775	5463	17	1028

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.sex.telephones	162
uk.rec.cycling.moderated	94
uk.railway	68
24hoursupport.helpdesk	59
alt.windows7.general	43
mozilla.dev.tree-management	32
mozilla.dev.gaia	32
fa.freebsd.cvs-all	30
it.comp.os.win.windows7	28
it.tlc.cellulari.android	23
comp.mobile.ipad	19
hr.alt.cellular.gsm.android	18
gmane.linux.alsa.devel	15
hr.ponuda.hardver.komponente	14
comp.mobile.android	13
fr.usenet.abus.nocem	13
hr.alt.cellular.gsm.iphone	11
alt.politics.scorched-earth	11
it.comp.os.win.windows8	10
gnu.hurd.bug	9
TOTAL: 43	775

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

Groups	Count
pl.sci.historia	11
pl.sci.matematyka	6
TOTAL: 2	17

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	509
EMP (fsl)	151
HTML post	69
Attached HTML file	24
EMP (phl)	20
EMP (md5)	12
TOTAL: 6	785

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	68073	4535	38609	4574	2	1166	6%	23:50:25
2	panorama	51239	3539	45048	1001	0	0	6%	23:52:26
3	poznan	15179	82	12884	57	0	0	0%	24:08:36
4	task	2282	4	1265	3	0	0	0%	21:02:38
5	nask	17595	3	14370	0	0	0	0%	24:00:02
6	okapi	0	0	0	0	0	2735	0%	24:00:00
TOTAL: 6		154368	8163	112176	5635	2	3901	5%	140:54:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	947.3 MB	592.4 MB	1.5 GB	18.4 KB/s	173.1 KB	23:50:25
2	panorama	9.5 MB	3.9 MB	13.4 MB	0.2 KB/s	3.0 KB	23:52:26
3	poznan	257.7 KB	147.1 KB	404.8 KB	0.0 KB/s	2.9 KB	24:08:36
4	task	12.2 KB	6.0 KB	18.2 KB	0.0 KB/s	2.6 KB	21:02:38
5	nask	4.9 KB	0.0 KB	4.9 KB	0.0 KB/s	1.6 KB	24:00:02
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		957.1 MB	596.4 MB	1.5 GB	3.1 KB/s	115.3 KB	140:54:07

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	376	736.1 KB	288	0	00:00:11
2	web.man.lodz.pl	288	146	185.4 KB	66	0	00:00:18
3	212.191.78.190	307	111	210.4 KB	41	2	47:51:28
4	lze200.lze.lodz.pl	2	27	48.8 KB	2	0	00:07:39
5	ebz78.neoplus.adsl.tpnet.pl	7	12	23.3 KB	2	0	00:38:50
6	ip-176.105.135.22.tvsat364.lodz.pl	4	3	6.1 KB	3	0	00:36:21
7	212.191.196.1	2	2	5.3 KB	1	0	00:06:03
8	router2.cbmm.lodz.pl	3	1	1.3 KB	1	0	00:45:26
9	kujawiak.man.lodz.pl	9	0	0.0 KB	0	9	00:00:02
TOTAL: 9		910	678	1.2 MB	404	11	50:17:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	376	736.1 KB	288	0	00:00:11
2	*.man.lodz.pl	681	146	185.4 KB	66	9	00:00:33
3	unresolved	309	113	215.7 KB	42	2	47:57:32
4	*.lze.lodz.pl	2	27	48.8 KB	2	0	00:07:39
5	*.neoplus.adsl.tpnet.pl	7	12	23.3 KB	2	0	00:38:50
6	*.105.135.22.tvsat364.lodz.pl	4	3	6.1 KB	3	0	00:36:21
7	*.cbmm.lodz.pl	5	1	1.3 KB	1	0	00:55:38
8	*.internetdsl.tpnet.pl	2	0	0.0 KB	0	0	00:00:01
9	*.inhort.pl	1	0	0.0 KB	0	0	00:00:05
10	*.toya.net.pl	79	0	0.0 KB	0	0	00:00:13
TOTAL: 10		1378	678	1.2 MB	404	11	50:17:07

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	1.368	12.884	47:51:28
router2.cbmm.lodz.pl	0.012	0.148	00:45:26
ebz78.neoplus.adsl.tpnet.pl	0.012	0.172	00:38:50
ip-176.105.135.22.tvsat364.lodz.pl	0.024	0.152	00:36:21
router.cbmm.lodz.pl	0.052	0.228	00:10:11
lze200.lze.lodz.pl	0.012	0.268	00:07:39
212.191.196.1	0.004	0.104	00:06:03
web.man.lodz.pl	1.848	20.628	00:00:18
vegas.cm.p.lodz.pl	1.100	12.728	00:00:11
f-oper-v100.man.lodz.pl	1.732	24.884	00:00:10
staticline41435.toya.net.pl	0.364	3.744	00:00:08
g.inhort.pl	0.000	0.024	00:00:05
staticline43485.toya.net.pl	0.004	0.024	00:00:04
david.man.lodz.pl	0.532	8.076	00:00:02
kujawiak.man.lodz.pl	0.136	0.880	00:00:02
gcq193.internetdsl.tpnet.pl	0.000	0.032	00:00:01
TOTAL: 16	7.200	84.976	50:17:07

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	78
gcq193.internetdsl.tpnet.pl	2
router.cbmm.lodz.pl	2
g.inhort.pl	1
staticline43485.toya.net.pl	1
TOTAL: 7	468

NNRP client timeouts [Top 20]:

System	Conn	Peer
router2.cbmm.lodz.pl	1	0
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	388	57.2%
2	pl	289	42.6%
3	alt	1	0.1%
TOTAL: 3		678	100.0%

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

Newsgroup		Count
1	lodman.info	388
2	pl.comp.os.ms-windows.winnt	98
3	pl.comp.pecet	72
4	pl.regionalne.warszawa	31
5	pl.comp.os.linux	24
6	pl.rec.gory	16
7	pl.misc.kolej	15
8	pl.soc.prawo	15
9	pl.rec.rowery	9
10	pl.praca.dyskusje	4
11	pl.regionalne.lodz	3
12	pl.listserv.chomor-l	2
13	alt.pl.praca.oferowana	1
TOTAL: 13		678

Daily Usenet report

Jun 11 04:15:06 -- Jun 12 04:15:04