Daily Usenet report: Sep 15 04:15:01

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Sep 15 09:05:44 newsfeed nnrpd[2418]: SERVER perl filter not defined
Sep 15 09:07:25 newsfeed nnrpd[2466]: SERVER perl filter not defined
Sep 15 09:57:00 newsfeed nnrpd[4093]: SERVER perl filter not defined
Sep 15 14:17:38 newsfeed nnrpd[12933]: SERVER perl filter not defined
Sep 15 14:23:19 newsfeed nnrpd[13167]: SERVER perl filter not defined
Sep 15 14:27:02 newsfeed nnrpd[13255]: SERVER perl filter not defined
Sep 15 14:28:14 newsfeed nnrpd[13259]: SERVER perl filter not defined
Sep 15 17:00:04 newsfeed pgpverify[18320]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	655724	96.6%	77.7 MB	96.1%
innd	9811	1.4%	1.6 MB	1.9%
nnrpd	7348	1.1%	762.8 KB	0.9%
innfeed	6243	0.9%	884.9 KB	1.1%
controlchan	3	0.0%	0.4 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	679130	100.0%	80.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	652449	94.3%
Negative hits	20982	3.0%
Positive hits	18425	2.7%
Cache misses	199	0.0%
TOTAL: 4	692055	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:06.863	0.0%	293	0.000	23.423	559.000
article cleanup	00:00:11.379	0.0%	655545	0.000	0.017	0.054
article logging	00:00:20.755	0.0%	655679	0.000	0.032	0.092
article parse	00:14:49.894	1.0%	56248889	0.005	0.016	0.067
article write	00:04:32.199	0.3%	651124	0.140	0.418	2.815
artlog/artcncl	00:00:00.006	0.0%	279	0.000	0.022	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:49.408	0.1%	59994190	0.000	0.001	0.006
hisgrep/artcncl	00:00:01.710	0.0%	274	0.000	6.241	266.000
hishave/artcncl	00:00:00.293	0.0%	293	0.000	1.000	18.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:21:45.259	1.5%	692259	0.041	1.886	8.954
history sync	00:00:00.032	0.0%	437	0.000	0.073	1.000
history write	01:23:40.963	5.8%	652900	0.062	7.690	39.280
hiswrite/artcncl	00:00:00.096	0.0%	19	0.000	5.053	17.000
idle	20:15:46.082	84.4%	47990482	0.361	1.520	8.491
nntp read	00:16:49.614	1.2%	55834215	0.008	0.018	0.043
overview write	00:00:04.151	0.0%	651124	0.000	0.006	0.027
perl filter	01:05:40.185	4.6%	652900	2.417	6.035	10.964
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:35.596	0.1%	1333336	0.015	0.072	0.151
TOTAL: 23:59:59.781	23:46:14.485	99.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.086	0.0%	31100	0.000	0.003	0.200
article prepare	00:00:00.004	0.0%	10392	0.000	0.000	0.250
article read	00:00:00.180	0.0%	2543	0.000	0.071	23.000
backlog stats	00:00:00.112	0.0%	196501	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.247	0.0%	128935	0.000	0.010	0.075
data write	00:00:03.028	0.0%	98295	0.000	0.031	1.000
idle	24:00:07.267	100.0%	196501	0.000	439.729	19138.000
status file	00:00:00.352	0.0%	173	0.000	2.035	61.250
TOTAL: 24:00:16.372	24:00:12.276	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	18:43:32.018	99.9%	455925	0.000	147.858	600058.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:13.763	0.0%	914063	0.000	0.015	0.667
readart	00:00:01.872	0.0%	598	0.000	3.130	264.000
TOTAL: 18:44:25.092	18:43:47.653	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
group-admin@isc.org	0	0	0	1	0	0
TOTAL	0	0	0	1	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	249	652925	648864	476	3585	99%	133:56:39
2	news.nask.pl	2	18724	3016	15050	658	16%	24:08:23
3	news.icm.edu.pl	39	392	36	200	156	9%	18:05:15
4	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 4		298	672048	651923	15726	4399	97%	176:10:17

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	135.6 GB	9.5 MB	115.1 MB	135.7 GB	99%	218.1 KB
2	news.nask.pl	11.8 MB	1.7 MB	2.0 MB	15.5 MB	75%	4.3 KB
3	news.icm.edu.pl	1.2 MB	32.4 KB	10.8 MB	12.0 MB	10%	64.1 KB
4	localhost	11.5 KB	0.0 KB	0.0 KB	11.5 KB	100%	1.6 KB
TOTAL: 4		135.6 GB	11.3 MB	128.0 MB	135.7 GB	99%	216.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 15 04:15:01 - 04:59:59	33292	5.1%	12.33	9.3 GB	6.9%	3610.88
Sep 15 05:00:00 - 05:59:59	15232	2.3%	4.23	3.6 GB	2.6%	1043.66
Sep 15 06:00:00 - 06:59:59	18549	2.8%	5.15	3.8 GB	2.8%	1100.09
Sep 15 07:00:00 - 07:59:59	19250	3.0%	5.35	3.2 GB	2.4%	926.76
Sep 15 08:00:00 - 08:59:59	14163	2.2%	3.93	2.8 GB	2.1%	826.23
Sep 15 09:00:00 - 09:59:59	11411	1.8%	3.17	2.6 GB	1.9%	760.98
Sep 15 10:00:00 - 10:59:59	11259	1.7%	3.13	2.0 GB	1.5%	581.85
Sep 15 11:00:00 - 11:59:59	10862	1.7%	3.02	2.0 GB	1.5%	578.85
Sep 15 12:00:00 - 12:59:59	10331	1.6%	2.87	2.0 GB	1.5%	584.72
Sep 15 13:00:00 - 13:59:59	10048	1.5%	2.79	2.0 GB	1.4%	569.26
Sep 15 14:00:00 - 14:59:59	10638	1.6%	2.96	2.2 GB	1.6%	633.74
Sep 15 15:00:00 - 15:59:59	11061	1.7%	3.07	1.9 GB	1.4%	560.48
Sep 15 16:00:00 - 16:59:59	11946	1.8%	3.32	1.8 GB	1.3%	521.56
Sep 15 17:00:00 - 17:59:59	13302	2.0%	3.69	1.5 GB	1.1%	428.47
Sep 15 18:00:00 - 18:59:59	10285	1.6%	2.86	1.5 GB	1.1%	440.62
Sep 15 19:00:00 - 19:59:59	25293	3.9%	7.03	3.5 GB	2.6%	1011.83
Sep 15 20:00:00 - 20:59:59	34996	5.4%	9.72	4.6 GB	3.4%	1342.81
Sep 15 21:00:00 - 21:59:59	32346	5.0%	8.98	4.4 GB	3.3%	1289.50
Sep 15 22:00:00 - 22:59:59	31947	4.9%	8.87	4.4 GB	3.3%	1288.55
Sep 15 23:00:00 - 23:59:59	29822	4.6%	8.28	4.2 GB	3.1%	1217.36
Sep 16 00:00:00 - 00:59:59	59501	9.1%	16.53	14.0 GB	10.4%	4079.41
Sep 16 01:00:00 - 01:59:59	73129	11.2%	20.31	18.4 GB	13.6%	5346.14
Sep 16 02:00:00 - 02:59:59	82735	12.7%	22.98	20.8 GB	15.4%	6048.42
Sep 16 03:00:00 - 03:59:59	61070	9.4%	16.96	16.5 GB	12.2%	4810.36
Sep 16 04:00:00 - 04:15:02	8423	1.3%	9.34	2.4 GB	1.8%	2776.45
TOTAL: 24:00:01	650891	100.0%	7.53	135.3 GB	100.0%	1641.42

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3711	260	2058	0	1393
2	news.nask.pl	656	60	583	2	11
3	news.icm.edu.pl	187	0	3	0	184
TOTAL: 3		4554	320	2644	2	1588

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	109
it.tlc.cellulari.android	47
alt.sex.telephones	45
comp.sys.raspberry-pi	41
comp.mobile.ipad	14
comp.mobile.android	12
it.comp.os.win.windows8	11
it.comp.os.win.windows7	7
hr.ponuda.hardver.komponente	6
de.rec.sf.startrek	5
rec.arts.tv.x-factor	4
hr.alt.cellular.gsm.android	4
de.comp.lang.vbclassic	2
nl.wetenschap.regulier	2
hr.rec.glazba.hifi	2
nl.comp.os.linux.techniek	2
uk.rec.cycling.moderated	2
de.comm.provider.telefonie	2
it.tlc.cellulari.iphone	1
de.comp.office-pakete.ms-office.excel	1
TOTAL: 21	320

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	1245
EMP (md5)	188
HTML post	19
Attached HTML file	1
Scoring filter (12)	1
TOTAL: 5	1454

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	31910	1210	29669	227	0	3%	24:00:59
2	icm	33631	486	29097	511	8	1%	24:01:18
3	nask	27053	112	16377	13	0	0%	24:02:14
4	poznan	3975	23	2808	14	0	0%	23:57:28
5	okapi	0	0	0	0	3389	0%	24:00:01
TOTAL: 5		96569	1831	77951	765	3397	1%	120:02:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	44.4 MB	95.1 MB	139.5 MB	1.7 KB/s	143.2 KB	24:01:18
2	panorama	4.6 MB	780.2 KB	5.4 MB	0.1 KB/s	3.8 KB	24:00:59
3	nask	967.1 KB	875.4 KB	1.8 MB	0.0 KB/s	14.7 KB	24:02:14
4	poznan	85.4 KB	37.7 KB	123.1 KB	0.0 KB/s	3.3 KB	23:57:28
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		50.0 MB	96.7 MB	146.7 MB	0.3 KB/s	57.9 KB	120:02:00

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	362	572.4 KB	288	0	00:00:06
2	web.man.lodz.pl	289	142	154.1 KB	59	0	00:00:21
3	lze200.lze.lodz.pl	9	94	164.4 KB	6	0	02:55:58
4	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	00:00:00
TOTAL: 4		593	598	891.0 KB	353	7	18:44:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	362	572.4 KB	288	0	00:00:06
2	*.man.lodz.pl	680	142	154.1 KB	59	7	00:00:26
3	*.lze.lodz.pl	9	94	164.4 KB	6	0	02:55:58
4	*.181.14.62.static.jazztel.es	4	0	0.0 KB	0	0	15:17:32
5	unresolved	2	0	0.0 KB	0	0	00:00:10
6	*.toya.net.pl	78	0	0.0 KB	0	0	00:30:09
TOTAL: 6		1061	598	891.0 KB	353	7	18:44:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
73.181.14.62.static.jazztel.es	23.101	26.762	15:17:32
lze200.lze.lodz.pl	0.024	0.143	02:55:58
staticline-31-182-128-230.toya.net.pl	0.004	0.004	00:30:00
web.man.lodz.pl	0.892	3.902	00:00:21
212.51.203.199	0.010	0.014	00:00:10
staticline41435.toya.net.pl	0.276	0.927	00:00:09
pc-skrzep2.cm.p.lodz.pl	0.855	3.238	00:00:06
mon.man.lodz.pl	0.873	3.308	00:00:03
david.man.lodz.pl	0.304	1.187	00:00:01
isvcs01.man.lodz.pl	0.031	0.095	00:00:00
TOTAL: 10	26.370	39.580	18:44:24

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	77
73.181.14.62.static.jazztel.es	4
212.51.203.199	2
staticline-31-182-128-230.toya.net.pl	1
TOTAL: 6	468

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	3	0
73.181.14.62.static.jazztel.es	2	2
staticline-31-182-128-230.toya.net.pl	1	0
TOTAL: 3	6	2

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	362	60.5%
2	pl	236	39.5%
TOTAL: 2		598	100.0%

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

Newsgroup		Count
1	lodman.info	362
2	pl.comp.pecet	121
3	pl.misc.telefonia.gsm	65
4	pl.comp.os.ms-windows.winnt	34
5	pl.rec.dom	8
6	pl.comp.os.linux.sieci	6
7	pl.internet.polip	2
TOTAL: 7		598

Daily Usenet report

Sep 15 04:15:01 -- Sep 16 04:15:02