Daily Usenet report: May 12 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

May 12 09:15:16 newsfeed overchan[2297]: input line too long, skipping
May 12 09:39:07 newsfeed nnrpd[11068]: SERVER perl filter not defined
May 13 00:39:01 newsfeed nnrpd[9646]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1747730	98.3%	198.2 MB	97.9%
innd	14646	0.8%	2.4 MB	1.2%
innfeed	7880	0.4%	1.2 MB	0.6%
nnrpd	7052	0.4%	742.5 KB	0.4%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	1777309	100.0%	202.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1743300	98.0%
Negative hits	18128	1.0%
Positive hits	17510	1.0%
Cache misses	161	0.0%
TOTAL: 4	1779099	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.562	0.0%	359	0.000	7.136	242.500
article cleanup	00:00:21.512	0.0%	1747519	0.000	0.012	0.030
article logging	00:00:55.688	0.1%	1747642	0.015	0.032	0.060
article parse	00:43:10.768	3.0%	104660951	0.008	0.025	0.043
article write	00:15:58.105	1.1%	1743355	0.124	0.550	1.207
artlog/artcncl	00:00:00.011	0.0%	344	0.000	0.032	1.000
data move	00:01:22.262	0.1%	116180916	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.886	0.0%	300	0.000	2.953	160.000
hishave/artcncl	00:00:00.031	0.0%	359	0.000	0.086	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:06:59.676	0.5%	1779796	0.012	0.236	5.511
history sync	00:00:00.017	0.0%	301	0.000	0.056	2.000
history write	00:13:15.283	0.9%	1744284	0.082	0.456	5.877
hiswrite/artcncl	00:00:00.008	0.0%	59	0.000	0.136	3.000
idle	17:38:10.757	73.5%	90604279	0.319	0.701	133.051
nntp read	00:39:37.192	2.8%	103398642	0.014	0.023	0.032
overview write	00:00:11.193	0.0%	1743355	0.000	0.006	0.028
perl filter	03:57:12.756	16.5%	1744284	4.492	8.160	13.727
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:37.275	0.3%	3516196	0.041	0.062	0.133
TOTAL: 24:00:19.113	23:40:55.982	98.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.127	0.0%	29505	0.000	0.004	0.143
article prepare	00:00:00.008	0.0%	26236	0.000	0.000	0.125
article read	00:00:00.450	0.0%	6082	0.000	0.074	1.000
backlog stats	00:00:00.159	0.0%	267119	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.794	0.0%	151927	0.000	0.012	1.000
data write	00:00:04.909	0.0%	125202	0.000	0.039	2.000
idle	24:00:30.578	100.0%	267119	0.000	323.566	30099.000
status file	00:00:00.155	0.0%	204	0.000	0.760	2.000
TOTAL: 24:00:43.993	24:00:38.180	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.000	0.0%	10	0.000	0.000	0.000
idle	00:43:41.947	99.3%	5033	0.000	520.951	227545.375
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.345	0.0%	11816	0.000	0.029	1.111
readart	00:00:00.101	0.0%	392	0.000	0.258	3.000
TOTAL: 00:44:01.277	00:43:42.393	99.3%	-	-	-	-

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	452	1743703	1739263	612	3828	99%	152:27:15
2	news.nask.pl	2	17058	4013	12774	271	23%	22:41:18
3	news.icm.edu.pl	42	249	26	207	16	10%	16:53:38
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		499	1761012	1743304	13593	4115	98%	192:02:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	581.0 GB	16.4 MB	109.4 MB	581.1 GB	99%	349.6 KB
2	news.nask.pl	27.3 MB	736.7 KB	802.8 KB	28.8 MB	94%	6.9 KB
3	news.icm.edu.pl	931.5 KB	17.8 KB	404.4 KB	1.3 MB	68%	32.2 KB
4	localhost	3.4 KB	0.0 KB	0.0 KB	3.4 KB	100%	1.7 KB
TOTAL: 4		581.0 GB	17.1 MB	110.6 MB	581.1 GB	99%	348.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 12 04:15:02 - 04:59:59	56969	3.3%	21.12	21.2 GB	3.7%	8255.19
May 12 05:00:00 - 05:59:59	73808	4.2%	20.50	28.0 GB	4.8%	8155.58
May 12 06:00:00 - 06:59:59	46233	2.7%	12.84	16.3 GB	2.8%	4748.08
May 12 07:00:00 - 07:59:59	71110	4.1%	19.75	25.9 GB	4.5%	7537.78
May 12 08:00:00 - 08:59:59	48589	2.8%	13.50	16.3 GB	2.8%	4740.69
May 12 09:00:00 - 09:59:59	68395	3.9%	19.00	25.1 GB	4.3%	7300.46
May 12 10:00:00 - 10:59:59	73111	4.2%	20.31	26.9 GB	4.6%	7821.82
May 12 11:00:00 - 11:59:59	69003	4.0%	19.17	25.6 GB	4.4%	7453.29
May 12 12:00:00 - 12:59:59	74372	4.3%	20.66	25.6 GB	4.4%	7463.98
May 12 13:00:00 - 13:59:59	79344	4.6%	22.04	26.6 GB	4.6%	7752.27
May 12 14:00:00 - 14:59:59	73481	4.2%	20.41	23.9 GB	4.1%	6968.82
May 12 15:00:00 - 15:59:59	73568	4.2%	20.44	24.9 GB	4.3%	7259.53
May 12 16:00:00 - 16:59:59	88378	5.1%	24.55	26.1 GB	4.5%	7608.77
May 12 17:00:00 - 17:59:59	77439	4.4%	21.51	23.2 GB	4.0%	6771.81
May 12 18:00:00 - 18:59:59	87560	5.0%	24.32	27.1 GB	4.7%	7892.44
May 12 19:00:00 - 19:59:59	80903	4.6%	22.47	24.0 GB	4.1%	6997.21
May 12 20:00:00 - 20:59:59	80847	4.6%	22.46	26.2 GB	4.5%	7643.35
May 12 21:00:00 - 21:59:59	77549	4.4%	21.54	25.9 GB	4.4%	7535.59
May 12 22:00:00 - 22:59:59	70410	4.0%	19.56	24.8 GB	4.3%	7216.82
May 12 23:00:00 - 23:59:59	84487	4.8%	23.47	26.6 GB	4.6%	7735.90
May 13 00:00:00 - 00:59:59	46057	2.6%	12.79	14.0 GB	2.4%	4072.69
May 13 01:00:00 - 01:59:59	77908	4.5%	21.64	24.3 GB	4.2%	7090.36
May 13 02:00:00 - 02:59:59	80124	4.6%	22.26	26.1 GB	4.5%	7603.47
May 13 03:00:00 - 03:59:59	63510	3.6%	17.64	20.1 GB	3.5%	5861.32
May 13 04:00:00 - 04:15:02	19944	1.1%	22.11	6.7 GB	1.1%	7748.08
TOTAL: 24:00:00	1743099	100.0%	20.17	581.5 GB	100.0%	7056.67

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3928	192	2977	4	755
2	news.nask.pl	296	9	257	16	14
3	news.icm.edu.pl	63	0	1	0	62
TOTAL: 3		4287	201	3235	20	831

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	64
it.tlc.cellulari.android	35
it.comp.os.win.windows8	16
it.comp.os.win.windows7	14
de.comp.lang.php	13
uk.rec.cycling.moderated	12
comp.mobile.android	12
comp.sys.raspberry-pi	10
hr.rec.glazba.hifi	4
hr.alt.cellular.gsm.android	3
comp.mobile.ipad	3
hr.ponuda.hardver.komponente	3
hr.ponuda.hardver.konfiguracije	3
alt.sex.telephones	2
de.comp.lang.vbclassic	2
de.comm.software.mailreader	2
hr.ponuda.hardver.ostalo	1
nl.comp.sys.android	1
de.comm.provider.telefonie	1
TOTAL: 19	201

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

Groups	Count
pl.sci.historia	11
pl.praca.oferowana	8
bit.listserv.catholic	1
TOTAL: 3	20

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	635
EMP (md5)	61
HTML post	9
Scoring filter (11)	1
Scoring filter (8)	1
Scoring filter (10)	1
TOTAL: 6	708

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	41130	3226	25954	320	1	0	7%	23:59:49
2	icm	43111	1457	26725	724	0	17	3%	23:53:47
3	poznan	6466	132	4002	45	0	0	2%	23:55:12
4	nask	27455	92	14501	570	1	0	0%	23:55:13
5	okapi	0	0	0	0	0	3034	0%	24:00:03
TOTAL: 5		118162	4907	71182	1659	2	3051	4%	119:44:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	23.5 MB	951.7 KB	24.4 MB	0.3 KB/s	7.1 KB	23:59:49
2	icm	15.6 MB	97.9 MB	113.5 MB	1.4 KB/s	53.3 KB	23:53:47
3	poznan	7.2 MB	1.8 MB	9.0 MB	0.1 KB/s	51.9 KB	23:55:12
4	nask	734.2 KB	137.8 MB	138.5 MB	1.6 KB/s	214.3 KB	23:55:13
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		47.0 MB	238.5 MB	285.4 MB	0.7 KB/s	44.5 KB	119:44:04

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	312	525.2 KB	288	0	00:00:07
2	web.man.lodz.pl	288	66	66.9 KB	29	0	00:00:31
3	pc-212-51-218-225.p.lodz.pl	3	14	32.3 KB	4	0	00:41:18
4	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 4		581	392	624.5 KB	321	2	00:44:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	312	525.2 KB	288	0	00:00:07
2	*.man.lodz.pl	674	66	66.9 KB	29	2	00:00:37
3	*.p.lodz.pl	3	14	32.3 KB	4	0	00:41:18
4	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:05
5	unresolved	2	0	0.0 KB	0	0	00:01:33
6	*.toya.net.pl	53	0	0.0 KB	0	0	00:00:19
TOTAL: 6		1022	392	624.5 KB	321	2	00:44:00

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.019	0.037	00:41:18
185.48.195.96	0.100	0.042	00:01:33
web.man.lodz.pl	1.140	3.112	00:00:31
staticline-31-182-52-70.toya.net.pl	0.013	0.018	00:00:16
pc-skrzep2.cm.p.lodz.pl	1.157	2.921	00:00:07
host227.elsnet.pl	0.004	0.024	00:00:05
mon.man.lodz.pl	1.058	2.703	00:00:03
staticline41435.toya.net.pl	0.221	0.491	00:00:03
david.man.lodz.pl	0.396	0.844	00:00:01
isvcs01.man.lodz.pl	0.011	0.028	00:00:00
TOTAL: 10	4.119	10.220	00:44:00

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	51
host227.elsnet.pl	2
staticline-31-182-52-70.toya.net.pl	2
185.48.195.96	2
TOTAL: 6	441

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	312	79.6%
2	pl	80	20.4%
TOTAL: 2		392	100.0%

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

Newsgroup		Count
1	lodman.info	312
2	pl.comp.pecet	66
3	pl.misc.kolej	8
4	pl.misc.elektronika	6
TOTAL: 4		392

Daily Usenet report

May 12 04:15:02 -- May 13 04:15:02