Daily Usenet report: Apr 28 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Apr 28 08:45:27 newsfeed nnrpd[32103]: SERVER perl filter not defined
Apr 28 09:37:02 newsfeed nnrpd[1356]: SERVER perl filter not defined
Apr 28 12:38:30 newsfeed nnrpd[7332]: SERVER perl filter not defined
Apr 28 18:31:29 newsfeed nnrpd[19122]: SERVER perl filter not defined
Apr 28 21:13:19 newsfeed nnrpd[24417]: SERVER perl filter not defined
Apr 29 02:50:41 newsfeed overchan[2426]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1716860	98.3%	198.2 MB	97.9%
innd	15293	0.9%	2.5 MB	1.2%
innfeed	7615	0.4%	1.1 MB	0.5%
nnrpd	7054	0.4%	756.7 KB	0.4%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	1746823	100.0%	202.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1712107	98.0%
Negative hits	18409	1.1%
Positive hits	17277	1.0%
Cache misses	134	0.0%
TOTAL: 4	1747927	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.863	0.0%	320	0.000	5.822	118.600
article cleanup	00:00:20.824	0.0%	1716793	0.000	0.012	0.042
article logging	00:00:53.824	0.1%	1716921	0.006	0.031	0.078
article parse	00:38:31.291	2.7%	86061177	0.021	0.027	0.048
article write	00:16:09.860	1.1%	1712714	0.234	0.566	1.268
artlog/artcncl	00:00:00.006	0.0%	305	0.000	0.020	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:01:11.625	0.1%	96774599	0.000	0.001	0.010
hisgrep/artcncl	00:00:00.654	0.0%	292	0.000	2.240	98.800
hishave/artcncl	00:00:00.045	0.0%	320	0.000	0.141	11.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:07:04.633	0.5%	1749012	0.041	0.243	4.077
history sync	00:00:00.019	0.0%	332	0.000	0.057	1.000
history write	00:14:11.018	1.0%	1713462	0.108	0.497	6.756
hiswrite/artcncl	00:00:00.003	0.0%	28	0.000	0.107	0.500
idle	17:57:11.300	74.8%	72972521	0.421	0.886	27.880
nntp read	00:33:40.803	2.3%	84826905	0.017	0.024	0.040
overview write	00:00:11.532	0.0%	1712714	0.000	0.007	0.026
perl filter	03:45:40.015	15.7%	1713461	4.683	7.902	10.570
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:39.119	0.3%	3460591	0.045	0.063	0.135
TOTAL: 23:59:53.875	23:38:48.434	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.189	0.0%	35211	0.000	0.005	1.000
article prepare	00:00:00.013	0.0%	47148	0.000	0.000	0.083
article read	00:00:01.607	0.0%	11469	0.000	0.140	1.000
backlog stats	00:00:00.175	0.0%	279902	0.000	0.001	0.016
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.070	0.0%	165124	0.000	0.013	1.000
data write	00:00:07.940	0.0%	133929	0.000	0.059	3.000
idle	23:59:08.218	100.0%	279902	0.000	308.494	14753.000
status file	00:00:00.157	0.0%	194	0.000	0.809	13.000
TOTAL: 23:59:27.094	23:59:20.369	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.008	0.0%	33	0.242	0.242	0.242
idle	00:58:03.302	99.4%	5226	0.000	666.533	318425.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.498	0.0%	72862	0.000	0.021	1.111
readart	00:00:00.822	0.0%	501	0.000	1.641	34.385
TOTAL: 00:58:24.989	00:58:05.630	99.4%	-	-	-	-

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	651	1712645	1708463	599	3583	99%	171:36:14
2	news.nask.pl	2	17110	3969	12687	454	23%	23:24:56
3	news.icm.edu.pl	50	297	48	210	39	16%	18:17:56
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		709	1730057	1712485	13496	4076	98%	213:19:06

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	517.4 GB	14.7 MB	80.2 MB	517.5 GB	99%	317.0 KB
2	news.nask.pl	15.4 MB	1.3 MB	1.5 MB	18.2 MB	84%	4.2 KB
3	news.icm.edu.pl	1.7 MB	244.4 KB	721.0 KB	2.6 MB	64%	30.9 KB
4	localhost	7.9 KB	0.0 KB	0.0 KB	7.9 KB	100%	1.6 KB
TOTAL: 4		517.4 GB	16.3 MB	82.4 MB	517.5 GB	99%	316.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 28 04:15:02 - 04:59:59	61126	3.6%	22.66	21.8 GB	4.2%	8465.09
Apr 28 05:00:00 - 05:59:59	78887	4.6%	21.91	28.3 GB	5.5%	8229.18
Apr 28 06:00:00 - 06:59:59	85059	5.0%	23.63	28.7 GB	5.6%	8368.59
Apr 28 07:00:00 - 07:59:59	89680	5.2%	24.91	27.4 GB	5.3%	7978.99
Apr 28 08:00:00 - 08:59:59	69321	4.0%	19.26	20.1 GB	3.9%	5840.83
Apr 28 09:00:00 - 09:59:59	90492	5.3%	25.14	27.9 GB	5.4%	8118.19
Apr 28 10:00:00 - 10:59:59	83270	4.9%	23.13	26.1 GB	5.0%	7598.00
Apr 28 11:00:00 - 11:59:59	94908	5.5%	26.36	29.6 GB	5.7%	8614.19
Apr 28 12:00:00 - 12:59:59	87094	5.1%	24.19	28.2 GB	5.5%	8222.19
Apr 28 13:00:00 - 13:59:59	88508	5.2%	24.59	28.9 GB	5.6%	8413.05
Apr 28 14:00:00 - 14:59:59	99594	5.8%	27.66	28.6 GB	5.5%	8335.11
Apr 28 15:00:00 - 15:59:59	87953	5.1%	24.43	26.4 GB	5.1%	7682.35
Apr 28 16:00:00 - 16:59:59	96205	5.6%	26.72	27.5 GB	5.3%	8022.34
Apr 28 17:00:00 - 17:59:59	86485	5.1%	24.02	23.0 GB	4.4%	6687.15
Apr 28 18:00:00 - 18:59:59	65304	3.8%	18.14	17.7 GB	3.4%	5150.24
Apr 28 19:00:00 - 19:59:59	77151	4.5%	21.43	19.3 GB	3.7%	5610.65
Apr 28 20:00:00 - 20:59:59	60169	3.5%	16.71	18.4 GB	3.6%	5346.58
Apr 28 21:00:00 - 21:59:59	12105	0.7%	3.36	1.6 GB	0.3%	465.64
Apr 28 22:00:00 - 22:59:59	14597	0.9%	4.05	2.2 GB	0.4%	632.87
Apr 28 23:00:00 - 23:59:59	14064	0.8%	3.91	2.3 GB	0.4%	662.50
Apr 29 00:00:00 - 00:59:59	65094	3.8%	18.08	19.6 GB	3.8%	5713.03
Apr 29 01:00:00 - 01:59:59	66072	3.9%	18.35	19.1 GB	3.7%	5563.49
Apr 29 02:00:00 - 02:59:59	53887	3.1%	14.97	16.9 GB	3.3%	4925.64
Apr 29 03:00:00 - 03:59:59	74676	4.4%	20.74	24.3 GB	4.7%	7084.38
Apr 29 04:00:00 - 04:15:01	10646	0.6%	11.82	3.2 GB	0.6%	3704.33
TOTAL: 23:59:59	1712347	100.0%	19.82	516.8 GB	100.0%	6272.42

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3697	190	2912	14	581
2	news.nask.pl	473	12	416	20	25
3	news.icm.edu.pl	38	0	4	1	33
TOTAL: 3		4208	202	3332	35	639

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	71
it.tlc.cellulari.android	36
comp.sys.raspberry-pi	29
uk.rec.cycling.moderated	13
uk.net.providers.gradwell	11
it.comp.os.win.windows7	8
hr.ponuda.hardver.komponente	7
de.comp.lang.vbclassic	4
comp.mobile.android	4
hr.alt.cellular.gsm.android	3
nl.wetenschap.regulier	3
nl.comp.os.linux.techniek	3
hr.ponuda.hardver.ostalo	2
it.comp.os.linux.ubuntu	2
de.comm.software.mailreader	2
it.comp.os.win.windows8	2
alt.sex.telephones	1
hr.ponuda.hardver.konfiguracije	1
TOTAL: 18	202

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

Groups	Count
pl.praca.oferowana	32
pl.sci.matematyka	2
pl.sci.historia	1
TOTAL: 3	35

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	463
EMP (md5)	46
Attached HTML file	1
TOTAL: 3	510

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	44312	2903	31885	376	0	6%	23:57:53
2	icm	44188	1390	26090	6596	60	3%	23:57:39
3	nask	26059	56	14060	411	0	0%	23:53:41
4	poznan	6141	46	3974	18	0	0%	24:04:54
5	okapi	0	0	0	0	3095	0%	24:00:01
TOTAL: 5		120700	4395	76009	7401	3155	3%	119:54:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	9.3 MB	1.7 MB	11.0 MB	0.1 KB/s	3.4 KB	23:57:53
2	icm	7.2 MB	1.2 GB	1.2 GB	14.3 KB/s	154.5 KB	23:57:39
3	nask	467.5 KB	101.0 MB	101.5 MB	1.2 KB/s	222.6 KB	23:53:41
4	poznan	127.9 KB	125.2 KB	253.1 KB	0.0 KB/s	4.0 KB	24:04:54
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		17.1 MB	1.3 GB	1.3 GB	3.1 KB/s	114.4 KB	119:54:08

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	348	599.0 KB	288	0	00:00:07
2	auriga.rz.izeto.pl	6	67	133.4 KB	2	0	00:05:58
3	web.man.lodz.pl	287	60	52.1 KB	24	0	00:00:27
4	lze200.lze.lodz.pl	2	17	28.6 KB	3	0	00:07:38
5	212.51.205.200	2	9	14.2 KB	1	0	00:03:16
6	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 6		590	501	827.1 KB	318	5	00:58:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	348	599.0 KB	288	0	00:00:07
2	*.rz.izeto.pl	6	67	133.4 KB	2	0	00:05:58
3	*.man.lodz.pl	676	60	52.1 KB	24	5	00:00:32
4	*.lze.lodz.pl	2	17	28.6 KB	3	0	00:07:38
5	unresolved	4	9	14.2 KB	1	0	00:21:34
6	*.p.lodz.pl	2	0	0.0 KB	0	0	00:21:27
7	*.elsnet.pl	4	0	0.0 KB	0	0	00:01:01
8	*.toya.net.pl	33	0	0.0 KB	0	0	00:00:02
TOTAL: 8		1015	501	827.1 KB	318	5	00:58:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
r8ds.p.lodz.pl	0.311	0.128	00:21:27
89.38.41.242	0.064	0.099	00:18:18
lze200.lze.lodz.pl	0.014	0.042	00:07:38
auriga.rz.izeto.pl	0.039	0.094	00:05:58
212.51.205.200	0.007	0.020	00:03:16
host227.elsnet.pl	0.006	0.056	00:01:01
web.man.lodz.pl	1.113	4.755	00:00:27
pc-skrzep2.cm.p.lodz.pl	1.098	4.223	00:00:07
mon.man.lodz.pl	1.106	4.220	00:00:03
staticline41435.toya.net.pl	0.096	0.488	00:00:02
david.man.lodz.pl	0.386	1.290	00:00:01
isvcs01.man.lodz.pl	0.040	0.086	00:00:00
TOTAL: 12	4.280	15.501	00:58:24

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	33
host227.elsnet.pl	4
r8ds.p.lodz.pl	2
89.38.41.242	2
TOTAL: 6	425

NNRP client timeouts [Top 20]:

System	Conn	Peer
89.38.41.242	2	0
TOTAL: 1	2	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	415	82.8%
2	pl	86	17.2%
TOTAL: 2		501	100.0%

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

Newsgroup		Count
1	lodman.info	415
2	pl.comp.pecet	82
3	pl.rec.dom	2
4	pl.misc.telefonia.gsm	2
TOTAL: 4		501

Daily Usenet report

Apr 28 04:15:02 -- Apr 29 04:15:01