Daily Usenet report: Dec 10 04:15:03

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Dec 10 10:29:37 newsfeed nnrpd[21685]: SERVER perl filter not defined
Dec 10 10:34:25 newsfeed nnrpd[21922]: SERVER perl filter not defined
Dec 10 12:53:13 newsfeed pgpverify[26597]: pgpverify: verification failed
Dec 10 13:31:27 newsfeed nnrpd[27901]: SERVER perl filter not defined
Dec 10 15:39:42 newsfeed nnrpd[32115]: SERVER perl filter not defined
Dec 10 15:40:29 newsfeed nnrpd[32300]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1515690	97.8%	176.9 MB	97.3%
innd	20116	1.3%	3.1 MB	1.7%
nnrpd	7779	0.5%	829.1 KB	0.4%
innfeed	6626	0.4%	966.6 KB	0.5%
controlchan	1	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
TOTAL: 6	1550213	100.0%	181.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1510249	95.3%
Negative hits	56388	3.6%
Positive hits	17149	1.1%
Cache misses	141	0.0%
TOTAL: 4	1583927	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.886	0.0%	246	0.000	36.122	487.000
article cleanup	00:00:25.894	0.0%	1514451	0.000	0.017	0.046
article logging	00:00:41.630	0.0%	1514569	0.000	0.027	0.960
article parse	00:54:35.029	3.8%	113210644	0.000	0.029	0.056
article write	00:16:01.389	1.1%	1504331	0.217	0.639	4.000
artlog/artcncl	00:00:00.005	0.0%	234	0.000	0.021	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:01:54.902	0.1%	122233483	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.437	0.0%	223	0.000	1.960	23.000
hishave/artcncl	00:00:00.046	0.0%	246	0.000	0.187	7.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:07:55.989	0.6%	1585356	0.000	0.300	1.846
history sync	00:00:00.019	0.0%	343	0.000	0.055	2.000
history write	02:37:46.614	11.0%	1511612	0.071	6.263	16.456
hiswrite/artcncl	00:00:00.096	0.0%	23	0.000	4.174	13.000
idle	15:16:38.964	63.7%	74164772	0.323	0.742	1815.212
nntp read	00:46:30.313	3.2%	111946126	0.000	0.025	0.044
overview write	00:00:10.079	0.0%	1504331	0.000	0.007	0.042
perl filter	03:23:07.387	14.1%	1511609	3.826	8.063	123.143
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:54.353	0.2%	3061618	0.036	0.057	0.242
TOTAL: 23:59:11.160	23:28:52.032	97.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.191	0.0%	53006	0.000	0.004	0.111
article prepare	00:00:00.002	0.0%	20776	0.000	0.000	0.250
article read	00:00:00.445	0.0%	4937	0.000	0.090	1.000
backlog stats	00:00:00.157	0.0%	295602	0.000	0.001	0.024
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.880	0.0%	189525	0.000	0.010	0.111
data write	00:00:05.044	0.0%	139426	0.000	0.036	1.000
idle	24:00:40.843	100.0%	295602	0.000	292.423	16153.000
status file	00:00:00.247	0.0%	186	0.000	1.328	53.000
TOTAL: 24:00:54.978	24:00:48.809	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	10:51:23.170	99.9%	20409	0.000	1914.997	200001.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.077	0.0%	43638	0.000	0.025	1.889
readart	00:00:13.758	0.0%	711	0.000	19.350	274.000
TOTAL: 10:52:02.046	10:51:38.005	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
control@usenet.org.uk	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	472	1511999	1501459	917	9623	99%	244:20:44
2	news.nask.pl	2	17160	3537	13153	470	20%	23:49:24
3	news.icm.edu.pl	51	210	19	179	12	9%	16:28:44
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		531	1529374	1505020	14249	10105	98%	284:38:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	445.1 GB	19.1 MB	1007.0 MB	446.1 GB	99%	309.5 KB
2	news.nask.pl	16.6 MB	1.2 MB	1.3 MB	19.0 MB	87%	4.9 KB
3	news.icm.edu.pl	460.1 KB	8.2 KB	291.7 KB	759.9 KB	60%	24.5 KB
4	localhost	12.0 KB	0.0 KB	0.0 KB	12.0 KB	100%	2.4 KB
TOTAL: 4		445.1 GB	20.3 MB	1008.5 MB	446.1 GB	99%	308.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 10 04:15:03 - 04:59:59	56116	3.7%	20.81	15.9 GB	3.6%	6175.71
Dec 10 05:00:00 - 05:59:59	76977	5.1%	21.38	21.4 GB	4.8%	6246.96
Dec 10 06:00:00 - 06:59:59	97216	6.5%	27.00	28.3 GB	6.3%	8234.91
Dec 10 07:00:00 - 07:59:59	101588	6.7%	28.22	30.9 GB	6.9%	8997.65
Dec 10 08:00:00 - 08:59:59	89983	6.0%	25.00	27.6 GB	6.2%	8049.92
Dec 10 09:00:00 - 09:59:59	101864	6.8%	28.30	31.1 GB	7.0%	9068.99
Dec 10 10:00:00 - 10:59:59	108976	7.2%	30.27	32.0 GB	7.2%	9327.01
Dec 10 11:00:00 - 11:59:59	106849	7.1%	29.68	28.9 GB	6.5%	8431.26
Dec 10 12:00:00 - 12:59:59	92011	6.1%	25.56	26.8 GB	6.0%	7808.48
Dec 10 13:00:00 - 13:59:59	79316	5.3%	22.03	25.2 GB	5.7%	7340.95
Dec 10 14:00:00 - 14:59:59	24743	1.6%	6.87	5.6 GB	1.3%	1640.13
Dec 10 15:00:00 - 15:59:59	13824	0.9%	3.84	2.6 GB	0.6%	760.53
Dec 10 16:00:00 - 16:59:59	10917	0.7%	3.03	2.5 GB	0.6%	719.27
Dec 10 17:00:00 - 17:59:59	12470	0.8%	3.46	2.3 GB	0.5%	673.00
Dec 10 18:00:00 - 18:59:59	13147	0.9%	3.65	2.1 GB	0.5%	625.64
Dec 10 19:00:00 - 19:59:59	12676	0.8%	3.52	2.2 GB	0.5%	626.62
Dec 10 20:00:00 - 20:59:59	38207	2.5%	10.61	11.3 GB	2.5%	3300.59
Dec 10 21:00:00 - 21:59:59	45761	3.0%	12.71	13.0 GB	2.9%	3788.83
Dec 10 22:00:00 - 22:59:59	42537	2.8%	11.82	12.3 GB	2.8%	3575.73
Dec 10 23:00:00 - 23:59:59	72108	4.8%	20.03	23.0 GB	5.2%	6689.39
Dec 11 00:00:00 - 00:59:59	60864	4.0%	16.91	20.3 GB	4.6%	5903.78
Dec 11 01:00:00 - 01:59:59	91479	6.1%	25.41	30.7 GB	6.9%	8941.82
Dec 11 02:00:00 - 02:59:59	70228	4.7%	19.51	21.1 GB	4.7%	6134.51
Dec 11 03:00:00 - 03:59:59	66469	4.4%	18.46	21.8 GB	4.9%	6339.77
Dec 11 04:00:00 - 04:15:02	18888	1.3%	20.94	6.4 GB	1.4%	7492.13
TOTAL: 23:59:59	1505214	100.0%	17.42	445.4 GB	100.0%	5405.46

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	9726	232	2375	1	7118
2	news.nask.pl	504	18	467	3	16
3	news.icm.edu.pl	12	0	1	0	11
TOTAL: 3		10242	250	2843	4	7145

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	99
comp.mobile.android	57
uk.rec.cycling.moderated	22
it.tlc.cellulari.android	21
it.comp.os.win.windows7	12
hr.alt.cellular.gsm.iphone	11
it.comp.os.win.windows8	5
sci.physics.acoustics	3
rec.arts.tv.x-factor	3
alt.sex.telephones	3
comp.mobile.ipad	3
comp.sys.raspberry-pi	2
de.comp.lang.vbclassic	2
it.discussioni.energia	2
hr.ponuda.hardver.komponente	2
it.comp.virtualizzazione	1
hr.ponuda.hardver.periferije	1
hr.ponuda.hardver.konfiguracije	1
TOTAL: 18	250

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	6996
EMP (md5)	16
EMP (fsl)	6
HTML post	5
Attached HTML file	1
TOTAL: 5	7024

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	53663	1652	51090	248	0	3%	24:01:19
2	icm	51384	783	37231	2238	5	1%	24:08:07
3	nask	24226	233	14448	0	0	0%	23:57:13
4	poznan	4782	21	3295	17	0	0%	24:00:35
5	okapi	0	0	0	0	2635	0%	24:00:00
TOTAL: 5		134055	2689	106064	2503	2640	2%	120:07:14

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	32.7 MB	0.0 KB	32.7 MB	0.4 KB/s	143.8 KB	23:57:13
2	panorama	6.2 MB	965.2 KB	7.2 MB	0.1 KB/s	3.9 KB	24:01:19
3	icm	5.3 MB	392.1 MB	397.3 MB	4.7 KB/s	134.7 KB	24:08:07
4	poznan	86.4 KB	44.8 KB	131.2 KB	0.0 KB/s	3.5 KB	24:00:35
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		44.3 MB	393.1 MB	437.3 MB	1.0 KB/s	86.3 KB	120:07:14

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	Rej	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	338	1.1 MB	288	0	0	00:00:08
2	bursztyn.p.lodz.pl	1	190	25.7 MB	3	0	0	01:03:53
3	pc-212-51-218-225.p.lodz.pl	65	111	205.6 KB	21	0	0	08:43:26
4	web.man.lodz.pl	288	68	68.3 KB	30	0	0	00:00:24
5	host227.elsnet.pl	31	4	4.9 KB	1	0	2	00:26:55
6	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	0	00:00:00
TOTAL: 6		678	711	27.1 MB	343	5	2	10:52:01

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	338	1.1 MB	288	0	0	00:00:08
2	*.p.lodz.pl	66	301	25.9 MB	24	0	0	09:47:19
3	*.man.lodz.pl	677	68	68.3 KB	30	5	0	00:00:30
4	*.elsnet.pl	31	4	4.9 KB	1	0	2	00:26:55
5	*.191.14.62.static.jazztel.es	6	0	0.0 KB	0	0	0	00:36:57
6	*.toya.net.pl	98	0	0.0 KB	0	0	0	00:00:09
TOTAL: 6		1166	711	27.1 MB	343	5	2	10:52:01

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.260	0.889	08:43:26
bursztyn.p.lodz.pl	0.025	0.374	01:03:53
187.191.14.62.static.jazztel.es	0.949	0.983	00:36:57
host227.elsnet.pl	0.670	0.505	00:26:55
web.man.lodz.pl	1.014	4.400	00:00:24
staticline41435.toya.net.pl	0.360	1.341	00:00:09
pc-skrzep2.cm.p.lodz.pl	1.068	3.966	00:00:08
mon.man.lodz.pl	0.968	3.948	00:00:04
david.man.lodz.pl	0.311	1.298	00:00:01
isvcs01.man.lodz.pl	0.049	0.063	00:00:00
TOTAL: 10	5.674	17.767	10:52:01

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
staticline41435.toya.net.pl	98
david.man.lodz.pl	96
187.191.14.62.static.jazztel.es	6
TOTAL: 4	488

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	342	48.1%
2	alt	190	26.7%
3	pl	179	25.2%
TOTAL: 3		711	100.0%

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

Newsgroup		Count
1	lodman.info	338
2	alt.binaries.pictures.erotica.groupsex	89
3	alt.binaries.pictures.sex	76
4	pl.comp.pecet	60
5	pl.misc.elektronika	58
6	pl.misc.kolej	53
7	alt.binaries.pictures.bisexuals	25
8	pl.comp.os.ms-windows.winnt	8
9	lodman.test	4
TOTAL: 9		711

Daily Usenet report

Dec 10 04:15:03 -- Dec 11 04:15:02