Daily Usenet report: Sep 26 04:15:03

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Sep 26 05:03:11 newsfeed nnrpd[19684]: SERVER perl filter not defined
Sep 26 13:14:31 newsfeed nnrpd[3084]: SERVER perl filter not defined
Sep 26 15:58:33 newsfeed nnrpd[8159]: SERVER perl filter not defined
Sep 26 17:23:02 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable
Sep 26 17:30:05 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable
Sep 26 17:55:08 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable
Sep 26 19:28:11 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable
Sep 26 21:29:14 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable
Sep 26 23:30:18 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable
Sep 27 01:31:22 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable
Sep 27 03:32:25 newsfeed innfeed[2378]: icm:0 connect: Network is unreachable

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1759778	98.1%	198.2 MB	97.6%
innd	19812	1.1%	3.1 MB	1.5%
nnrpd	7720	0.4%	823.0 KB	0.4%
innfeed	6676	0.4%	1010.3 KB	0.5%
TOTAL: 4	1793986	100.0%	203.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1753855	92.2%
Negative hits	103792	5.5%
Positive hits	41448	2.2%
Cache misses	2538	0.1%
TOTAL: 4	1901633	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.593	0.0%	343	0.000	30.883	649.000
article cleanup	00:00:23.167	0.0%	1760349	0.003	0.013	0.035
article logging	00:00:58.836	0.1%	1760645	0.011	0.033	0.854
article parse	00:49:14.635	3.4%	57391416	0.012	0.051	0.093
article write	00:18:10.854	1.3%	1748721	0.198	0.624	1.775
artlog/artcncl	00:00:00.008	0.0%	340	0.000	0.024	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:01:53.203	0.1%	67721480	0.001	0.002	0.004
hisgrep/artcncl	00:00:03.211	0.0%	320	0.000	10.034	290.000
hishave/artcncl	00:00:01.396	0.0%	343	0.000	4.070	196.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:40:11.367	15.3%	1902730	0.864	6.943	35.086
history sync	00:00:00.006	0.0%	294	0.000	0.020	1.000
history write	04:33:35.859	19.0%	1754987	3.639	9.354	40.285
hiswrite/artcncl	00:00:00.079	0.0%	23	0.000	3.435	14.000
idle	09:26:00.614	39.3%	32655562	0.234	1.040	4.854
nntp read	00:32:01.975	2.2%	56055564	0.011	0.034	0.051
overview write	00:00:10.844	0.0%	1748721	0.000	0.006	0.023
perl filter	04:16:10.066	17.8%	1754987	4.100	8.758	12.016
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:09.265	0.2%	3541046	0.022	0.053	0.099
TOTAL: 24:00:55.658	23:42:15.978	98.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.176	0.0%	43602	0.000	0.004	0.333
article prepare	00:00:00.013	0.0%	33988	0.000	0.000	0.250
article read	00:00:01.423	0.0%	8284	0.000	0.172	13.800
backlog stats	00:00:00.213	0.0%	266322	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.876	0.0%	157120	0.000	0.012	0.067
data write	00:00:05.533	0.0%	131355	0.000	0.042	1.000
idle	23:59:40.096	100.0%	266322	0.000	324.345	15414.000
status file	00:00:00.776	0.0%	227	0.000	3.419	177.000
TOTAL: 23:59:55.788	23:59:50.106	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:00:29.814	99.7%	14425	0.000	501.200	510052.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.449	0.0%	30697	0.000	0.015	0.500
readart	00:00:00.802	0.0%	395	0.000	2.030	39.000
TOTAL: 02:00:54.527	02:00:31.065	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	715	1748828	1734598	5677	8553	99%	384:41:13
2	news.nask.pl	3	17240	6600	8728	1912	38%	23:58:01
3	news.task.gda.pl	13	30978	6121	23736	1121	19%	45:26:16
4	news.icm.edu.pl	20	165	16	132	17	9%	10:27:34
5	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 5		755	1797214	1747338	38273	11603	97%	464:33:04

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	594.3 GB	293.1 MB	924.2 MB	595.5 GB	99%	358.2 KB
2	news.nask.pl	87.9 MB	5.2 MB	10.6 MB	103.6 MB	84%	12.5 KB
3	news.task.gda.pl	12.9 MB	76.0 KB	3.0 MB	16.0 MB	80%	2.3 KB
4	news.icm.edu.pl	217.6 KB	0.0 KB	869.4 KB	1.1 MB	20%	32.9 KB
5	localhost	4.2 KB	0.0 KB	0.0 KB	4.2 KB	100%	1.4 KB
TOTAL: 5		594.4 GB	298.4 MB	938.6 MB	595.6 GB	99%	355.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 26 04:15:03 - 04:59:59	57720	3.3%	21.40	22.9 GB	3.8%	8893.43
Sep 26 05:00:00 - 05:59:59	81931	4.7%	22.76	31.2 GB	5.2%	9078.39
Sep 26 06:00:00 - 06:59:59	80096	4.6%	22.25	30.4 GB	5.1%	8861.12
Sep 26 07:00:00 - 07:59:59	79589	4.6%	22.11	27.7 GB	4.7%	8054.34
Sep 26 08:00:00 - 08:59:59	88359	5.1%	24.54	31.7 GB	5.3%	9223.26
Sep 26 09:00:00 - 09:59:59	69724	4.0%	19.37	24.8 GB	4.2%	7210.45
Sep 26 10:00:00 - 10:59:59	66945	3.8%	18.60	23.8 GB	4.0%	6929.71
Sep 26 11:00:00 - 11:59:59	84910	4.9%	23.59	29.7 GB	5.0%	8664.04
Sep 26 12:00:00 - 12:59:59	93403	5.3%	25.95	31.7 GB	5.3%	9247.10
Sep 26 13:00:00 - 13:59:59	108303	6.2%	30.08	36.1 GB	6.1%	10527.18
Sep 26 14:00:00 - 14:59:59	114176	6.5%	31.72	36.0 GB	6.1%	10479.44
Sep 26 15:00:00 - 15:59:59	91089	5.2%	25.30	30.9 GB	5.2%	9012.43
Sep 26 16:00:00 - 16:59:59	85047	4.9%	23.62	30.0 GB	5.0%	8727.18
Sep 26 17:00:00 - 17:59:59	54167	3.1%	15.05	18.1 GB	3.0%	5268.87
Sep 26 18:00:00 - 18:59:59	37688	2.2%	10.47	9.3 GB	1.6%	2696.39
Sep 26 19:00:00 - 19:59:59	37136	2.1%	10.32	7.7 GB	1.3%	2231.09
Sep 26 20:00:00 - 20:59:59	50958	2.9%	14.15	14.5 GB	2.4%	4223.85
Sep 26 21:00:00 - 21:59:59	43923	2.5%	12.20	12.9 GB	2.2%	3763.42
Sep 26 22:00:00 - 22:59:59	31161	1.8%	8.66	9.9 GB	1.7%	2883.59
Sep 26 23:00:00 - 23:59:59	54893	3.1%	15.25	15.0 GB	2.5%	4358.27
Sep 27 00:00:00 - 00:59:59	82456	4.7%	22.90	26.3 GB	4.4%	7660.37
Sep 27 01:00:00 - 01:59:59	74436	4.3%	20.68	26.7 GB	4.5%	7775.29
Sep 27 02:00:00 - 02:59:59	80486	4.6%	22.36	29.6 GB	5.0%	8618.51
Sep 27 03:00:00 - 03:59:59	81669	4.7%	22.69	30.6 GB	5.1%	8898.89
Sep 27 04:00:00 - 04:15:03	17249	1.0%	19.10	7.3 GB	1.2%	8442.39
TOTAL: 24:00:00	1747514	100.0%	20.23	594.5 GB	100.0%	7215.56

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	8794	302	3521	3	4968
2	news.nask.pl	1971	36	1797	11	127
3	news.task.gda.pl	1142	943	44	0	155
4	news.icm.edu.pl	17	0	0	0	17
TOTAL: 4		11924	1281	5362	14	5267

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	102
mailing.freebsd.svn-ports-head	102
mailing.openbsd.ports-changes	100
mailing.freebsd.ports-bugs	71
uk.railway	61
it.tlc.cellulari.android	57
comp.mobile.ipad	49
uk.rec.cycling.moderated	44
alt.windows7.general	37
fr.usenet.abus.nocem	33
mailing.gcc.gcc-cvs	32
mailing.unix.dovecot	29
mailing.database.pgsql-general	28
mailing.freebsd.ports	28
24hoursupport.helpdesk	28
mozilla.dev.tree-management	28
it.comp.os.win.windows8	27
mailing.unix.samba	27
mailing.openbsd.misc	27
mailing.freebsd.svn-src-all	26
TOTAL: 79	1281

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

Groups	Count
pl.sci.historia	9
uk.religion.christian	4
bit.listserv.catholic	1
TOTAL: 3	14

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	4783
EMP (fsl)	114
EMP (md5)	53
HTML post	12
EMP (phl)	7
Scoring filter (9)	1
Scoring filter (10)	1
TOTAL: 7	4971

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	45021	2751	40013	841	0	0	6%	23:58:16
2	icm	30124	1472	16307	3130	2	19433	4%	23:55:27
3	poznan	13947	53	11949	43	0	0	0%	24:00:22
4	task	1914	46	1006	4	0	1	2%	21:33:05
5	nask	17928	27	12315	118	0	0	0%	24:00:02
6	okapi	0	0	0	0	0	2612	0%	24:00:01
TOTAL: 6		108934	4349	81590	4136	2	22046	3%	141:27:13

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	8.0 MB	2.7 MB	10.7 MB	0.1 KB/s	3.0 KB	23:58:16
2	icm	4.8 MB	1.4 GB	1.4 GB	16.6 KB/s	310.0 KB	23:55:27
3	poznan	163.4 KB	84.5 KB	248.0 KB	0.0 KB/s	2.6 KB	24:00:22
4	task	103.7 KB	7.6 KB	111.3 KB	0.0 KB/s	2.2 KB	21:33:05
5	nask	76.1 KB	72.0 MB	72.0 MB	0.9 KB/s	508.7 KB	24:00:02
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 6		13.0 MB	1.4 GB	1.4 GB	3.0 KB/s	178.2 KB	141:27:13

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	324	437.5 KB	288	0	00:00:07
2	web.man.lodz.pl	288	66	65.4 KB	27	0	00:00:20
3	212.191.196.1	2	5	11.2 KB	2	0	00:05:33
4	kujawiak.man.lodz.pl	3	0	0.0 KB	0	3	00:00:01
TOTAL: 4		581	395	514.2 KB	317	3	02:00:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	324	437.5 KB	288	0	00:00:07
2	*.man.lodz.pl	675	66	65.4 KB	27	3	00:00:31
3	unresolved	2	5	11.2 KB	2	0	00:05:33
4	*.versanet.de	160	0	0.0 KB	0	0	00:00:17
5	*.cbmm.lodz.pl	1	0	0.0 KB	0	0	00:30:01
6	*.adsl.inetia.pl	1	0	0.0 KB	0	0	00:00:02
7	*.181.14.62.static.jazztel.es	3	0	0.0 KB	0	0	00:20:09
8	*.internetdsl.tpnet.pl	2	0	0.0 KB	0	0	00:00:00
9	*.105.135.22.tvsat364.lodz.pl	3	0	0.0 KB	0	0	01:04:00
10	*.toya.net.pl	54	0	0.0 KB	0	0	00:00:09
TOTAL: 10		1189	395	514.2 KB	317	3	02:00:53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ip-176.105.135.22.tvsat364.lodz.pl	0.008	0.052	01:04:00
router2.cbmm.lodz.pl	0.000	0.012	00:30:01
87.181.14.62.static.jazztel.es	0.604	0.712	00:20:09
212.191.196.1	0.016	0.028	00:05:33
web.man.lodz.pl	0.728	4.896	00:00:20
i59f5e0a8.versanet.de	0.360	2.416	00:00:17
staticline41435.toya.net.pl	0.136	0.880	00:00:09
f-oper-v100.man.lodz.pl	0.660	5.284	00:00:08
vegas.cm.p.lodz.pl	0.728	4.748	00:00:07
87-205-39-55.adsl.inetia.pl	0.000	0.024	00:00:02
kujawiak.man.lodz.pl	0.012	0.068	00:00:01
david.man.lodz.pl	0.256	1.432	00:00:01
gcq193.internetdsl.tpnet.pl	0.008	0.032	00:00:00
TOTAL: 13	3.516	20.584	02:00:53

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
i59f5e0a8.versanet.de	160
david.man.lodz.pl	96
staticline41435.toya.net.pl	54
ip-176.105.135.22.tvsat364.lodz.pl	3
87.181.14.62.static.jazztel.es	3
gcq193.internetdsl.tpnet.pl	2
router2.cbmm.lodz.pl	1
87-205-39-55.adsl.inetia.pl	1
TOTAL: 9	608

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	324	82.0%
2	pl	71	18.0%
TOTAL: 2		395	100.0%

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

Newsgroup		Count
1	lodman.info	324
2	pl.comp.pecet	64
3	pl.regionalne.lodz	3
4	pl.misc.paranauki	2
5	pl.comp.os.ms-windows.winnt	2
TOTAL: 5		395

Daily Usenet report

Sep 26 04:15:03 -- Sep 27 04:15:03