Daily Usenet report: Sep 14 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 14 16:24:54 newsfeed nnrpd[1282]: SERVER perl filter not defined
Sep 14 16:27:23 newsfeed nnrpd[1346]: SERVER perl filter not defined
Sep 14 18:02:03 newsfeed nnrpd[4708]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2808718	98.4%	328.5 MB	98.2%
innd	34789	1.2%	4.8 MB	1.4%
innfeed	4869	0.2%	686.6 KB	0.2%
nnrpd	4743	0.2%	497.0 KB	0.1%
TOTAL: 4	2853119	100.0%	334.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2802717	95.6%
Negative hits	113301	3.9%
Positive hits	16829	0.6%
Cache misses	165	0.0%
TOTAL: 4	2933012	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.635	0.0%	202	0.000	8.094	563.000
article cleanup	00:00:40.093	0.0%	2807576	0.000	0.014	0.200
article logging	00:01:22.221	0.1%	2808134	0.000	0.029	0.614
article parse	01:13:07.061	5.1%	203939806	0.000	0.022	0.143
article write	00:26:27.965	1.8%	2790271	0.000	0.569	4.026
artlog/artcncl	00:00:00.005	0.0%	193	0.000	0.026	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:40.255	0.2%	221615522	0.000	0.001	0.040
hisgrep/artcncl	00:00:00.141	0.0%	176	0.000	0.801	19.000
hishave/artcncl	00:00:00.105	0.0%	202	0.000	0.520	4.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:27:00.026	1.9%	2935098	0.000	0.552	9.007
history sync	00:00:00.018	0.0%	335	0.000	0.054	1.000
history write	00:37:00.092	2.6%	2804838	0.000	0.792	9.549
hiswrite/artcncl	00:00:00.009	0.0%	26	0.000	0.346	3.000
idle	13:22:54.792	55.8%	150592103	0.217	0.320	5060.167
nntp read	01:07:51.268	4.7%	201698035	0.000	0.020	0.167
overview write	00:00:16.136	0.0%	2790271	0.000	0.006	0.091
perl filter	05:45:12.769	24.0%	2804838	1.091	7.385	85.071
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:35.780	0.3%	5627589	0.000	0.049	0.333
TOTAL: 23:59:43.469	23:09:10.371	96.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.220	0.0%	68713	0.000	0.003	0.200
article prepare	00:00:00.027	0.0%	95820	0.000	0.000	0.062
article read	00:00:39.895	0.0%	23934	0.000	1.667	311.500
backlog stats	00:00:00.285	0.0%	320635	0.000	0.001	0.023
callbacks	00:00:00.000	0.0%	9	0.000	0.000	0.000
data read	00:00:02.114	0.0%	154189	0.000	0.014	0.125
data write	00:00:17.224	0.0%	166186	0.000	0.104	7.021
idle	23:59:10.477	99.9%	320635	10.393	269.311	4719.533
status file	00:00:00.706	0.0%	965	0.000	0.732	2.000
TOTAL: 24:00:18.531	24:00:10.948	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:45.626	80.2%	3020	0.000	15.108	2815.364
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.124	0.2%	6621	0.000	0.019	0.500
readart	00:00:00.001	0.0%	10	0.000	0.100	0.500
TOTAL: 00:00:56.865	00:00:45.751	80.5%	-	-	-	-

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	712	2790916	2778059	10123	2734	99%	278:07:36
2	news.nask.pl	2	31088	12908	3608	14572	41%	23:50:35
3	news.icm.edu.pl	41	390	16	353	21	4%	19:30:05
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		759	2822397	2790986	14084	17327	98%	321:28:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	860.3 GB	19.7 MB	20.8 MB	860.4 GB	99%	324.4 KB
2	news.nask.pl	63.1 MB	933.5 KB	171.8 MB	235.8 MB	26%	8.8 KB
3	news.icm.edu.pl	767.9 KB	73.0 KB	488.1 KB	1.3 MB	57%	35.9 KB
4	localhost	4.8 KB	0.0 KB	0.0 KB	4.8 KB	100%	1.6 KB
TOTAL: 4		860.4 GB	20.7 MB	193.1 MB	860.6 GB	99%	321.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 14 04:15:02 - 04:59:59	77377	2.8%	28.68	24.9 GB	2.9%	9688.00
Sep 14 05:00:00 - 05:59:59	128004	4.6%	35.56	39.6 GB	4.6%	11531.32
Sep 14 06:00:00 - 06:59:59	135219	4.8%	37.56	40.6 GB	4.7%	11832.59
Sep 14 07:00:00 - 07:59:59	105221	3.8%	29.23	33.7 GB	3.9%	9824.26
Sep 14 08:00:00 - 08:59:59	103899	3.7%	28.86	32.8 GB	3.8%	9550.92
Sep 14 09:00:00 - 09:59:59	136257	4.9%	37.85	41.7 GB	4.9%	12140.63
Sep 14 10:00:00 - 10:59:59	141319	5.1%	39.26	41.7 GB	4.9%	12147.26
Sep 14 11:00:00 - 11:59:59	136685	4.9%	37.97	42.2 GB	4.9%	12300.67
Sep 14 12:00:00 - 12:59:59	135590	4.9%	37.66	40.5 GB	4.7%	11789.58
Sep 14 13:00:00 - 13:59:59	146661	5.3%	40.74	41.1 GB	4.8%	11960.11
Sep 14 14:00:00 - 14:59:59	138034	4.9%	38.34	39.1 GB	4.5%	11385.99
Sep 14 15:00:00 - 15:59:59	44340	1.6%	12.32	12.8 GB	1.5%	3715.35
Sep 14 16:00:00 - 16:59:59	95690	3.4%	26.58	28.2 GB	3.3%	8208.27
Sep 14 17:00:00 - 17:59:59	111909	4.0%	31.09	32.6 GB	3.8%	9493.61
Sep 14 18:00:00 - 18:59:59	105668	3.8%	29.35	32.7 GB	3.8%	9522.69
Sep 14 19:00:00 - 19:59:59	107103	3.8%	29.75	33.2 GB	3.9%	9679.50
Sep 14 20:00:00 - 20:59:59	116560	4.2%	32.38	36.8 GB	4.3%	10719.28
Sep 14 21:00:00 - 21:59:59	129069	4.6%	35.85	39.4 GB	4.6%	11466.69
Sep 14 22:00:00 - 22:59:59	127722	4.6%	35.48	41.0 GB	4.8%	11942.04
Sep 14 23:00:00 - 23:59:59	129172	4.6%	35.88	41.3 GB	4.8%	12032.47
Sep 15 00:00:00 - 00:59:59	95833	3.4%	26.62	30.1 GB	3.5%	8771.91
Sep 15 01:00:00 - 01:59:59	121612	4.4%	33.78	37.3 GB	4.3%	10867.85
Sep 15 02:00:00 - 02:59:59	107915	3.9%	29.98	36.3 GB	4.2%	10585.21
Sep 15 03:00:00 - 03:59:59	90814	3.3%	25.23	31.5 GB	3.7%	9169.82
Sep 15 04:00:00 - 04:15:02	22982	0.8%	25.48	8.1 GB	0.9%	9473.29
TOTAL: 24:00:00	2790655	100.0%	32.30	859.2 GB	100.0%	10428.01

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	14816	5	291	5	14515
2	newsfeed.pionier.net.pl	3033	159	2451	0	423
3	news.icm.edu.pl	21	0	3	0	18
TOTAL: 3		17870	164	2745	5	14956

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	89
it.tlc.cellulari.android	34
it.comp.os.win.windows10	25
comp.mobile.android	4
de.comp.lang.vbclassic	3
uk.rec.cycling.moderated	3
comp.sys.mac.vintage	3
hr.alt.cellular.gsm.android	1
alt.sex.telephones	1
it.comp.os.linux.ubuntu	1
TOTAL: 10	164

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	13953
Binary in non-binary group	135
Scoring filter (9)	105
Scoring filter (8)	99
EMP (phl)	66
Scoring filter (10)	18
Scoring filter (11)	7
Scoring filter (13)	6
Scoring filter (12)	3
EMP (fsl)	2
HTML post	2
Attached HTML file	1
Excessively crossposted test article	1
TOTAL: 13	14398

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	23443	1410	20036	484	20	44853	6%	23:57:19
2	icm	54902	420	24937	21400	0	1185	0%	23:59:02
3	poznan	19841	222	12698	24	0	728	1%	23:58:27
4	nask	7184	31	4771	4	0	0	0%	23:15:14
5	okapi	0	0	0	0	0	2245	0%	24:00:02
TOTAL: 5		105370	2083	62442	21912	20	49011	1%	119:10:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	8.5 MB	3.3 MB	11.8 MB	0.1 KB/s	6.4 KB	23:57:19
2	icm	2.2 MB	5.2 GB	5.2 GB	62.9 KB/s	249.0 KB	23:59:02
3	poznan	1.2 MB	115.3 KB	1.3 MB	0.0 KB/s	5.5 KB	23:58:27
4	nask	190.3 KB	31.0 KB	221.3 KB	0.0 KB/s	6.3 KB	23:15:14
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		12.1 MB	5.2 GB	5.2 GB	12.7 KB/s	227.0 KB	119:10:04

Backlog files shrunk by innfeed:

Server	Size
panorama	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	10	13.9 KB	5	0	0	00:00:20
2	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	0	00:00:00
3	jwq218.internetdsl.tpnet.pl	1	0	0.0 KB	0	0	1	00:00:31
TOTAL: 3		292	10	13.9 KB	5	3	1	00:00:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	675	10	13.9 KB	5	3	0	00:00:25
2	*.internetdsl.tpnet.pl	1	0	0.0 KB	0	0	1	00:00:31
TOTAL: 2		676	10	13.9 KB	5	3	1	00:00:56

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
jwq218.internetdsl.tpnet.pl	0.003	0.006	00:00:31
web.man.lodz.pl	1.035	4.662	00:00:20
mon.man.lodz.pl	0.878	3.946	00:00:03
david.man.lodz.pl	0.316	1.310	00:00:01
isvcs01.man.lodz.pl	0.018	0.042	00:00:00
TOTAL: 5	2.250	9.966	00:00:56

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
TOTAL: 2	384

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Sep 14 04:15:02 -- Sep 15 04:15:02