Daily Usenet report: Jul 6 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jul 6 08:56:12 newsfeed nnrpd[27150]: SERVER perl filter not defined
Jul 7 00:13:36 newsfeed nnrpd[23872]: SERVER perl filter not defined
Jul 7 00:55:13 newsfeed nnrpd[25194]: SERVER perl filter not defined
Jul 7 04:02:05 newsfeed innfeed[2247]: icm:0 connect: Network is unreachable
Jul 7 04:08:05 newsfeed innfeed[2247]: icm:0 connect: Network is unreachable

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1444292	97.9%	162.3 MB	97.4%
innd	13517	0.9%	2.3 MB	1.4%
nnrpd	9724	0.7%	1004.8 KB	0.6%
innfeed	7165	0.5%	1.1 MB	0.6%
TOTAL: 4	1474698	100.0%	166.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1438908	93.9%
Negative hits	56963	3.7%
Positive hits	36016	2.4%
Cache misses	275	0.0%
TOTAL: 4	1532162	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.316	0.0%	425	0.000	17.214	294.000
article cleanup	00:00:18.842	0.0%	1443174	0.000	0.013	0.029
article logging	00:00:40.645	0.0%	1443273	0.008	0.028	0.689
article parse	00:45:38.692	3.2%	67623707	0.020	0.040	0.090
article write	00:16:06.696	1.1%	1437969	0.394	0.672	2.629
artlog/artcncl	00:00:00.008	0.0%	407	0.000	0.020	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:01:19.210	0.1%	76639419	0.000	0.001	0.003
hisgrep/artcncl	00:00:01.417	0.0%	234	0.000	6.056	274.000
hishave/artcncl	00:00:01.403	0.0%	425	0.000	3.301	62.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:39:27.183	11.1%	1532600	2.147	6.242	13.843
history sync	00:00:00.014	0.0%	290	0.000	0.048	1.000
history write	03:29:21.971	14.5%	1439443	2.894	8.727	21.730
hiswrite/artcncl	00:00:02.034	0.0%	191	0.000	10.649	117.500
idle	12:14:49.672	51.0%	52357566	0.162	0.842	7.131
nntp read	00:30:51.452	2.1%	66604450	0.017	0.028	0.044
overview write	00:00:08.900	0.0%	1437969	0.000	0.006	0.020
perl filter	03:30:58.563	14.7%	1439443	6.058	8.794	10.517
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:30.019	0.2%	2918315	0.013	0.051	0.080
TOTAL: 23:59:36.144	23:32:24.037	98.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.153	0.0%	42578	0.000	0.004	0.083
article prepare	00:00:00.019	0.0%	64496	0.000	0.000	0.062
article read	00:00:29.375	0.0%	15714	0.000	1.869	79.462
backlog stats	00:00:00.233	0.0%	338017	0.000	0.001	0.016
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.857	0.0%	191772	0.000	0.010	1.000
data write	00:00:07.061	0.0%	171667	0.000	0.041	0.217
idle	23:59:21.325	99.9%	338017	0.000	255.494	12952.000
status file	00:00:00.387	0.0%	236	0.000	1.640	54.000
TOTAL: 24:00:06.987	24:00:00.410	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	67:45:03.775	100.0%	364471	0.000	669.199	149704.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:10.593	0.0%	730722	0.000	0.014	1.111
readart	00:00:01.065	0.0%	395	0.000	2.696	284.000
TOTAL: 67:45:57.081	67:45:15.433	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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	598	1433340	1428053	1901	3386	99%	269:56:28
2	news.nask.pl	3	17204	5716	10464	1024	33%	24:09:19
3	news.task.gda.pl	15	23698	4150	18811	737	17%	44:37:03
4	news.icm.edu.pl	32	433	29	337	67	6%	19:57:47
5	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 5		652	1474678	1437951	31513	5214	97%	358:40:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	479.0 GB	17.1 MB	30.9 MB	479.0 GB	99%	350.9 KB
2	news.nask.pl	24.1 MB	2.3 MB	3.4 MB	29.8 MB	80%	4.5 KB
3	news.task.gda.pl	7.8 MB	27.8 KB	1.9 MB	9.7 MB	80%	2.0 KB
4	news.icm.edu.pl	1.8 MB	984.0 KB	3.3 MB	6.0 MB	30%	64.4 KB
5	localhost	3.9 KB	0.0 KB	0.0 KB	3.9 KB	100%	1.3 KB
TOTAL: 5		479.0 GB	20.4 MB	39.4 MB	479.1 GB	99%	348.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 6 04:15:03 - 04:59:59	75536	5.3%	28.01	23.6 GB	4.9%	9166.55
Jul 6 05:00:00 - 05:59:59	105753	7.4%	29.38	33.0 GB	6.9%	9612.64
Jul 6 06:00:00 - 06:59:59	53358	3.7%	14.82	17.8 GB	3.7%	5170.49
Jul 6 07:00:00 - 07:59:59	39839	2.8%	11.07	14.8 GB	3.1%	4322.84
Jul 6 08:00:00 - 08:59:59	46247	3.2%	12.85	16.7 GB	3.5%	4857.38
Jul 6 09:00:00 - 09:59:59	41537	2.9%	11.54	13.3 GB	2.8%	3875.62
Jul 6 10:00:00 - 10:59:59	45879	3.2%	12.74	15.8 GB	3.3%	4594.26
Jul 6 11:00:00 - 11:59:59	50086	3.5%	13.91	17.5 GB	3.7%	5095.33
Jul 6 12:00:00 - 12:59:59	41937	2.9%	11.65	14.0 GB	2.9%	4066.97
Jul 6 13:00:00 - 13:59:59	40790	2.8%	11.33	14.2 GB	3.0%	4143.62
Jul 6 14:00:00 - 14:59:59	43365	3.0%	12.05	14.4 GB	3.0%	4183.25
Jul 6 15:00:00 - 15:59:59	46485	3.2%	12.91	16.5 GB	3.4%	4806.28
Jul 6 16:00:00 - 16:59:59	58197	4.0%	16.17	17.1 GB	3.6%	4971.06
Jul 6 17:00:00 - 17:59:59	60838	4.2%	16.90	16.7 GB	3.5%	4867.58
Jul 6 18:00:00 - 18:59:59	45654	3.2%	12.68	16.8 GB	3.5%	4894.14
Jul 6 19:00:00 - 19:59:59	47314	3.3%	13.14	17.9 GB	3.7%	5219.12
Jul 6 20:00:00 - 20:59:59	43142	3.0%	11.98	16.6 GB	3.5%	4838.45
Jul 6 21:00:00 - 21:59:59	47479	3.3%	13.19	17.0 GB	3.5%	4954.20
Jul 6 22:00:00 - 22:59:59	41453	2.9%	11.51	15.2 GB	3.2%	4441.06
Jul 6 23:00:00 - 23:59:59	47067	3.3%	13.07	16.5 GB	3.4%	4796.17
Jul 7 00:00:00 - 00:59:59	95268	6.6%	26.46	29.9 GB	6.2%	8719.27
Jul 7 01:00:00 - 01:59:59	97557	6.8%	27.10	30.7 GB	6.4%	8948.93
Jul 7 02:00:00 - 02:59:59	108772	7.6%	30.21	34.4 GB	7.2%	10015.65
Jul 7 03:00:00 - 03:59:59	90305	6.3%	25.08	30.4 GB	6.3%	8854.48
Jul 7 04:00:00 - 04:15:03	24720	1.7%	27.38	8.5 GB	1.8%	9875.03
TOTAL: 24:00:00	1438578	100.0%	16.65	479.3 GB	100.0%	5816.38

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3466	118	2914	10	424
2	news.nask.pl	1021	176	795	21	29
3	news.task.gda.pl	753	530	15	0	208
4	news.icm.edu.pl	67	0	11	0	56
TOTAL: 4		5307	824	3735	31	717

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.sex.telephones	165
mailing.freebsd.svn-ports-all	58
mailing.freebsd.svn-ports-head	58
mailing.freebsd.ports-bugs	43
uk.railway	41
mailing.freebsd.svn-src-all	41
fa.freebsd.cvs-all	41
alt.politics.scorched-earth	36
mailing.openbsd.source-changes	22
mailing.openbsd.ports-changes	21
24hoursupport.helpdesk	17
it.tlc.cellulari.android	16
mailing.gcc.gcc-cvs	14
fr.usenet.abus.nocem	14
mailing.openbsd.misc	13
mozilla.dev.tree-management	13
mailing.freebsd.ports	12
mailing.freebsd.svn-src-head	12
comp.mobile.ipad	10
it.comp.os.win.windows8	9
TOTAL: 66	824

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

Groups	Count
pl.sci.historia	26
pl.sci.matematyka	4
bit.listserv.catholic	1
TOTAL: 3	31

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	249
EMP (fsl)	202
Attached HTML file	90
EMP (md5)	71
HTML post	4
Angle-bracket bot	1
Scoring filter (9)	1
TOTAL: 7	618

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	45361	3194	37810	1181	0	7%	23:53:27
2	icm	60224	1169	28769	10621	324	1%	23:59:20
3	task	1776	56	905	6	0	3%	21:52:00
4	nask	19117	33	12507	0	0	0%	23:56:59
5	poznan	11849	28	9789	23	0	0%	24:00:19
6	okapi	0	0	0	0	1831	0%	24:00:03
TOTAL: 6		138327	4480	89780	11831	2155	3%	141:42:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	18.1 MB	2.5 GB	2.5 GB	30.4 KB/s	222.6 KB	23:59:20
2	panorama	11.8 MB	8.7 MB	20.5 MB	0.2 KB/s	4.8 KB	23:53:27
3	task	171.3 KB	10.1 KB	181.4 KB	0.0 KB/s	2.9 KB	21:52:00
4	nask	98.3 KB	0.0 KB	98.3 KB	0.0 KB/s	3.0 KB	23:56:59
5	poznan	59.7 KB	41.8 KB	101.5 KB	0.0 KB/s	2.0 KB	24:00:19
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 6		30.1 MB	2.5 GB	2.5 GB	5.2 KB/s	162.2 KB	141:42: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	vegas.cm.p.lodz.pl	288	324	421.6 KB	288	0	00:00:07
2	web.man.lodz.pl	288	36	27.2 KB	18	0	00:00:21
3	212.191.78.190	293	35	69.9 KB	12	0	47:42:29
4	kujawiak.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 4		872	395	518.7 KB	318	3	67:45:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	324	421.6 KB	288	0	00:00:07
2	*.man.lodz.pl	675	36	27.2 KB	18	3	00:00:31
3	unresolved	293	35	69.9 KB	12	0	47:42:29
4	*.191.14.62.static.jazztel.es	2	0	0.0 KB	0	0	20:02:47
TOTAL: 4		1258	395	518.7 KB	318	3	67:45:56

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.696	4.904	47:42:29
171.191.14.62.static.jazztel.es	18.173	24.493	20:02:47
web.man.lodz.pl	0.832	4.780	00:00:21
f-oper-v100.man.lodz.pl	0.688	5.296	00:00:07
vegas.cm.p.lodz.pl	0.780	4.928	00:00:07
kujawiak.man.lodz.pl	0.012	0.060	00:00:00
david.man.lodz.pl	0.192	1.532	00:00:00
TOTAL: 7	21.373	45.993	67:45:56

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
171.191.14.62.static.jazztel.es	2
TOTAL: 3	386

NNRP client timeouts [Top 20]:

System	Conn	Peer
171.191.14.62.static.jazztel.es	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	324	82.0%
2	pl	71	18.0%
TOTAL: 2		395	100.0%

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

Newsgroup		Count
1	lodman.info	324
2	pl.comp.pecet	32
3	pl.misc.kolej	14
4	pl.soc.prawo	8
5	pl.rec.rowery	6
6	pl.regionalne.lodz	3
7	pl.regionalne.warszawa	2
8	pl.rec.gory	2
9	pl.comp.os.ms-windows.winnt	2
10	pl.internet.polip	2
TOTAL: 10		395

Daily Usenet report

Jul 6 04:15:03 -- Jul 7 04:15:03