Daily Usenet report: Nov 21 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 21 04:39:11 newsfeed pgpverify[26314]: pgpverify: verification failed
Nov 21 09:53:57 newsfeed nnrpd[4560]: SERVER perl filter not defined
Nov 21 10:52:05 newsfeed innfeed[2235]: task:0 connect: Network is unreachable
Nov 21 11:00:12 newsfeed innfeed[2235]: task:0 connect: Network is unreachable
Nov 21 11:26:19 newsfeed innfeed[2235]: task:0 connect: Network is unreachable
Nov 21 13:00:26 newsfeed innfeed[2235]: task:0 connect: Network is unreachable
Nov 21 17:38:26 newsfeed nnrpd[19958]: SERVER perl filter not defined
Nov 21 21:11:27 newsfeed overchan[2236]: input line too long, skipping
Nov 21 22:58:57 newsfeed nnrpd[30570]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1948060	98.3%	220.8 MB	97.8%
innd	17705	0.9%	2.9 MB	1.3%
nnrpd	10505	0.5%	1.1 MB	0.5%
innfeed	6375	0.3%	939.7 KB	0.4%
controlchan	3	0.0%	0.4 KB	0.0%
overchan	1	0.0%	0.2 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
TOTAL: 7	1982650	100.0%	225.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1943467	94.0%
Negative hits	81241	3.9%
Positive hits	41719	2.0%
Cache misses	1824	0.1%
TOTAL: 4	2068251	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.524	0.0%	364	0.000	28.912	598.000
article cleanup	00:00:25.657	0.0%	1946949	0.004	0.013	0.027
article logging	00:00:59.927	0.1%	1947142	0.015	0.031	0.460
article parse	00:57:24.898	4.0%	54623017	0.020	0.063	0.093
article write	00:18:14.435	1.3%	1941075	0.336	0.564	1.230
artlog/artcncl	00:00:00.011	0.0%	359	0.000	0.031	1.000
artlog/artparse	00:00:00.001	0.0%	3	0.000	0.333	0.500
data move	00:01:36.378	0.1%	66014878	0.001	0.001	0.016
hisgrep/artcncl	00:00:01.660	0.0%	304	0.000	5.461	255.000
hishave/artcncl	00:00:00.883	0.0%	364	0.000	2.426	165.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:04:45.154	12.8%	2067938	0.253	5.360	11.715
history sync	00:00:00.012	0.0%	290	0.000	0.041	1.000
history write	04:34:52.372	19.1%	1943275	1.024	8.487	22.397
hiswrite/artcncl	00:00:00.467	0.0%	60	0.000	7.783	167.000
idle	09:03:06.131	37.7%	24961991	0.254	1.305	3.971
nntp read	00:28:46.086	2.0%	53056145	0.013	0.033	0.042
overview write	00:00:12.203	0.0%	1941075	0.000	0.006	0.017
perl filter	05:07:21.716	21.3%	1943272	5.858	9.490	11.995
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:55.990	0.3%	3924554	0.037	0.060	0.079
TOTAL: 23:59:41.377	23:41:54.505	98.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.180	0.0%	42622	0.000	0.004	1.000
article prepare	00:00:00.006	0.0%	18608	0.000	0.000	0.250
article read	00:00:00.166	0.0%	4364	0.000	0.038	1.000
backlog stats	00:00:00.136	0.0%	196080	0.000	0.001	0.029
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.389	0.0%	125701	0.000	0.011	1.000
data write	00:00:02.447	0.0%	83713	0.000	0.029	1.000
idle	23:59:19.458	100.0%	196080	0.000	440.430	19464.000
status file	00:00:01.565	0.0%	276	0.000	5.670	176.000
TOTAL: 23:59:30.213	23:59:25.347	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	57:27:05.188	100.0%	153430	0.000	1348.010	600069.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:25.423	0.0%	369813	0.000	0.069	32.667
readart	00:00:00.856	0.0%	580	0.000	1.476	161.000
TOTAL: 57:28:31.029	57:27:31.467	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
nl-admin@nic.surfnet.nl	0	0	0	1	0	0
TOTAL	0	0	0	1	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1012	1934705	1928838	2304	3563	99%	390:10:45
2	news.task.gda.pl	22	36530	7787	27302	1441	21%	43:12:49
3	news.nask.pl	3	16813	5547	10383	883	32%	23:28:51
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		1041	1988051	1942175	39989	5887	97%	456:52:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	705.7 GB	22.0 MB	41.2 MB	705.8 GB	99%	383.0 KB
2	news.nask.pl	24.0 MB	2.2 MB	2.3 MB	28.5 MB	84%	4.5 KB
3	news.task.gda.pl	16.6 MB	50.2 KB	4.1 MB	20.7 MB	80%	2.3 KB
4	localhost	3.3 KB	0.0 KB	0.0 KB	3.3 KB	100%	1.1 KB
TOTAL: 4		705.8 GB	24.2 MB	47.6 MB	705.8 GB	99%	379.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 21 04:15:02 - 04:59:59	66201	3.4%	24.54	25.0 GB	3.5%	9702.82
Nov 21 05:00:00 - 05:59:59	73766	3.8%	20.49	28.0 GB	4.0%	8143.63
Nov 21 06:00:00 - 06:59:59	72679	3.7%	20.19	27.2 GB	3.9%	7922.28
Nov 21 07:00:00 - 07:59:59	69799	3.6%	19.39	26.5 GB	3.8%	7726.91
Nov 21 08:00:00 - 08:59:59	68996	3.6%	19.17	26.0 GB	3.7%	7572.08
Nov 21 09:00:00 - 09:59:59	86768	4.5%	24.10	32.3 GB	4.6%	9408.44
Nov 21 10:00:00 - 10:59:59	87850	4.5%	24.40	32.9 GB	4.7%	9587.22
Nov 21 11:00:00 - 11:59:59	77084	4.0%	21.41	30.6 GB	4.3%	8901.95
Nov 21 12:00:00 - 12:59:59	65229	3.4%	18.12	28.2 GB	4.0%	8203.91
Nov 21 13:00:00 - 13:59:59	75939	3.9%	21.09	29.2 GB	4.1%	8514.93
Nov 21 14:00:00 - 14:59:59	93007	4.8%	25.84	33.9 GB	4.8%	9871.46
Nov 21 15:00:00 - 15:59:59	77398	4.0%	21.50	27.7 GB	3.9%	8074.14
Nov 21 16:00:00 - 16:59:59	94223	4.9%	26.17	32.6 GB	4.6%	9488.92
Nov 21 17:00:00 - 17:59:59	81692	4.2%	22.69	28.0 GB	4.0%	8164.55
Nov 21 18:00:00 - 18:59:59	94393	4.9%	26.22	31.1 GB	4.4%	9064.43
Nov 21 19:00:00 - 19:59:59	94036	4.8%	26.12	31.4 GB	4.5%	9138.55
Nov 21 20:00:00 - 20:59:59	70983	3.7%	19.72	25.4 GB	3.6%	7392.85
Nov 21 21:00:00 - 21:59:59	69263	3.6%	19.24	25.0 GB	3.5%	7279.42
Nov 21 22:00:00 - 22:59:59	83047	4.3%	23.07	30.2 GB	4.3%	8810.02
Nov 21 23:00:00 - 23:59:59	86373	4.4%	23.99	29.8 GB	4.2%	8674.00
Nov 22 00:00:00 - 00:59:59	67395	3.5%	18.72	23.8 GB	3.4%	6944.88
Nov 22 01:00:00 - 01:59:59	81055	4.2%	22.52	29.3 GB	4.2%	8531.98
Nov 22 02:00:00 - 02:59:59	81075	4.2%	22.52	28.8 GB	4.1%	8383.93
Nov 22 03:00:00 - 03:59:59	97355	5.0%	27.04	33.4 GB	4.7%	9723.05
Nov 22 04:00:00 - 04:15:03	26024	1.3%	28.82	8.7 GB	1.2%	10158.91
TOTAL: 24:00:01	1941630	100.0%	22.47	705.0 GB	100.0%	8555.88

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3744	221	2773	1	749
2	news.task.gda.pl	1416	1196	27	3	190
3	news.nask.pl	911	19	878	2	12
TOTAL: 3		6071	1436	3678	6	951

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	90
mailing.freebsd.svn-ports-all	79
mailing.freebsd.svn-ports-head	78
fr.rec.loisirs-creatifs	68
mailing.freebsd.ports-bugs	60
alt.windows7.general	57
mozilla.dev.platform	51
gmane.linux.alsa.devel	51
24hoursupport.helpdesk	50
mailing.openbsd.misc	45
mailing.gcc.gcc-cvs	43
mailing.www.horde-bugs	43
perl.cpan.uploads	39
mailing.openbsd.source-changes	37
fa.freebsd.cvs-all	37
mailing.freebsd.svn-src-all	35
fr.usenet.abus.nocem	35
alt.politics.scorched-earth	33
comp.mobile.ipad	31
mailing.freebsd.svn-src-head	30
TOTAL: 82	1436

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

Groups	Count
fr.comp.applications.libres	3
pl.sci.historia	2
pl.praca.oferowana	1
TOTAL: 3	6

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	506
EMP (fsl)	161
Attached HTML file	55
HTML post	17
EMP (md5)	13
Scoring filter (8)	3
TOTAL: 6	755

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	43447	3320	38241	855	28	7%	24:00:14
2	task	1619	269	793	20	188	16%	21:05:59
3	poznan	15324	117	13029	61	0	0%	24:02:50
4	nask	19027	13	13392	0	0	0%	24:00:29
5	okapi	0	0	0	0	2458	0%	24:00:02
6	icm	0	0	0	0	41018	0%	24:00:02
TOTAL: 6		79417	3719	65455	936	43692	4%	141:09:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	9.9 MB	4.3 MB	14.1 MB	0.2 KB/s	3.5 KB	24:00:14
2	task	565.0 KB	31.9 KB	597.0 KB	0.0 KB/s	2.1 KB	21:05:59
3	poznan	305.7 KB	111.7 KB	417.4 KB	0.0 KB/s	2.3 KB	24:02:50
4	nask	36.2 KB	0.0 KB	36.2 KB	0.0 KB/s	2.8 KB	24:00:29
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
6	icm	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 6		10.7 MB	4.4 MB	15.2 MB	0.0 KB/s	3.3 KB	141:09:36

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	vegas.cm.p.lodz.pl	288	288	443.8 KB	288	0	0	00:00:14
2	web.man.lodz.pl	288	152	149.7 KB	60	0	0	00:00:30
3	212.191.78.190	325	93	176.5 KB	45	2	0	47:32:23
4	lze200.lze.lodz.pl	2	25	41.3 KB	4	0	0	00:11:27
5	dynamic-78-8-239-2.ssp.dialog.net.pl	3	8	8.2 KB	1	0	1	00:22:08
6	staticline-31-182-74-88.toya.net.pl	9	8	7.1 KB	4	0	3	00:25:21
7	ip-176.105.135.22.tvsat364.lodz.pl	4	4	6.5 KB	3	0	0	00:47:24
8	pc26.zsk.p.lodz.pl	2	2	1.5 KB	2	1	0	00:33:32
TOTAL: 8		921	580	834.6 KB	407	3	4	57:28:30

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	288	443.8 KB	288	0	0	00:00:14
2	*.man.lodz.pl	672	152	149.7 KB	60	0	0	00:00:40
3	unresolved	325	93	176.5 KB	45	2	0	47:32:23
4	*.lze.lodz.pl	2	25	41.3 KB	4	0	0	00:11:27
5	*.ssp.dialog.net.pl	3	8	8.2 KB	1	0	1	00:22:08
6	*.toya.net.pl	81	8	7.1 KB	4	0	3	01:56:42
7	*.105.135.22.tvsat364.lodz.pl	4	4	6.5 KB	3	0	0	00:47:24
8	*.zsk.p.lodz.pl	2	2	1.5 KB	2	1	0	00:33:32
9	*.191.14.62.static.jazztel.es	3	0	0.0 KB	0	0	0	06:02:57
10	*.eti.pg.gda.pl	1	0	0.0 KB	0	0	0	00:00:58
TOTAL: 10		1381	580	834.6 KB	407	3	4	57:28:30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.856	4.812	47:32:23
39.191.14.62.static.jazztel.es	8.500	11.744	06:02:57
staticline-31-183-51-127.toya.net.pl	0.016	0.200	01:29:24
ip-176.105.135.22.tvsat364.lodz.pl	0.008	0.064	00:47:24
pc26.zsk.p.lodz.pl	0.292	0.172	00:33:32
staticline-31-182-74-88.toya.net.pl	0.124	0.164	00:25:21
dynamic-78-8-239-2.ssp.dialog.net.pl	0.108	0.060	00:22:08
lze200.lze.lodz.pl	0.008	0.044	00:11:27
staticline-31-182-76-125.toya.net.pl	0.032	0.016	00:01:50
knot1135.eti.pg.gda.pl	0.024	0.024	00:00:58
web.man.lodz.pl	0.500	4.456	00:00:30
vegas.cm.p.lodz.pl	0.660	4.428	00:00:14
mon.man.lodz.pl	0.664	4.412	00:00:07
staticline41435.toya.net.pl	0.140	0.904	00:00:05
david.man.lodz.pl	0.252	1.404	00:00:02
TOTAL: 15	12.184	32.904	57:28:30

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	59
staticline-31-183-51-127.toya.net.pl	12
39.191.14.62.static.jazztel.es	3
staticline-31-182-76-125.toya.net.pl	1
knot1135.eti.pg.gda.pl	1
TOTAL: 7	460

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc26.zsk.p.lodz.pl	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 2	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	288	49.7%
2	pl	273	47.1%
3	lodz	16	2.8%
4	alt	3	0.5%
TOTAL: 4		580	100.0%

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

Newsgroup		Count
1	lodman.info	288
2	pl.comp.pecet	165
3	pl.misc.kolej	26
4	pl.regionalne.warszawa	23
5	lodz.test	16
6	pl.comp.os.linux	15
7	pl.rec.rowery	10
8	pl.soc.prawo	9
9	pl.regionalne.lodz	8
10	pl.misc.telefonia.gsm	7
11	pl.news.admin	2
12	alt.pl.praca.oferowana	2
13	pl.test	2
14	pl.rec.gory	2
15	pl.comp.os.ms-windows.winnt	2
16	pl.misc.dieta	1
17	alt.pl.comp.os.linux.newbie	1
18	pl.praca.dyskusje	1
TOTAL: 18		580

Daily Usenet report

Nov 21 04:15:02 -- Nov 22 04:15:03