Daily Usenet report: Jun 23 04:15:03

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jun 23 10:45:14 newsfeed nnrpd[9470]: SERVER perl filter not defined
Jun 23 13:49:43 newsfeed nnrpd[15540]: SERVER perl filter not defined
Jun 23 15:19:09 newsfeed nnrpd[18620]: SERVER perl filter not defined
Jun 23 21:47:40 newsfeed nnrpd[31661]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1477675	97.5%	166.9 MB	96.9%
innd	21387	1.4%	3.2 MB	1.9%
nnrpd	9834	0.6%	1.1 MB	0.6%
innfeed	7365	0.5%	1.1 MB	0.6%
TOTAL: 4	1516261	100.0%	172.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1472619	94.4%
Negative hits	65964	4.2%
Positive hits	20782	1.3%
Cache misses	140	0.0%
TOTAL: 4	1559505	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:06.456	0.0%	503	0.000	12.835	273.000
article cleanup	00:00:17.786	0.0%	1476816	0.000	0.012	0.041
article logging	00:00:41.625	0.0%	1476936	0.005	0.028	0.769
article parse	00:36:14.022	2.5%	246844675	0.004	0.009	0.046
article write	00:11:15.197	0.8%	1462982	0.163	0.462	2.071
artlog/artcncl	00:00:00.006	0.0%	486	0.000	0.012	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:01:49.554	0.1%	257189272	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.985	0.0%	273	0.000	3.608	97.000
hishave/artcncl	00:00:00.627	0.0%	503	0.000	1.247	19.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:12:08.776	5.0%	1559554	0.084	2.776	12.618
history sync	00:00:00.217	0.0%	293	0.000	0.741	201.000
history write	01:47:56.009	7.5%	1472853	0.068	4.397	72.495
hiswrite/artcncl	00:00:00.622	0.0%	230	0.000	2.704	138.000
idle	16:02:19.079	66.9%	208903309	0.152	0.276	4.454
nntp read	00:44:25.057	3.1%	245770069	0.006	0.011	0.042
overview write	00:00:07.570	0.0%	1462982	0.000	0.005	0.017
perl filter	02:33:20.857	10.7%	1472850	3.201	6.247	11.574
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:34.273	0.2%	2962798	0.011	0.052	0.131
TOTAL: 23:59:21.731	23:13:18.718	96.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.110	0.0%	36869	0.000	0.003	0.500
article prepare	00:00:00.006	0.0%	33362	0.000	0.000	0.031
article read	00:00:00.599	0.0%	7479	0.000	0.080	1.000
backlog stats	00:00:00.165	0.0%	319071	0.000	0.001	0.024
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.506	0.0%	173385	0.000	0.009	1.000
data write	00:00:04.365	0.0%	152821	0.000	0.029	2.000
idle	23:59:57.758	100.0%	319071	0.000	270.779	16080.000
status file	00:00:00.538	0.0%	193	0.000	2.788	88.500
TOTAL: 24:00:10.707	24:00:05.047	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	19:45:48.206	99.9%	181444	0.000	392.122	360541.600
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.195	0.0%	365329	0.000	0.011	1.222
readart	00:00:01.068	0.0%	417	0.000	2.561	22.000
TOTAL: 19:46:35.078	19:45:53.469	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	289	1471805	1457229	1533	13043	99%	113:53:09
2	news.nask.pl	2	21730	6005	14934	791	27%	24:04:19
3	news.icm.edu.pl	41	294	7	276	11	2%	17:47:05
4	localhost	5	4	4	0	0	100%	00:00:02
TOTAL: 4		337	1493833	1463245	16743	13845	97%	155:44:35

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	473.0 GB	25.6 MB	1.2 GB	474.2 GB	99%	338.2 KB
2	news.nask.pl	71.3 MB	2.2 MB	2.3 MB	75.8 MB	94%	11.4 KB
3	news.icm.edu.pl	263.8 KB	0.0 KB	142.6 KB	406.4 KB	64%	22.6 KB
4	localhost	7.0 KB	0.0 KB	0.0 KB	7.0 KB	100%	1.7 KB
TOTAL: 4		473.0 GB	27.8 MB	1.2 GB	474.3 GB	99%	336.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 23 04:15:03 - 04:59:59	54454	3.7%	20.19	18.9 GB	4.0%	7338.39
Jun 23 05:00:00 - 05:59:59	79282	5.4%	22.02	26.9 GB	5.7%	7831.95
Jun 23 06:00:00 - 06:59:59	83379	5.7%	23.16	28.6 GB	6.0%	8336.02
Jun 23 07:00:00 - 07:59:59	86644	5.9%	24.07	28.8 GB	6.1%	8374.51
Jun 23 08:00:00 - 08:59:59	75847	5.2%	21.07	25.2 GB	5.3%	7337.25
Jun 23 09:00:00 - 09:59:59	66396	4.5%	18.44	21.5 GB	4.5%	6268.28
Jun 23 10:00:00 - 10:59:59	59181	4.0%	16.44	18.4 GB	3.9%	5345.30
Jun 23 11:00:00 - 11:59:59	60348	4.1%	16.76	19.8 GB	4.2%	5773.80
Jun 23 12:00:00 - 12:59:59	78853	5.4%	21.90	24.5 GB	5.2%	7134.67
Jun 23 13:00:00 - 13:59:59	56141	3.8%	15.59	17.8 GB	3.8%	5173.56
Jun 23 14:00:00 - 14:59:59	66517	4.5%	18.48	22.1 GB	4.7%	6428.33
Jun 23 15:00:00 - 15:59:59	46509	3.2%	12.92	14.8 GB	3.1%	4311.89
Jun 23 16:00:00 - 16:59:59	97666	6.7%	27.13	32.4 GB	6.8%	9424.05
Jun 23 17:00:00 - 17:59:59	47037	3.2%	13.07	15.6 GB	3.3%	4550.42
Jun 23 18:00:00 - 18:59:59	33192	2.3%	9.22	8.5 GB	1.8%	2482.13
Jun 23 19:00:00 - 19:59:59	38149	2.6%	10.60	10.2 GB	2.1%	2963.74
Jun 23 20:00:00 - 20:59:59	60646	4.1%	16.85	14.9 GB	3.2%	4350.08
Jun 23 21:00:00 - 21:59:59	39839	2.7%	11.07	14.6 GB	3.1%	4263.42
Jun 23 22:00:00 - 22:59:59	30570	2.1%	8.49	8.1 GB	1.7%	2362.55
Jun 23 23:00:00 - 23:59:59	34366	2.3%	9.55	10.6 GB	2.2%	3097.76
Jun 24 00:00:00 - 00:59:59	44501	3.0%	12.36	13.7 GB	2.9%	3997.85
Jun 24 01:00:00 - 01:59:59	41634	2.8%	11.56	13.3 GB	2.8%	3884.19
Jun 24 02:00:00 - 02:59:59	86902	5.9%	24.14	29.4 GB	6.2%	8561.22
Jun 24 03:00:00 - 03:59:59	84703	5.8%	23.53	30.9 GB	6.5%	9002.93
Jun 24 04:00:00 - 04:15:04	10473	0.7%	11.59	4.0 GB	0.8%	4603.69
TOTAL: 24:00:01	1463229	100.0%	16.94	473.5 GB	100.0%	5746.17

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	13158	369	3212	6	9571
2	news.nask.pl	791	8	756	14	13
3	news.icm.edu.pl	11	0	0	0	11
TOTAL: 3		13960	377	3968	20	9595

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	227
it.tlc.cellulari.android	65
it.comp.os.win.windows7	28
comp.mobile.ipad	15
nl.comp.sys.android	10
uk.rec.cycling.moderated	7
it.discussioni.energia	6
comp.mobile.android	5
nl.wetenschap.regulier	5
nl.comp.os.linux.techniek	2
hr.ponuda.hardver.komponente	2
it.comp.os.win.windows8	2
de.rec.sf.startrek	1
alt.sex.telephones	1
hr.ponuda.hardver.periferije	1
TOTAL: 15	377

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

Groups	Count
pl.sci.historia	13
pl.sci.matematyka	6
bit.listserv.catholic	1
TOTAL: 3	20

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	9434
Attached HTML file	17
EMP (md5)	15
HTML post	3
Scoring filter (9)	2
Scoring filter (12)	1
TOTAL: 6	9472

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	45942	3076	33200	632	0	0	6%	24:00:42
2	icm	59426	1713	30510	1739	0	20	2%	24:02:15
3	nask	29388	1028	16116	13	0	1	3%	23:53:20
4	poznan	8417	96	5564	54	1	0	1%	23:56:05
5	okapi	0	0	0	0	0	2557	0%	24:00:01
6	task	0	0	0	0	0	962	0%	24:00:01
TOTAL: 6		143173	5913	85390	2438	1	3540	4%	143:52:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	159.2 MB	353.7 MB	512.9 MB	6.1 KB/s	152.1 KB	24:02:15
2	nask	89.5 MB	1.1 MB	90.5 MB	1.1 KB/s	89.1 KB	23:53:20
3	panorama	16.0 MB	14.7 MB	30.6 MB	0.4 KB/s	8.5 KB	24:00:42
4	poznan	259.0 KB	106.5 KB	365.4 KB	0.0 KB/s	2.4 KB	23:56:05
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
6	task	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 6		264.9 MB	369.5 MB	634.4 MB	1.3 KB/s	77.8 KB	143:52:24

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	336	592.1 KB	288	0	00:00:10
2	web.man.lodz.pl	288	70	60.6 KB	29	0	00:00:24
3	194.33.77.50	1	8	12.5 KB	1	0	00:00:44
4	pc-vicki.man.lodz.pl	2	2	4.1 KB	1	0	00:52:40
5	router2.cbmm.lodz.pl	3	1	1.3 KB	1	0	00:00:32
6	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:01
TOTAL: 6		586	417	670.7 KB	320	4	19:46:34

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	336	592.1 KB	288	0	00:00:10
2	*.man.lodz.pl	678	72	64.8 KB	30	4	00:53:12
3	unresolved	3	8	12.5 KB	1	0	00:02:59
4	*.cbmm.lodz.pl	3	1	1.3 KB	1	0	00:00:32
5	*.pa.nsw.optusnet.com.au	570	0	0.0 KB	0	0	00:31:22
6	*.wroclaw.mm.pl	76	0	0.0 KB	0	0	12:33:23
7	*.205.15.62.static.jazztel.es	2	0	0.0 KB	0	0	05:34:00
8	*.zb.lnet.pl	2	0	0.0 KB	0	0	00:10:42
9	*.toya.net.pl	72	0	0.0 KB	0	0	00:00:10
TOTAL: 9		1694	417	670.7 KB	320	4	19:46:34

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
host-89-231-50-15.wroclaw.mm.pl	0.104	0.672	12:33:23
184.205.15.62.static.jazztel.es	7.944	7.520	05:34:00
pc-vicki.man.lodz.pl	0.008	0.008	00:52:40
pa49-181-246-126.pa.nsw.optusnet.com.au	1.004	5.464	00:31:22
nat00.zb.lnet.pl	0.036	0.024	00:10:42
212.51.203.199	0.000	0.012	00:02:14
194.33.77.50	0.008	0.008	00:00:44
router2.cbmm.lodz.pl	0.000	0.036	00:00:32
web.man.lodz.pl	0.656	3.804	00:00:24
pc-skrzep2.cm.p.lodz.pl	0.472	3.108	00:00:10
staticline41435.toya.net.pl	0.148	0.824	00:00:10
mon.man.lodz.pl	0.496	3.072	00:00:03
isvcs01.man.lodz.pl	0.004	0.032	00:00:01
david.man.lodz.pl	0.152	1.044	00:00:01
TOTAL: 14	11.032	25.628	19:46:34

Curious NNRP server explorers [Top 20]:

System	Conn
pa49-181-246-126.pa.nsw.optusnet.com.au	570
mon.man.lodz.pl	288
david.man.lodz.pl	96
host-89-231-50-15.wroclaw.mm.pl	76
staticline41435.toya.net.pl	72
184.205.15.62.static.jazztel.es	2
nat00.zb.lnet.pl	2
212.51.203.199	2
TOTAL: 8	1108

NNRP client timeouts [Top 20]:

System	Conn	Peer
pa49-181-246-126.pa.nsw.optusnet.com.au	2	0
184.205.15.62.static.jazztel.es	1	1
pc-vicki.man.lodz.pl	1	0
TOTAL: 3	4	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	344	82.5%
2	pl	73	17.5%
TOTAL: 2		417	100.0%

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

Newsgroup		Count
1	lodman.info	344
2	pl.comp.pecet	70
3	pl.sci.medycyna	2
4	pl.sci.chemia	1
TOTAL: 4		417

Daily Usenet report

Jun 23 04:15:03 -- Jun 24 04:15:04