Daily Usenet report: Jun 15 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jun 15 10:17:23 newsfeed nnrpd[5319]: SERVER perl filter not defined
Jun 15 10:53:59 newsfeed nnrpd[6446]: SERVER perl filter not defined
Jun 15 17:00:04 newsfeed pgpverify[19195]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2322392	98.4%	264.5 MB	98.1%
innd	28173	1.2%	4.1 MB	1.5%
innfeed	4825	0.2%	659.3 KB	0.2%
nnrpd	4769	0.2%	491.9 KB	0.2%
controlchan	3	0.0%	0.4 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2360163	100.0%	269.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2315938	94.9%
Negative hits	104568	4.3%
Positive hits	17031	0.7%
Cache misses	1796	0.1%
TOTAL: 4	2439333	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.215	0.0%	304	0.000	17.155	177.000
article cleanup	00:00:30.592	0.0%	2321112	0.004	0.013	0.030
article logging	00:01:02.210	0.1%	2321747	0.010	0.027	0.285
article parse	01:02:46.259	4.4%	223147026	0.008	0.017	0.070
article write	00:20:33.150	1.4%	2308157	0.329	0.534	2.976
artlog/artcncl	00:00:00.007	0.0%	299	0.000	0.023	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:24.199	0.2%	238611311	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.817	0.0%	177	0.000	4.616	50.000
hishave/artcncl	00:00:00.132	0.0%	304	0.000	0.434	17.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:26:16.389	1.8%	2440324	0.068	0.646	13.219
history sync	00:00:00.011	0.0%	290	0.000	0.038	1.000
history write	00:35:56.736	2.5%	2317029	0.159	0.931	47.206
hiswrite/artcncl	00:00:00.064	0.0%	127	0.000	0.504	14.000
idle	14:45:26.869	61.5%	173368668	0.144	0.306	0.517
nntp read	01:04:58.090	4.5%	221449099	0.011	0.018	0.032
overview write	00:00:11.982	0.0%	2308157	0.000	0.005	0.014
perl filter	04:48:31.912	20.0%	2317029	5.478	7.472	10.045
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:46.473	0.3%	4653671	0.036	0.049	0.082
TOTAL: 24:00:09.186	23:12:31.107	96.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.168	0.0%	39859	0.000	0.004	0.143
article prepare	00:00:00.013	0.0%	41738	0.000	0.000	0.250
article read	00:00:05.224	0.0%	10434	0.000	0.501	996.500
backlog stats	00:00:00.171	0.0%	210302	0.000	0.001	0.023
callbacks	00:00:00.000	0.0%	3	0.000	0.000	0.000
data read	00:00:01.235	0.0%	113885	0.000	0.011	0.200
data write	00:00:07.222	0.0%	93546	0.000	0.077	0.271
idle	23:58:57.702	100.0%	210302	21.093	410.542	6422.545
status file	00:00:00.579	0.0%	840	0.000	0.689	3.000
TOTAL: 23:59:17.568	23:59:12.314	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:38:03.852	99.5%	21381	0.000	106.817	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.853	0.0%	43383	0.000	0.020	0.500
readart	00:00:00.001	0.0%	26	0.000	0.038	0.250
TOTAL: 00:38:16.194	00:38:04.706	99.5%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	189

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	1178	2309925	2295108	10717	4100	99%	273:32:05
2	news.nask.pl	2	25655	13136	3657	8862	51%	23:54:14
3	news.icm.edu.pl	48	236	27	205	4	11%	16:26:28
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1231	2335818	2308273	14579	12966	98%	313:52:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	732.1 GB	27.4 MB	30.9 MB	732.1 GB	99%	333.9 KB
2	news.nask.pl	67.9 MB	948.2 KB	80.4 MB	149.2 MB	45%	6.9 KB
3	news.icm.edu.pl	777.5 KB	0.0 KB	477.7 KB	1.2 MB	61%	40.5 KB
4	localhost	2.9 KB	0.0 KB	0.0 KB	2.9 KB	100%	1.4 KB
TOTAL: 4		732.1 GB	28.3 MB	111.7 MB	732.3 GB	99%	330.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 15 04:15:01 - 04:59:59	38243	1.7%	14.17	14.8 GB	2.0%	5731.00
Jun 15 05:00:00 - 05:59:59	50681	2.2%	14.08	19.5 GB	2.7%	5685.77
Jun 15 06:00:00 - 06:59:59	53606	2.3%	14.89	20.4 GB	2.8%	5940.69
Jun 15 07:00:00 - 07:59:59	56508	2.4%	15.70	22.1 GB	3.0%	6438.90
Jun 15 08:00:00 - 08:59:59	90941	3.9%	25.26	30.6 GB	4.2%	8912.90
Jun 15 09:00:00 - 09:59:59	89798	3.9%	24.94	28.7 GB	3.9%	8347.59
Jun 15 10:00:00 - 10:59:59	93262	4.0%	25.91	30.5 GB	4.2%	8882.79
Jun 15 11:00:00 - 11:59:59	107397	4.7%	29.83	34.7 GB	4.7%	10093.49
Jun 15 12:00:00 - 12:59:59	99803	4.3%	27.72	32.5 GB	4.4%	9463.94
Jun 15 13:00:00 - 13:59:59	96127	4.2%	26.70	30.3 GB	4.1%	8826.19
Jun 15 14:00:00 - 14:59:59	93514	4.1%	25.98	30.1 GB	4.1%	8769.92
Jun 15 15:00:00 - 15:59:59	94885	4.1%	26.36	31.1 GB	4.3%	9055.47
Jun 15 16:00:00 - 16:59:59	114161	4.9%	31.71	34.4 GB	4.7%	10029.14
Jun 15 17:00:00 - 17:59:59	108593	4.7%	30.16	32.5 GB	4.5%	9475.29
Jun 15 18:00:00 - 18:59:59	124801	5.4%	34.67	36.3 GB	5.0%	10582.85
Jun 15 19:00:00 - 19:59:59	110144	4.8%	30.60	32.5 GB	4.4%	9463.44
Jun 15 20:00:00 - 20:59:59	129651	5.6%	36.01	36.5 GB	5.0%	10625.71
Jun 15 21:00:00 - 21:59:59	112323	4.9%	31.20	33.6 GB	4.6%	9780.51
Jun 15 22:00:00 - 22:59:59	108110	4.7%	30.03	33.9 GB	4.6%	9885.75
Jun 15 23:00:00 - 23:59:59	83178	3.6%	23.11	28.2 GB	3.9%	8226.31
Jun 16 00:00:00 - 00:59:59	85999	3.7%	23.89	28.2 GB	3.9%	8210.94
Jun 16 01:00:00 - 01:59:59	117130	5.1%	32.54	35.1 GB	4.8%	10223.06
Jun 16 02:00:00 - 02:59:59	116912	5.1%	32.48	34.2 GB	4.7%	9964.08
Jun 16 03:00:00 - 03:59:59	105755	4.6%	29.38	31.7 GB	4.3%	9244.93
Jun 16 04:00:00 - 04:15:02	26991	1.2%	29.92	8.2 GB	1.1%	9545.73
TOTAL: 24:00:01	2308513	100.0%	26.72	730.7 GB	100.0%	8867.32

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	9113	59	333	5	8716
2	newsfeed.pionier.net.pl	4462	263	3751	2	446
3	news.icm.edu.pl	5	0	0	0	5
TOTAL: 3		13580	322	4084	7	9167

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	143
it.tlc.cellulari.android	59
comp.mobile.ipad	31
comp.sys.raspberry-pi	24
it.comp.os.win.windows10	23
comp.mobile.android	15
uk.rec.cycling.moderated	14
it.comp.os.win.windows7	10
hr.alt.cellular.gsm.iphone	1
hr.ponuda.hardver.periferije	1
alt.sex.telephones	1
TOTAL: 11	322

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

Groups	Count
pl.praca.oferowana	4
bit.listserv.catholic	2
christnet.theology	1
TOTAL: 3	7

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	7804
PFM bot misc	208
EMP (phl)	131
Binary in non-binary group	114
Scoring filter (8)	110
Scoring filter (9)	60
Scoring filter (10)	23
Scoring filter (11)	22
Scoring filter (12)	21
Scoring filter (13)	13
Scoring filter (14)	6
HTML post	3
Scoring filter (16)	3
Poison newsgroup	2
Scoring filter (17)	2
Scoring filter (23)	1
Scoring filter (20)	1
Scoring filter (19)	1
Scoring filter (21)	1
Scoring filter (18)	1
TOTAL: 25	8532

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	42780	5972	24689	4252	0	101	13%	24:00:43
2	poznan	21259	98	13041	21	0	1	0%	23:58:16
3	panorama	2418	46	1047	10	5	38300	1%	24:01:17
4	nask	6963	11	4546	0	0	0	0%	24:00:03
5	okapi	0	0	0	0	0	2742	0%	24:00:01
TOTAL: 5		73420	6127	43323	4283	5	41144	8%	120:00:20

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	947.0 MB	969.4 MB	1.9 GB	22.7 KB/s	191.9 KB	24:00:43
2	poznan	630.7 KB	45.0 KB	675.6 KB	0.0 KB/s	5.7 KB	23:58:16
3	panorama	152.8 KB	36.4 KB	189.2 KB	0.0 KB/s	3.4 KB	24:01:17
4	nask	34.1 KB	0.0 KB	34.1 KB	0.0 KB/s	3.1 KB	24:00:03
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		947.8 MB	969.4 MB	1.9 GB	4.5 KB/s	188.6 KB	120:00:20

Backlog files shrunk by innfeed:

Server	Size
panorama	2.9 MB
okapi	488.4 KB
TOTAL: 2	3.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	26	21.6 KB	12	0	00:00:24
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		290	26	21.6 KB	12	2	00:38:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	674	26	21.6 KB	12	2	00:00:28
2	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:10
3	unresolved	2	0	0.0 KB	0	0	00:37:37
TOTAL: 3		678	26	21.6 KB	12	2	00:38:16

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.41.146	0.950	1.253	00:37:37
web.man.lodz.pl	0.905	4.718	00:00:24
host227.elsnet.pl	0.015	0.022	00:00:10
mon.man.lodz.pl	0.774	3.742	00:00:03
david.man.lodz.pl	0.278	1.324	00:00:01
isvcs01.man.lodz.pl	0.010	0.034	00:00:00
TOTAL: 6	2.932	11.093	00:38:16

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
host227.elsnet.pl	2
89.38.41.146	2
TOTAL: 4	388

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	26	100.0%
TOTAL: 1		26	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	16
2	pl.comp.os.ms-windows.winnt	10
TOTAL: 2		26

Daily Usenet report

Jun 15 04:15:01 -- Jun 16 04:15:02