Daily Usenet report: Sep 20 04:15:03

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Sep 20 09:19:35 newsfeed nnrpd[9032]: SERVER perl filter not defined
Sep 20 09:52:04 newsfeed nnrpd[10163]: SERVER perl filter not defined
Sep 20 10:13:29 newsfeed nnrpd[10819]: SERVER perl filter not defined
Sep 20 14:00:04 newsfeed nnrpd[17869]: SERVER perl filter not defined
Sep 20 14:49:26 newsfeed nnrpd[19369]: SERVER perl filter not defined
Sep 20 16:06:10 newsfeed nnrpd[21880]: SERVER perl filter not defined
Sep 20 16:08:23 newsfeed nnrpd[21900]: SERVER perl filter not defined
Sep 20 16:26:05 newsfeed nnrpd[22507]: SERVER perl filter not defined
Sep 20 17:08:00 newsfeed nnrpd[23782]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2406957	98.2%	269.0 MB	97.7%
innd	29553	1.2%	4.5 MB	1.6%
nnrpd	7406	0.3%	782.3 KB	0.3%
innfeed	7038	0.3%	1.1 MB	0.4%
TOTAL: 4	2450954	100.0%	275.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2400944	94.0%
Negative hits	110793	4.3%
Positive hits	38712	1.5%
Cache misses	4484	0.2%
TOTAL: 4	2554933	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:06.554	0.0%	315	0.000	20.806	600.000
article cleanup	00:00:32.586	0.0%	2405966	0.004	0.014	0.026
article logging	00:01:25.924	0.1%	2406168	0.010	0.036	0.670
article parse	01:13:53.106	5.1%	74758500	0.013	0.059	0.094
article write	00:25:45.350	1.8%	2389607	0.325	0.647	1.501
artlog/artcncl	00:00:00.006	0.0%	313	0.000	0.019	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:25.351	0.2%	88828329	0.000	0.002	0.005
hisgrep/artcncl	00:00:01.501	0.0%	256	0.000	5.863	248.000
hishave/artcncl	00:00:00.911	0.0%	315	0.000	2.892	304.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:37:59.972	15.1%	2555765	0.388	5.118	13.904
history sync	00:00:00.017	0.0%	290	0.000	0.059	1.000
history write	04:56:27.824	20.6%	2401683	1.297	7.406	22.567
hiswrite/artcncl	00:00:00.169	0.0%	59	0.000	2.864	20.000
idle	06:21:14.615	26.5%	34584253	0.213	0.661	7.230
nntp read	00:42:40.594	3.0%	72786729	0.010	0.035	0.051
overview write	00:00:14.725	0.0%	2389607	0.001	0.006	0.014
perl filter	06:09:27.988	25.7%	2401681	4.022	9.230	11.464
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:22.475	0.3%	4823085	0.024	0.054	0.073
TOTAL: 23:59:45.975	23:36:39.668	98.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.147	0.0%	43894	0.000	0.003	0.125
article prepare	00:00:00.009	0.0%	42064	0.000	0.000	0.062
article read	00:00:01.797	0.0%	10182	0.000	0.176	38.000
backlog stats	00:00:00.249	0.0%	317605	0.000	0.001	0.017
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.416	0.0%	186540	0.000	0.013	0.069
data write	00:00:06.491	0.0%	163064	0.000	0.040	1.000
idle	23:59:58.359	100.0%	317605	0.000	272.031	15076.000
status file	00:00:00.782	0.0%	231	0.000	3.385	114.250
TOTAL: 24:00:17.489	24:00:10.250	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.000	0.0%	8	0.000	0.000	0.000
idle	22:23:31.519	99.9%	470264	0.000	171.418	900077.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:16.179	0.0%	942631	0.000	0.017	1.400
readart	00:00:01.740	0.0%	526	0.000	3.308	136.000
TOTAL: 22:24:47.043	22:23:49.438	99.9%	-	-	-	-

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	827	2400092	2377534	8212	14346	99%	463:31:59
2	news.nask.pl	8	16467	7880	7713	874	47%	24:27:43
3	news.task.gda.pl	13	29020	6458	21474	1088	22%	44:06:50
4	news.icm.edu.pl	41	290	12	260	18	4%	18:46:44
5	localhost	10	9	9	0	0	100%	00:00:00
TOTAL: 5		899	2445878	2391893	37659	16326	97%	550:53:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	856.1 GB	150.2 MB	1.6 GB	857.9 GB	99%	376.1 KB
2	news.nask.pl	177.8 MB	3.4 MB	3.5 MB	184.7 MB	96%	21.6 KB
3	news.task.gda.pl	13.1 MB	61.1 KB	3.2 MB	16.3 MB	80%	2.2 KB
4	news.icm.edu.pl	777.8 KB	80.4 KB	1.1 MB	1.9 MB	39%	66.2 KB
5	localhost	13.9 KB	0.0 KB	0.0 KB	13.9 KB	100%	1.5 KB
TOTAL: 5		856.3 GB	153.7 MB	1.7 GB	858.1 GB	99%	373.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 20 04:15:03 - 04:59:59	67548	2.8%	25.05	26.0 GB	3.0%	10107.09
Sep 20 05:00:00 - 05:59:59	82137	3.4%	22.82	31.5 GB	3.7%	9178.27
Sep 20 06:00:00 - 06:59:59	88249	3.7%	24.51	34.1 GB	4.0%	9945.55
Sep 20 07:00:00 - 07:59:59	86217	3.6%	23.95	33.3 GB	3.9%	9688.49
Sep 20 08:00:00 - 08:59:59	102677	4.3%	28.52	38.0 GB	4.4%	11054.76
Sep 20 09:00:00 - 09:59:59	101150	4.2%	28.10	37.5 GB	4.4%	10918.67
Sep 20 10:00:00 - 10:59:59	101297	4.2%	28.14	37.3 GB	4.4%	10858.27
Sep 20 11:00:00 - 11:59:59	102317	4.3%	28.42	35.9 GB	4.2%	10444.55
Sep 20 12:00:00 - 12:59:59	92990	3.9%	25.83	32.2 GB	3.8%	9367.03
Sep 20 13:00:00 - 13:59:59	105805	4.4%	29.39	37.2 GB	4.4%	10846.00
Sep 20 14:00:00 - 14:59:59	103282	4.3%	28.69	36.3 GB	4.3%	10587.26
Sep 20 15:00:00 - 15:59:59	99154	4.1%	27.54	34.6 GB	4.0%	10082.92
Sep 20 16:00:00 - 16:59:59	98572	4.1%	27.38	32.0 GB	3.7%	9330.35
Sep 20 17:00:00 - 17:59:59	117015	4.9%	32.50	40.1 GB	4.7%	11679.65
Sep 20 18:00:00 - 18:59:59	118643	5.0%	32.96	39.8 GB	4.7%	11595.04
Sep 20 19:00:00 - 19:59:59	118757	5.0%	32.99	40.4 GB	4.7%	11765.09
Sep 20 20:00:00 - 20:59:59	113501	4.7%	31.53	39.4 GB	4.6%	11489.12
Sep 20 21:00:00 - 21:59:59	99248	4.2%	27.57	34.4 GB	4.0%	10027.88
Sep 20 22:00:00 - 22:59:59	106271	4.4%	29.52	34.2 GB	4.0%	9968.85
Sep 20 23:00:00 - 23:59:59	103431	4.3%	28.73	36.5 GB	4.3%	10635.39
Sep 21 00:00:00 - 00:59:59	89513	3.7%	24.86	31.6 GB	3.7%	9217.11
Sep 21 01:00:00 - 01:59:59	86071	3.6%	23.91	32.4 GB	3.8%	9437.75
Sep 21 02:00:00 - 02:59:59	85415	3.6%	23.73	32.9 GB	3.9%	9595.74
Sep 21 03:00:00 - 03:59:59	96193	4.0%	26.72	37.4 GB	4.4%	10893.15
Sep 21 04:00:00 - 04:15:03	24627	1.0%	27.27	9.8 GB	1.1%	11335.27
TOTAL: 24:00:00	2390080	100.0%	27.66	854.9 GB	100.0%	10375.92

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	14494	265	3417	1	10811
2	news.task.gda.pl	1114	918	31	0	165
3	news.nask.pl	938	32	833	2	71
4	news.icm.edu.pl	18	0	4	0	14
TOTAL: 4		16564	1215	4285	3	11061

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	74
mailing.freebsd.svn-ports-head	74
mailing.freebsd.ports-bugs	61
uk.railway	51
mozilla.dev.tree-management	51
mailing.gcc.gcc-cvs	47
comp.mobile.ipad	46
fr.usenet.abus.nocem	46
uk.rec.cycling.moderated	45
mozilla.dev.platform	41
alt.windows7.general	40
it.tlc.cellulari.android	33
mailing.postfix.users	32
mailing.openbsd.misc	32
alt.politics.scorched-earth	31
mailing.openbsd.ports-changes	30
fa.freebsd.cvs-all	29
comp.sys.raspberry-pi	28
mailing.freebsd.svn-src-all	27
mailing.freebsd.current	26
TOTAL: 79	1215

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	10673
EMP (fsl)	140
EMP (md5)	41
HTML post	1
Scoring filter (11)	1
Attached HTML file	1
TOTAL: 6	10857

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	45123	3731	39235	912	0	0	8%	23:58:15
2	icm	61805	1627	34675	4086	2	10	2%	23:50:30
3	poznan	15589	54	13084	22	0	0	0%	24:00:22
4	task	2136	33	1157	5	0	0	1%	21:48:01
5	nask	17092	16	13104	7	0	0	0%	23:59:59
6	okapi	0	0	0	0	0	2421	0%	24:00:01
TOTAL: 6		141745	5461	101255	5032	2	2431	3%	141:37:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	53.5 MB	1.4 GB	1.5 GB	17.8 KB/s	267.4 KB	23:50:30
2	panorama	16.5 MB	4.2 MB	20.7 MB	0.2 KB/s	4.6 KB	23:58:15
3	nask	1.5 MB	1.5 MB	3.0 MB	0.0 KB/s	133.4 KB	23:59:59
4	poznan	328.8 KB	41.4 KB	370.2 KB	0.0 KB/s	4.9 KB	24:00:22
5	task	67.9 KB	7.6 KB	75.4 KB	0.0 KB/s	2.0 KB	21:48:01
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 6		71.9 MB	1.4 GB	1.5 GB	3.0 KB/s	148.0 KB	141:37:08

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	386	620.7 KB	288	0	00:00:09
2	web.man.lodz.pl	288	58	55.3 KB	29	0	00:00:19
3	lze200.lze.lodz.pl	4	52	85.0 KB	6	0	00:53:58
4	staticline-31-182-72-163.toya.net.pl	6	25	41.4 KB	6	0	00:31:05
5	router2.cbmm.lodz.pl	4	5	7.3 KB	3	0	00:37:56
6	kujawiak.man.lodz.pl	9	0	0.0 KB	0	9	00:00:01
TOTAL: 6		599	526	809.7 KB	332	9	22:24:46

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	386	620.7 KB	288	0	00:00:09
2	*.man.lodz.pl	681	58	55.3 KB	29	9	00:00:32
3	*.lze.lodz.pl	4	52	85.0 KB	6	0	00:53:58
4	*.toya.net.pl	88	25	41.4 KB	6	0	00:34:01
5	*.cbmm.lodz.pl	4	5	7.3 KB	3	0	00:37:56
6	*.191.14.62.static.jazztel.es	8	0	0.0 KB	0	0	04:44:31
7	*.neoplus.adsl.tpnet.pl	8	0	0.0 KB	0	0	02:16:10
8	*.181.14.62.static.jazztel.es	2	0	0.0 KB	0	0	02:30:30
9	*.internetdsl.tpnet.pl	4	0	0.0 KB	0	0	00:00:00
TOTAL: 9		1087	526	809.7 KB	332	9	22:24:46

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
119.207.15.62.static.jazztel.es	19.777	32.062	10:46:53
106.191.14.62.static.jazztel.es	3.552	5.952	02:54:38
247.191.14.62.static.jazztel.es	2.416	3.844	01:49:53
20.181.14.62.static.jazztel.es	2.480	4.148	01:39:32
aami169.neoplus.adsl.tpnet.pl	0.052	0.128	01:30:41
lze200.lze.lodz.pl	0.028	0.084	00:53:58
233.181.14.62.static.jazztel.es	0.668	1.180	00:50:58
bzb28.neoplus.adsl.tpnet.pl	0.068	0.068	00:45:28
router2.cbmm.lodz.pl	0.004	0.080	00:37:56
staticline-31-182-72-163.toya.net.pl	0.020	0.096	00:31:05
staticline-31-182-67-174.toya.net.pl	0.000	0.040	00:02:42
web.man.lodz.pl	0.768	4.636	00:00:19
staticline41435.toya.net.pl	0.144	1.260	00:00:13
f-oper-v100.man.lodz.pl	0.668	4.864	00:00:10
vegas.cm.p.lodz.pl	0.696	4.548	00:00:09
kujawiak.man.lodz.pl	0.036	0.184	00:00:01
david.man.lodz.pl	0.212	1.392	00:00:01
gcq193.internetdsl.tpnet.pl	0.008	0.072	00:00:00
TOTAL: 18	31.597	64.638	22:24: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	80
106.191.14.62.static.jazztel.es	6
aami169.neoplus.adsl.tpnet.pl	4
bzb28.neoplus.adsl.tpnet.pl	4
gcq193.internetdsl.tpnet.pl	4
staticline-31-182-67-174.toya.net.pl	2
247.191.14.62.static.jazztel.es	2
233.181.14.62.static.jazztel.es	1
20.181.14.62.static.jazztel.es	1
TOTAL: 11	488

NNRP client timeouts [Top 20]:

System	Conn	Peer
aami169.neoplus.adsl.tpnet.pl	2	0
233.181.14.62.static.jazztel.es	1	0
20.181.14.62.static.jazztel.es	1	0
247.191.14.62.static.jazztel.es	1	0
router2.cbmm.lodz.pl	1	0
TOTAL: 5	6	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	403	76.6%
2	pl	115	21.9%
3	lodz	8	1.5%
TOTAL: 3		526	100.0%

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

Newsgroup		Count
1	lodman.info	391
2	pl.comp.pecet	42
3	pl.misc.telefonia.gsm	30
4	pl.comp.os.ms-windows.winnt	20
5	lodman.test	12
6	pl.rec.kuchnia	9
7	pl.rec.dom	7
8	lodz.test	7
9	pl.regionalne.lodz	4
10	pl.rec.gory	2
11	lodz.ogloszenia	1
12	pl.sci.chemia	1
TOTAL: 12		526

Daily Usenet report

Sep 20 04:15:03 -- Sep 21 04:15:03