Daily Usenet report: May 28 04:15:04

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

May 28 12:14:43 newsfeed nnrpd[26615]: SERVER perl filter not defined
May 28 14:00:25 newsfeed nnrpd[30115]: SERVER perl filter not defined
May 28 14:02:23 newsfeed nnrpd[30129]: SERVER perl filter not defined
May 28 15:12:29 newsfeed nnrpd[32344]: SERVER perl filter not defined
May 28 15:17:53 newsfeed innfeed[23457]: task:0 connect: Network is unreachable

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2853163	98.6%	326.2 MB	98.3%
innd	21461	0.7%	3.6 MB	1.1%
nnrpd	10557	0.4%	1.1 MB	0.3%
innfeed	7132	0.2%	1.1 MB	0.3%
TOTAL: 4	2892313	100.0%	331.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2842210	95.7%
Negative hits	79047	2.7%
Positive hits	45318	1.5%
Cache misses	4538	0.2%
TOTAL: 4	2971113	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:11.515	0.0%	339	0.000	33.968	623.000
article cleanup	00:00:39.784	0.0%	2853690	0.005	0.014	0.368
article logging	00:01:56.091	0.1%	2853895	0.011	0.041	0.840
article parse	01:21:52.603	5.7%	76294633	0.023	0.064	0.194
article write	00:32:32.739	2.3%	2842252	0.380	0.687	3.761
artlog/artcncl	00:00:00.007	0.0%	308	0.000	0.023	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:59.351	0.2%	91219310	0.001	0.002	0.016
hisgrep/artcncl	00:00:02.560	0.0%	259	0.000	9.884	281.000
hishave/artcncl	00:00:01.130	0.0%	339	0.000	3.333	187.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:47:25.338	15.8%	2973707	0.027	4.589	20.690
history sync	00:00:00.008	0.0%	293	0.000	0.027	1.000
history write	05:10:44.149	21.6%	2844667	0.076	6.554	43.320
hiswrite/artcncl	00:00:00.294	0.0%	80	0.000	3.675	17.000
idle	04:38:35.439	19.3%	33332692	0.143	0.501	6.414
nntp read	00:43:59.341	3.1%	73921097	0.015	0.036	0.147
overview write	00:00:20.223	0.0%	2842252	0.002	0.007	0.146
perl filter	07:06:52.332	29.6%	2844665	5.087	9.004	20.477
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:08:08.113	0.6%	5739671	0.031	0.085	0.747
TOTAL: 24:00:13.072	23:36:21.017	98.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.661	0.0%	55539	0.000	0.012	35.083
article prepare	00:00:00.028	0.0%	86714	0.000	0.000	0.062
article read	00:00:33.059	0.0%	21442	0.000	1.542	238.000
backlog stats	00:00:00.373	0.0%	413724	0.000	0.001	0.319
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:04.311	0.0%	235309	0.000	0.018	1.925
data write	00:00:15.352	0.0%	221508	0.000	0.069	4.130
idle	23:58:40.220	99.9%	413724	0.000	208.642	20100.000
status file	00:00:05.078	0.0%	240	0.500	21.158	284.000
TOTAL: 23:59:53.591	23:59:39.082	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.001	0.0%	2	0.500	0.500	0.500
idle	95:07:40.915	100.0%	52312	0.000	6546.508	600035.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:05.825	0.0%	107064	0.000	0.054	12.333
readart	00:00:05.165	0.0%	560	0.000	9.223	63.000
TOTAL: 95:08:47.431	95:07:51.906	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	710	2839717	2827069	4849	7799	99%	502:27:03
2	news.nask.pl	2	19294	7743	9159	2392	40%	23:54:39
3	news.task.gda.pl	19	33854	6509	26142	1203	19%	45:09:40
4	news.icm.edu.pl	38	364	8	342	14	2%	21:11:08
5	localhost	5	4	4	0	0	100%	00:00:01
TOTAL: 5		774	2893233	2841333	40492	11408	98%	592:42:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	849.5 GB	52.6 MB	103.6 MB	849.6 GB	99%	314.3 KB
2	news.nask.pl	25.1 MB	7.6 MB	13.5 MB	46.2 MB	54%	4.7 KB
3	news.task.gda.pl	13.8 MB	72.7 KB	3.6 MB	17.5 MB	79%	2.3 KB
4	news.icm.edu.pl	219.1 KB	0.0 KB	179.1 KB	398.2 KB	55%	18.1 KB
5	localhost	7.0 KB	0.0 KB	0.0 KB	7.0 KB	100%	1.8 KB
TOTAL: 5		849.5 GB	60.3 MB	120.8 MB	849.7 GB	99%	312.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 28 04:15:04 - 04:59:59	62995	2.2%	23.37	17.7 GB	2.1%	6899.53
May 28 05:00:00 - 05:59:59	108603	3.8%	30.17	32.5 GB	3.8%	9474.16
May 28 06:00:00 - 06:59:59	109440	3.9%	30.40	33.7 GB	4.0%	9821.13
May 28 07:00:00 - 07:59:59	98950	3.5%	27.49	30.6 GB	3.6%	8927.39
May 28 08:00:00 - 08:59:59	125526	4.4%	34.87	37.5 GB	4.4%	10930.53
May 28 09:00:00 - 09:59:59	121738	4.3%	33.82	38.2 GB	4.5%	11129.15
May 28 10:00:00 - 10:59:59	138765	4.9%	38.55	39.9 GB	4.7%	11613.09
May 28 11:00:00 - 11:59:59	143869	5.1%	39.96	40.8 GB	4.8%	11891.52
May 28 12:00:00 - 12:59:59	139180	4.9%	38.66	37.3 GB	4.4%	10873.04
May 28 13:00:00 - 13:59:59	114970	4.0%	31.94	33.4 GB	3.9%	9725.50
May 28 14:00:00 - 14:59:59	114324	4.0%	31.76	32.3 GB	3.8%	9404.44
May 28 15:00:00 - 15:59:59	140666	5.0%	39.07	39.1 GB	4.6%	11391.86
May 28 16:00:00 - 16:59:59	130150	4.6%	36.15	39.7 GB	4.7%	11555.39
May 28 17:00:00 - 17:59:59	123728	4.4%	34.37	35.8 GB	4.2%	10433.52
May 28 18:00:00 - 18:59:59	145814	5.1%	40.50	39.1 GB	4.6%	11379.45
May 28 19:00:00 - 19:59:59	114966	4.0%	31.93	34.9 GB	4.1%	10178.48
May 28 20:00:00 - 20:59:59	111323	3.9%	30.92	34.1 GB	4.0%	9932.04
May 28 21:00:00 - 21:59:59	99946	3.5%	27.76	30.7 GB	3.6%	8950.38
May 28 22:00:00 - 22:59:59	110711	3.9%	30.75	34.6 GB	4.1%	10071.95
May 28 23:00:00 - 23:59:59	112441	4.0%	31.23	36.0 GB	4.2%	10487.89
May 29 00:00:00 - 00:59:59	105049	3.7%	29.18	31.7 GB	3.7%	9245.56
May 29 01:00:00 - 01:59:59	126341	4.4%	35.09	39.6 GB	4.7%	11526.70
May 29 02:00:00 - 02:59:59	109640	3.9%	30.46	35.8 GB	4.2%	10421.98
May 29 03:00:00 - 03:59:59	112167	3.9%	31.16	37.3 GB	4.4%	10870.18
May 29 04:00:00 - 04:15:03	19919	0.7%	22.06	6.6 GB	0.8%	7628.28
TOTAL: 23:59:59	2841221	100.0%	32.88	849.1 GB	100.0%	10304.94

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	7945	314	6635	1	995
2	news.nask.pl	2464	11	2335	2	116
3	news.task.gda.pl	1208	1010	42	2	154
4	news.icm.edu.pl	17	0	1	0	16
TOTAL: 4		11634	1335	9013	5	1281

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.rec.cycling.moderated	151
alt.politics.scorched-earth	132
mailing.freebsd.ports-bugs	65
uk.railway	62
mailing.unix.samba-technical	55
perl.cpan.uploads	47
mailing.freebsd.svn-ports-all	46
mailing.freebsd.svn-ports-head	46
mailing.freebsd.svn-src-all	39
fa.freebsd.cvs-all	39
mailing.openbsd.misc	37
mailing.database.pgsql-general	35
mailing.gcc.gcc-cvs	32
mailing.freebsd.ports	29
mailing.freebsd.svn-src-head	29
mailing.postfix.users	24
mailing.www.horde-bugs	21
it.comp.os.linux.ubuntu	20
alt.windows7.general	20
mozilla.dev.platform	19
TOTAL: 90	1335

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

Groups	Count
fr.comp.securite	2
pl.sci.matematyka	2
christnet.theology	1
TOTAL: 3	5

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	855
EMP (fsl)	111
HTML post	64
EMP (md5)	43
TOTAL: 4	1073

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	58000	3339	50860	846	1	0	5%	23:53:52
2	icm	75252	1651	37625	15550	0	370	2%	24:00:04
3	task	2150	161	1082	16	0	5	7%	21:09:46
4	poznan	16080	63	13726	30	0	0	0%	24:01:47
5	nask	17743	6	12660	0	0	0	0%	24:04:10
6	okapi	0	0	0	0	0	2962	0%	24:00:02
TOTAL: 6		169225	5220	115953	16442	1	3337	3%	141:09:41

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	246.5 MB	3.8 GB	4.0 GB	48.9 KB/s	245.8 KB	24:00:04
2	panorama	9.2 MB	6.2 MB	15.4 MB	0.2 KB/s	3.8 KB	23:53:52
3	task	329.0 KB	38.8 KB	367.8 KB	0.0 KB/s	2.1 KB	21:09:46
4	poznan	168.6 KB	63.7 KB	232.3 KB	0.0 KB/s	2.5 KB	24:01:47
5	nask	16.0 KB	0.0 KB	16.0 KB	0.0 KB/s	2.7 KB	24:04:10
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 6		256.2 MB	3.8 GB	4.0 GB	8.4 KB/s	195.9 KB	141:09:41

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	326	578.7 KB	288	0	00:00:13
2	212.191.196.1	2	96	168.5 KB	6	0	01:15:33
3	212.191.78.190	302	60	107.2 KB	21	0	47:39:17
4	ip-176.105.135.22.tvsat364.lodz.pl	3	48	85.7 KB	7	0	01:09:21
5	web.man.lodz.pl	288	24	20.0 KB	12	0	00:00:20
6	ech132.neoplus.adsl.tpnet.pl	3	5	8.6 KB	3	0	00:02:03
7	router2.cbmm.lodz.pl	2	1	1.7 KB	1	0	00:13:52
8	kujawiak.man.lodz.pl	4	0	0.0 KB	0	4	00:00:01
TOTAL: 8		892	560	970.4 KB	338	4	95:08:46

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	326	578.7 KB	288	0	00:00:13
2	unresolved	306	156	275.7 KB	27	0	48:55:00
3	*.105.135.22.tvsat364.lodz.pl	3	48	85.7 KB	7	0	01:09:21
4	*.man.lodz.pl	676	24	20.0 KB	12	4	00:00:31
5	*.neoplus.adsl.tpnet.pl	3	5	8.6 KB	3	0	00:02:03
6	*.cbmm.lodz.pl	2	1	1.7 KB	1	0	00:13:52
7	*.207.15.62.static.jazztel.es	59	0	0.0 KB	0	0	38:11:36
8	*.181.14.62.static.jazztel.es	18	0	0.0 KB	0	0	06:35:18
9	*.internetdsl.tpnet.pl	1	0	0.0 KB	0	0	00:00:00
10	*.toya.net.pl	74	0	0.0 KB	0	0	00:00:48
TOTAL: 10		1430	560	970.4 KB	338	4	95:08:46

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	1.280	11.464	47:39:17
245.207.15.62.static.jazztel.es	1.104	3.028	18:51:46
130.207.15.62.static.jazztel.es	4.156	6.672	13:23:00
116.181.14.62.static.jazztel.es	0.576	1.260	06:35:18
155.207.15.62.static.jazztel.es	0.352	0.680	04:35:01
145.207.15.62.static.jazztel.es	0.276	0.408	01:21:48
212.191.196.1	0.048	0.472	01:15:33
ip-176.105.135.22.tvsat364.lodz.pl	0.020	0.356	01:09:21
router2.cbmm.lodz.pl	0.008	0.044	00:13:52
ech132.neoplus.adsl.tpnet.pl	0.016	0.076	00:02:03
staticline41435.toya.net.pl	0.432	3.516	00:00:48
web.man.lodz.pl	2.072	21.812	00:00:20
vegas.cm.p.lodz.pl	1.420	15.432	00:00:13
212.51.203.199	0.000	0.064	00:00:10
f-oper-v100.man.lodz.pl	1.760	17.460	00:00:06
david.man.lodz.pl	0.436	4.472	00:00:02
kujawiak.man.lodz.pl	0.060	0.432	00:00:01
gcq193.internetdsl.tpnet.pl	0.000	0.028	00:00:00
TOTAL: 18	14.016	87.676	95:08:46

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	74
245.207.15.62.static.jazztel.es	39
116.181.14.62.static.jazztel.es	18
155.207.15.62.static.jazztel.es	10
145.207.15.62.static.jazztel.es	6
130.207.15.62.static.jazztel.es	4
212.51.203.199	2
gcq193.internetdsl.tpnet.pl	1
TOTAL: 10	538

NNRP client timeouts [Top 20]:

System	Conn	Peer
245.207.15.62.static.jazztel.es	31	0
116.181.14.62.static.jazztel.es	10	0
155.207.15.62.static.jazztel.es	7	1
130.207.15.62.static.jazztel.es	3	0
ip-176.105.135.22.tvsat364.lodz.pl	2	1
145.207.15.62.static.jazztel.es	1	0
212.191.196.1	1	0
TOTAL: 7	55	2

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	331	59.1%
2	pl	225	40.2%
3	alt	4	0.7%
TOTAL: 3		560	100.0%

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

Newsgroup		Count
1	lodman.info	331
2	pl.rec.fantastyka.sf-f	56
3	pl.misc.paranauki	36
4	pl.misc.kolej	28
5	pl.regionalne.lodz	23
6	pl.comp.os.ms-windows.winnt	22
7	pl.soc.prawo	20
8	pl.regionalne.warszawa	14
9	pl.soc.dzieci	7
10	pl.rec.rowery	7
11	pl.misc.dieta	3
12	pl.praca.dyskusje	3
13	alt.pl.matematyka	2
14	pl.comp.pecet	2
15	pl.rec.gory	2
16	pl.soc.dzieci.starsze	1
17	alt.pl.praca.oferowana	1
18	pl.listserv.chomor-l	1
19	alt.pl.misc.samochody.skoda	1
TOTAL: 19		560

Daily Usenet report

May 28 04:15:04 -- May 29 04:15:03