Daily Usenet report: Nov 17 04:15:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Nov 17 08:16:34 newsfeed nnrpd[1020]: SERVER perl filter not defined
Nov 17 09:24:27 newsfeed nnrpd[4773]: SERVER perl filter not defined
Nov 17 09:26:45 newsfeed nnrpd[4823]: SERVER perl filter not defined
Nov 17 09:28:57 newsfeed nnrpd[4880]: SERVER perl filter not defined
Nov 17 09:49:18 newsfeed nnrpd[5734]: SERVER perl filter not defined
Nov 17 13:10:02 newsfeed pgpverify[12797]: pgpverify: verification failed
Nov 17 16:41:19 newsfeed nnrpd[20090]: SERVER perl filter not defined
Nov 18 03:47:53 newsfeed nnrpd[10853]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2463639	97.3%	282.8 MB	96.9%
innfeed	41631	1.6%	5.0 MB	1.7%
innd	20537	0.8%	3.5 MB	1.2%
nnrpd	5467	0.2%	589.5 KB	0.2%
controlchan	4	0.0%	0.5 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2531279	100.0%	291.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2456951	98.1%
Negative hits	31691	1.3%
Positive hits	16818	0.7%
Cache misses	102	0.0%
TOTAL: 4	2505562	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.787	0.0%	164	0.000	16.994	137.000
article cleanup	00:00:42.121	0.0%	2462056	0.007	0.017	0.029
article logging	00:01:10.816	0.1%	2462559	0.015	0.029	0.523
article parse	01:19:23.854	5.5%	266115222	0.006	0.018	0.068
article write	00:51:55.990	3.6%	2457670	0.302	1.268	7.513
artlog/artcncl	00:00:00.006	0.0%	160	0.000	0.037	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:06:22.566	0.4%	282451187	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.827	0.0%	146	0.000	5.664	137.000
hishave/artcncl	00:00:00.290	0.0%	164	0.000	1.768	11.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:40:14.871	2.8%	2506813	0.085	0.963	15.122
history sync	00:00:00.017	0.0%	292	0.000	0.058	2.000
history write	00:53:26.206	3.7%	2458276	0.181	1.304	27.933
hiswrite/artcncl	00:00:00.036	0.0%	18	0.000	2.000	8.000
idle	12:38:17.892	52.7%	182759893	0.068	0.249	3.502
nntp read	01:34:06.047	6.5%	264189842	0.009	0.021	0.042
overview write	00:00:14.156	0.0%	2457670	0.001	0.006	0.015
perl filter	05:14:05.808	21.8%	2458276	4.789	7.666	9.667
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:35.210	0.3%	5087076	0.019	0.054	0.091
TOTAL: 23:58:24.910	23:24:39.500	97.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.702	0.0%	265829	0.000	0.003	0.056
article prepare	00:00:00.009	0.0%	61542	0.000	0.000	0.083
article read	00:01:56.959	0.1%	15357	0.000	7.616	971.000
backlog stats	00:00:00.345	0.0%	441235	0.000	0.001	0.031
callbacks	00:00:00.000	0.0%	3	0.000	0.000	0.000
data read	00:00:03.400	0.0%	295871	0.000	0.011	0.234
data write	00:00:09.351	0.0%	126923	0.000	0.074	1.256
idle	23:56:30.410	99.8%	441235	69.281	195.339	1227.240
status file	00:00:12.179	0.0%	14375	0.000	0.847	113.286
TOTAL: 23:59:07.943	23:58:53.355	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	18:43:14.110	99.9%	358401	0.000	188.041	539174.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:12.118	0.0%	718162	0.000	0.017	0.947
readart	00:00:02.501	0.0%	285	0.000	8.775	50.688
TOTAL: 18:44:03.335	18:43:28.729	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
newsmaster@carnet.hr	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	1158	2457282	2453045	326	3911	99%	354:22:41
2	news.nask.pl	3	16442	3992	12045	405	24%	22:39:40
3	news.icm.edu.pl	43	267	25	181	61	9%	17:45:42
4	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 4		1212	2473998	2457069	12552	4377	99%	394:48:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	773.5 GB	12.3 MB	26.7 MB	773.5 GB	99%	330.1 KB
2	news.nask.pl	13.7 MB	1.0 MB	1.1 MB	15.8 MB	86%	3.7 KB
3	news.icm.edu.pl	468.5 KB	69.2 KB	1.2 MB	1.8 MB	25%	21.1 KB
4	localhost	13.8 KB	0.0 KB	0.0 KB	13.8 KB	100%	2.0 KB
TOTAL: 4		773.5 GB	13.3 MB	29.1 MB	773.5 GB	99%	329.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 17 04:15:02 - 04:59:59	65660	2.7%	24.34	22.2 GB	2.9%	8642.19
Nov 17 05:00:00 - 05:59:59	90929	3.7%	25.26	29.7 GB	3.8%	8662.11
Nov 17 06:00:00 - 06:59:59	100480	4.1%	27.91	32.1 GB	4.1%	9336.98
Nov 17 07:00:00 - 07:59:59	95494	3.9%	26.53	30.7 GB	4.0%	8928.87
Nov 17 08:00:00 - 08:59:59	85708	3.5%	23.81	28.1 GB	3.6%	8178.10
Nov 17 09:00:00 - 09:59:59	74905	3.0%	20.81	26.3 GB	3.4%	7653.58
Nov 17 10:00:00 - 10:59:59	96032	3.9%	26.68	31.4 GB	4.1%	9150.25
Nov 17 11:00:00 - 11:59:59	95513	3.9%	26.53	30.5 GB	3.9%	8883.53
Nov 17 12:00:00 - 12:59:59	102058	4.2%	28.35	31.7 GB	4.1%	9219.54
Nov 17 13:00:00 - 13:59:59	112256	4.6%	31.18	34.4 GB	4.4%	10006.59
Nov 17 14:00:00 - 14:59:59	112074	4.6%	31.13	34.6 GB	4.5%	10086.80
Nov 17 15:00:00 - 15:59:59	112183	4.6%	31.16	34.9 GB	4.5%	10159.64
Nov 17 16:00:00 - 16:59:59	114267	4.6%	31.74	34.2 GB	4.4%	9975.48
Nov 17 17:00:00 - 17:59:59	112585	4.6%	31.27	34.5 GB	4.5%	10059.85
Nov 17 18:00:00 - 18:59:59	91214	3.7%	25.34	28.8 GB	3.7%	8376.47
Nov 17 19:00:00 - 19:59:59	109922	4.5%	30.53	34.8 GB	4.5%	10137.44
Nov 17 20:00:00 - 20:59:59	113517	4.6%	31.53	34.7 GB	4.5%	10109.01
Nov 17 21:00:00 - 21:59:59	114701	4.7%	31.86	33.4 GB	4.3%	9720.35
Nov 17 22:00:00 - 22:59:59	113918	4.6%	31.64	34.2 GB	4.4%	9974.73
Nov 17 23:00:00 - 23:59:59	117540	4.8%	32.65	36.1 GB	4.7%	10508.18
Nov 18 00:00:00 - 00:59:59	91551	3.7%	25.43	29.1 GB	3.8%	8463.87
Nov 18 01:00:00 - 01:59:59	114528	4.7%	31.81	36.2 GB	4.7%	10547.32
Nov 18 02:00:00 - 02:59:59	112893	4.6%	31.36	35.4 GB	4.6%	10318.23
Nov 18 03:00:00 - 03:59:59	93189	3.8%	25.89	30.0 GB	3.9%	8731.79
Nov 18 04:00:00 - 04:15:02	15469	0.6%	17.15	5.4 GB	0.7%	6317.90
TOTAL: 24:00:00	2458586	100.0%	28.46	773.3 GB	100.0%	9385.36

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4360	265	3413	1	681
2	news.nask.pl	471	33	369	1	68
3	news.icm.edu.pl	62	0	2	0	60
TOTAL: 3		4893	298	3784	2	809

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	105
comp.mobile.ipad	84
it.comp.os.win.windows10	44
it.tlc.cellulari.android	21
uk.rec.cycling.moderated	9
de.comp.office-pakete.ms-office.excel	9
nl.comp.sys.android	9
de.comp.lang.php	5
hr.ponuda.hardver.komponente	3
comp.mobile.android	2
it.comp.os.linux.ubuntu	2
rec.arts.tv.x-factor	2
it.comp.os.win.windows7	1
it.discussioni.energia	1
de.comp.office-pakete.ms-office.word	1
TOTAL: 15	298

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	173
EMP (fsl)	67
EMP (md5)	51
Too many newsgroups	14
Scoring filter (14)	1
TOTAL: 5	306

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	53647	7155	28350	3072	0	5	13%	23:55:18
2	panorama	109279	2909	81362	1249	7	180251	2%	23:58:56
3	poznan	6107	72	3976	25	0	0	1%	23:50:00
4	okapi	0	0	0	0	0	2644	0%	23:50:00
5	nask	0	0	0	0	0	16038	0%	23:50:00
TOTAL: 5		169033	10136	113688	4346	7	198938	5%	119:24:14

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	958.9 MB	676.7 MB	1.6 GB	19.4 KB/s	163.8 KB	23:55:18
2	panorama	13.1 MB	8.6 MB	21.7 MB	0.3 KB/s	5.3 KB	23:58:56
3	poznan	437.4 KB	57.2 KB	494.6 KB	0.0 KB/s	5.1 KB	23:50:00
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:00
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:00
TOTAL: 5		972.5 MB	685.4 MB	1.6 GB	3.9 KB/s	117.2 KB	119:24:14

Backlog files shrunk by innfeed:

Server	Size
panorama	10.0 MB
TOTAL: 1	10.0 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	staticline-31-182-74-115.toya.net.pl	11	90	88.5 KB	4	0	3	00:45:33
2	pc-212-51-218-225.p.lodz.pl	12	71	160.0 KB	9	0	0	02:38:29
3	5.174.125.155	8	57	50.3 KB	3	0	4	00:39:29
4	web.man.lodz.pl	288	44	43.2 KB	20	0	0	00:00:28
5	aeqe18.neoplus.adsl.tpnet.pl	11	14	11.7 KB	4	0	3	00:39:30
6	dmcs2.p.lodz.pl	5	9	19.2 KB	7	0	0	01:40:30
7	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	0	00:00:00
TOTAL: 7		342	285	372.8 KB	47	7	10	18:44:03

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.toya.net.pl	79	90	88.5 KB	4	0	3	00:45:56
2	*.p.lodz.pl	17	80	179.2 KB	16	0	0	04:19:00
3	unresolved	14	57	50.3 KB	3	0	4	12:58:25
4	*.man.lodz.pl	679	44	43.2 KB	20	7	0	00:00:32
5	*.neoplus.adsl.tpnet.pl	11	14	11.7 KB	4	0	3	00:39:30
6	*.105.131.121.tvsat364.lodz.pl	1	0	0.0 KB	0	0	0	00:00:00
7	*.elsnet.pl	10	0	0.0 KB	0	0	0	00:00:37
TOTAL: 7		811	285	372.8 KB	47	7	10	18:44:03

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.194.11	18.969	24.365	12:17:13
pc-212-51-218-225.p.lodz.pl	0.048	0.111	02:38:29
dmcs2.p.lodz.pl	0.018	0.041	01:40:30
staticline-31-182-74-115.toya.net.pl	0.078	0.096	00:45:33
aeqe18.neoplus.adsl.tpnet.pl	0.139	0.129	00:39:30
5.174.125.155	0.044	0.072	00:39:29
91.244.191.30	0.036	0.004	00:00:46
host227.elsnet.pl	0.023	0.072	00:00:37
79.110.202.6	0.013	0.006	00:00:34
web.man.lodz.pl	0.981	2.747	00:00:28
staticline41435.toya.net.pl	0.206	0.595	00:00:23
212.51.203.199	0.003	0.007	00:00:20
mon.man.lodz.pl	1.070	2.423	00:00:03
david.man.lodz.pl	0.233	0.869	00:00:00
isvcs01.man.lodz.pl	0.039	0.058	00:00:00
ip-176.105.131.121.tvsat364.lodz.pl	0.003	0.009	00:00:00
TOTAL: 16	21.903	31.604	18:44:03

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	68
host227.elsnet.pl	10
212.51.203.199	2
185.48.194.11	2
ip-176.105.131.121.tvsat364.lodz.pl	1
79.110.202.6	1
91.244.191.30	1
TOTAL: 9	469

NNRP client timeouts [Top 20]:

System	Conn	Peer
dmcs2.p.lodz.pl	2	0
pc-212-51-218-225.p.lodz.pl	2	2
5.174.125.155	1	0
185.48.194.11	1	0
TOTAL: 4	6	3

Newsgroup request counts (by category):

Category		Count	Pct
1	lodz	161	56.5%
2	pl	124	43.5%
TOTAL: 2		285	100.0%

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

Newsgroup		Count
1	lodz.test	161
2	pl.misc.elektronika	49
3	pl.misc.kolej	31
4	pl.comp.os.ms-windows.winnt	22
5	pl.comp.pecet	22
TOTAL: 5		285

Daily Usenet report

Nov 17 04:15:02 -- Nov 18 04:15:02