Daily Usenet report: Sep 7 04:15:04

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 7 10:37:46 newsfeed nnrpd[8405]: SERVER perl filter not defined
Sep 7 13:48:49 newsfeed nnrpd[14407]: SERVER perl filter not defined
Sep 7 17:12:42 newsfeed nnrpd[20892]: SERVER perl filter not defined
Sep 7 23:30:02 newsfeed nnrpd[32650]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2161418	98.3%	243.7 MB	97.9%
innd	22877	1.0%	3.6 MB	1.5%
innfeed	6816	0.3%	1.0 MB	0.4%
nnrpd	6571	0.3%	684.4 KB	0.3%
TOTAL: 4	2197682	100.0%	249.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2156114	94.5%
Negative hits	90654	4.0%
Positive hits	34873	1.5%
Cache misses	248	0.0%
TOTAL: 4	2281889	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.451	0.0%	435	0.000	24.025	577.000
article cleanup	00:00:29.299	0.0%	2160714	0.004	0.014	0.025
article logging	00:01:06.551	0.1%	2160823	0.012	0.031	0.718
article parse	01:17:51.429	5.4%	83876931	0.024	0.056	0.091
article write	00:23:33.882	1.6%	2150547	0.440	0.657	1.653
artlog/artcncl	00:00:00.003	0.0%	409	0.000	0.007	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:04.273	0.1%	97213910	0.001	0.001	0.003
hisgrep/artcncl	00:00:01.719	0.0%	256	0.000	6.715	239.000
hishave/artcncl	00:00:02.366	0.0%	435	0.000	5.439	286.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:54:09.983	16.3%	2282333	1.758	6.156	16.394
history sync	00:00:00.010	0.0%	291	0.000	0.034	1.000
history write	05:03:25.881	21.1%	2156378	0.620	8.443	19.101
hiswrite/artcncl	00:00:01.438	0.0%	179	0.000	8.034	80.000
idle	06:21:24.532	26.5%	47146049	0.187	0.485	3.083
nntp read	00:43:06.733	3.0%	82110567	0.017	0.032	0.044
overview write	00:00:12.972	0.0%	2150547	0.001	0.006	0.019
perl filter	05:41:55.987	23.7%	2156378	6.635	9.514	11.307
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:37.595	0.3%	4337253	0.027	0.050	0.075
TOTAL: 23:59:51.428	23:33:15.104	98.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.123	0.0%	36170	0.000	0.003	0.143
article prepare	00:00:00.017	0.0%	54834	0.000	0.000	0.050
article read	00:00:01.681	0.0%	12876	0.000	0.131	2.000
backlog stats	00:00:00.204	0.0%	276657	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.840	0.0%	159962	0.000	0.012	0.081
data write	00:00:05.772	0.0%	147045	0.000	0.039	0.333
idle	23:59:35.103	100.0%	276657	0.000	312.210	12615.000
status file	00:00:01.686	0.0%	226	0.000	7.460	299.000
TOTAL: 23:59:52.441	23:59:46.426	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:19.106	79.3%	3947	0.000	20.042	20259.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.189	0.2%	9589	0.000	0.020	1.000
readart	00:00:00.841	0.8%	426	0.000	1.974	40.923
TOTAL: 00:01:39.747	00:01:20.136	80.3%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1034	2148995	2138929	2338	7728	99%	448:17:07
2	news.task.gda.pl	12	27469	5972	20322	1175	21%	45:56:34
3	news.nask.pl	3	15300	5865	8196	1239	38%	23:58:56
4	news.icm.edu.pl	41	257	14	206	37	5%	16:09:55
5	localhost	5	4	4	0	0	100%	00:00:01
TOTAL: 5		1095	2192025	2150784	31062	10179	98%	534:22:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	800.5 GB	135.1 MB	750.6 MB	801.3 GB	99%	391.4 KB
2	news.nask.pl	95.2 MB	3.5 MB	3.6 MB	102.3 MB	93%	14.8 KB
3	news.task.gda.pl	11.2 MB	50.2 KB	3.5 MB	14.7 MB	76%	2.1 KB
4	news.icm.edu.pl	411.5 KB	327.8 KB	620.4 KB	1.3 MB	30%	26.7 KB
5	localhost	5.9 KB	0.0 KB	0.0 KB	5.9 KB	100%	1.5 KB
TOTAL: 5		800.6 GB	139.0 MB	758.3 MB	801.4 GB	99%	388.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 7 04:15:04 - 04:59:59	59958	2.8%	22.24	24.4 GB	3.1%	9500.04
Sep 7 05:00:00 - 05:59:59	84322	3.9%	23.42	33.2 GB	4.1%	9659.38
Sep 7 06:00:00 - 06:59:59	75392	3.5%	20.94	31.9 GB	4.0%	9277.10
Sep 7 07:00:00 - 07:59:59	82495	3.8%	22.92	33.6 GB	4.2%	9797.40
Sep 7 08:00:00 - 08:59:59	79542	3.7%	22.09	30.5 GB	3.8%	8893.21
Sep 7 09:00:00 - 09:59:59	99069	4.6%	27.52	35.9 GB	4.5%	10463.83
Sep 7 10:00:00 - 10:59:59	92138	4.3%	25.59	34.9 GB	4.4%	10157.49
Sep 7 11:00:00 - 11:59:59	93576	4.4%	25.99	34.6 GB	4.3%	10083.04
Sep 7 12:00:00 - 12:59:59	103658	4.8%	28.79	36.6 GB	4.6%	10646.76
Sep 7 13:00:00 - 13:59:59	104060	4.8%	28.91	35.1 GB	4.4%	10233.73
Sep 7 14:00:00 - 14:59:59	104141	4.8%	28.93	35.1 GB	4.4%	10224.22
Sep 7 15:00:00 - 15:59:59	92694	4.3%	25.75	31.5 GB	3.9%	9186.35
Sep 7 16:00:00 - 16:59:59	106122	4.9%	29.48	37.1 GB	4.6%	10817.24
Sep 7 17:00:00 - 17:59:59	89411	4.2%	24.84	32.1 GB	4.0%	9347.92
Sep 7 18:00:00 - 18:59:59	74220	3.5%	20.62	27.6 GB	3.4%	8030.96
Sep 7 19:00:00 - 19:59:59	94500	4.4%	26.25	35.6 GB	4.4%	10359.33
Sep 7 20:00:00 - 20:59:59	99403	4.6%	27.61	35.3 GB	4.4%	10289.08
Sep 7 21:00:00 - 21:59:59	94553	4.4%	26.26	35.2 GB	4.4%	10257.42
Sep 7 22:00:00 - 22:59:59	89048	4.1%	24.74	36.3 GB	4.5%	10571.07
Sep 7 23:00:00 - 23:59:59	95239	4.4%	26.46	36.0 GB	4.5%	10491.30
Sep 8 00:00:00 - 00:59:59	79345	3.7%	22.04	30.6 GB	3.8%	8907.80
Sep 8 01:00:00 - 01:59:59	82921	3.9%	23.03	31.2 GB	3.9%	9100.32
Sep 8 02:00:00 - 02:59:59	97766	4.5%	27.16	37.7 GB	4.7%	10969.99
Sep 8 03:00:00 - 03:59:59	63766	3.0%	17.71	23.1 GB	2.9%	6724.35
Sep 8 04:00:00 - 04:15:04	13394	0.6%	14.82	4.8 GB	0.6%	5611.80
TOTAL: 24:00:00	2150733	100.0%	24.89	800.0 GB	100.0%	9708.87

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	7812	201	3089	0	4522
2	news.nask.pl	1252	19	1209	1	23
3	news.task.gda.pl	1175	890	28	2	255
4	news.icm.edu.pl	37	0	10	0	27
TOTAL: 4		10276	1110	4336	3	4827

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	132
mailing.freebsd.svn-ports-head	132
alt.windows7.general	79
uk.railway	69
fa.freebsd.cvs-all	67
mailing.freebsd.svn-src-all	66
mailing.freebsd.svn-src-head	61
mailing.freebsd.ports-bugs	43
mailing.freebsd.current	37
it.tlc.cellulari.android	32
mozilla.dev.tree-management	32
comp.sys.raspberry-pi	26
mailing.freebsd.ports	20
mailing.openbsd.misc	19
mailing.postfix.users	16
mailing.openbsd.source-changes	16
it.comp.os.win.windows7	15
fr.usenet.abus.nocem	15
mailing.freebsd.kde	14
gnu.hurd.bug	12
TOTAL: 70	1110

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

Groups	Count
fr.comp.lang.php	2
bit.listserv.catholic	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	4460
EMP (fsl)	207
EMP (md5)	45
HTML post	5
Scoring filter (9)	1
TOTAL: 5	4718

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	48269	5569	24341	4416	9	5	11%	23:52:47
2	panorama	37000	2651	32730	738	0	0	7%	23:55:28
3	task	1597	146	788	3	0	0	9%	21:36:30
4	poznan	12770	89	10992	62	0	0	0%	24:07:05
5	nask	15796	4	11585	0	0	0	0%	24:01:38
6	okapi	0	0	0	0	0	1643	0%	24:00:00
TOTAL: 6		115432	8459	80436	5219	9	1648	7%	141:33:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	47.8 MB	1.8 GB	1.8 GB	22.2 KB/s	191.3 KB	23:52:47
2	panorama	7.2 MB	2.4 MB	9.6 MB	0.1 KB/s	2.9 KB	23:55:28
3	task	325.4 KB	6.6 KB	332.0 KB	0.0 KB/s	2.2 KB	21:36:30
4	poznan	300.0 KB	109.2 KB	409.2 KB	0.0 KB/s	2.7 KB	24:07:05
5	nask	7.2 KB	0.0 KB	7.2 KB	0.0 KB/s	1.8 KB	24:01:38
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		55.6 MB	1.8 GB	1.8 GB	3.8 KB/s	140.5 KB	141:33:28

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	336	493.7 KB	288	0	00:00:08
2	web.man.lodz.pl	288	90	106.3 KB	37	0	00:00:21
3	kujawiak.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 3		580	426	600.0 KB	325	4	00:01:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	336	493.7 KB	288	0	00:00:08
2	*.man.lodz.pl	611	90	106.3 KB	37	4	00:00:30
3	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	00:01:00
TOTAL: 3		900	426	600.0 KB	325	4	00:01:39

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ecf183.neoplus.adsl.tpnet.pl	0.000	0.024	00:01:00
web.man.lodz.pl	0.808	5.848	00:00:21
vegas.cm.p.lodz.pl	0.668	5.380	00:00:08
f-oper-v100.man.lodz.pl	0.712	6.020	00:00:06
david.man.lodz.pl	0.056	0.632	00:00:00
kujawiak.man.lodz.pl	0.004	0.112	00:00:00
TOTAL: 6	2.248	18.016	00:01:39

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	289
david.man.lodz.pl	30
ecf183.neoplus.adsl.tpnet.pl	1
TOTAL: 3	320

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	336	78.9%
2	pl	90	21.1%
TOTAL: 2		426	100.0%

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

Newsgroup		Count
1	lodman.info	336
2	pl.comp.os.ms-windows.winnt	48
3	pl.comp.pecet	42
TOTAL: 3		426

Daily Usenet report

Sep 7 04:15:04 -- Sep 8 04:15:04