Daily Usenet report: Sep 19 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 19 13:38:19 newsfeed nnrpd[6980]: SERVER perl filter not defined
Sep 19 14:18:55 newsfeed nnrpd[8371]: SERVER perl filter not defined
Sep 19 14:23:54 newsfeed nnrpd[8469]: SERVER perl filter not defined
Sep 19 19:39:25 newsfeed nnrpd[19614]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2969400	98.5%	351.5 MB	98.3%
innd	35176	1.2%	5.0 MB	1.4%
nnrpd	4844	0.2%	498.8 KB	0.1%
innfeed	4827	0.2%	672.3 KB	0.2%
TOTAL: 4	3014247	100.0%	357.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2962238	96.3%
Negative hits	99926	3.2%
Positive hits	14628	0.5%
Cache misses	246	0.0%
TOTAL: 4	3077038	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.719	0.0%	164	0.000	34.872	1342.000
article cleanup	00:00:43.347	0.1%	2969717	0.006	0.015	0.033
article logging	00:01:27.554	0.1%	2970242	0.016	0.029	0.797
article parse	01:17:37.788	5.4%	208386228	0.011	0.022	0.081
article write	00:24:49.187	1.7%	2953544	0.349	0.504	2.375
artlog/artcncl	00:00:00.002	0.0%	163	0.000	0.012	0.111
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:44.354	0.2%	226655974	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.078	0.0%	113	0.000	0.690	17.000
hishave/artcncl	00:00:00.063	0.0%	164	0.000	0.384	11.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:35:36.291	2.5%	3081284	0.111	0.693	9.032
history sync	00:00:00.016	0.0%	290	0.000	0.055	1.000
history write	00:48:28.669	3.4%	2966452	0.188	0.981	9.419
hiswrite/artcncl	00:00:00.107	0.0%	51	0.000	2.098	27.000
idle	12:35:36.432	52.5%	147553821	0.162	0.307	0.470
nntp read	01:12:15.720	5.0%	206030678	0.013	0.021	0.053
overview write	00:00:16.669	0.0%	2953544	0.001	0.006	0.015
perl filter	06:02:27.060	25.2%	2966452	5.493	7.331	12.275
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:49.380	0.3%	5938309	0.030	0.049	0.097
TOTAL: 24:00:21.097	23:06:58.436	96.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.161	0.0%	58567	0.000	0.003	0.118
article prepare	00:00:00.011	0.0%	38110	0.000	0.000	0.036
article read	00:00:29.979	0.0%	9540	0.000	3.142	646.400
backlog stats	00:00:00.198	0.0%	213910	0.000	0.001	0.032
callbacks	00:00:00.000	0.0%	16	0.000	0.000	0.000
data read	00:00:01.461	0.0%	113322	0.000	0.013	0.104
data write	00:00:07.480	0.0%	97905	0.000	0.076	0.380
idle	23:59:10.006	99.9%	213910	13.465	403.674	3573.909
status file	00:00:00.625	0.0%	858	0.000	0.728	2.000
TOTAL: 23:59:55.602	23:59:49.921	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:14:43.263	99.6%	11259	0.000	398.194	140495.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.502	0.0%	23261	0.000	0.022	0.500
readart	00:00:00.174	0.0%	87	0.000	2.000	56.000
TOTAL: 01:14:59.058	01:14:43.939	99.7%	-	-	-	-

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	1092	2953591	2942095	7598	3898	99%	341:58:53
2	news.nask.pl	1	26404	10625	3594	12185	40%	23:48:13
3	news.icm.edu.pl	38	330	23	284	23	6%	18:11:45
4	localhost	5	4	4	0	0	100%	00:00:01
TOTAL: 4		1136	2980329	2952747	11476	16106	99%	383:58:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	869.5 GB	22.2 MB	102.1 MB	869.7 GB	99%	309.5 KB
2	news.nask.pl	52.1 MB	910.8 KB	138.5 MB	191.4 MB	27%	8.6 KB
3	news.icm.edu.pl	634.9 KB	8.5 KB	431.1 KB	1.0 MB	59%	23.4 KB
4	localhost	5.6 KB	0.0 KB	0.0 KB	5.6 KB	100%	1.4 KB
TOTAL: 4		869.6 GB	23.1 MB	241.0 MB	869.9 GB	99%	307.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 19 04:15:02 - 04:59:59	103435	3.5%	38.34	30.5 GB	3.5%	11842.37
Sep 19 05:00:00 - 05:59:59	131697	4.5%	36.58	40.9 GB	4.7%	11923.00
Sep 19 06:00:00 - 06:59:59	117512	4.0%	32.64	38.4 GB	4.4%	11186.72
Sep 19 07:00:00 - 07:59:59	137310	4.7%	38.14	41.5 GB	4.8%	12078.35
Sep 19 08:00:00 - 08:59:59	144119	4.9%	40.03	43.2 GB	5.0%	12577.09
Sep 19 09:00:00 - 09:59:59	153307	5.2%	42.59	42.5 GB	4.9%	12392.26
Sep 19 10:00:00 - 10:59:59	148233	5.0%	41.18	42.0 GB	4.8%	12232.98
Sep 19 11:00:00 - 11:59:59	145593	4.9%	40.44	40.8 GB	4.7%	11885.90
Sep 19 12:00:00 - 12:59:59	140153	4.7%	38.93	39.7 GB	4.6%	11576.72
Sep 19 13:00:00 - 13:59:59	141055	4.8%	39.18	39.9 GB	4.6%	11631.90
Sep 19 14:00:00 - 14:59:59	95402	3.2%	26.50	29.3 GB	3.4%	8545.56
Sep 19 15:00:00 - 15:59:59	93694	3.2%	26.03	29.3 GB	3.4%	8529.69
Sep 19 16:00:00 - 16:59:59	91842	3.1%	25.51	27.4 GB	3.2%	7992.21
Sep 19 17:00:00 - 17:59:59	99765	3.4%	27.71	30.1 GB	3.5%	8757.68
Sep 19 18:00:00 - 18:59:59	79400	2.7%	22.06	25.8 GB	3.0%	7520.86
Sep 19 19:00:00 - 19:59:59	117988	4.0%	32.77	33.3 GB	3.8%	9706.98
Sep 19 20:00:00 - 20:59:59	115765	3.9%	32.16	34.2 GB	3.9%	9951.37
Sep 19 21:00:00 - 21:59:59	137468	4.7%	38.19	39.1 GB	4.5%	11382.62
Sep 19 22:00:00 - 22:59:59	146059	4.9%	40.57	40.1 GB	4.6%	11692.02
Sep 19 23:00:00 - 23:59:59	127087	4.3%	35.30	37.9 GB	4.4%	11046.00
Sep 20 00:00:00 - 00:59:59	110459	3.7%	30.68	31.5 GB	3.6%	9172.29
Sep 20 01:00:00 - 01:59:59	140744	4.8%	39.10	38.0 GB	4.4%	11070.04
Sep 20 02:00:00 - 02:59:59	112841	3.8%	31.34	32.7 GB	3.8%	9524.10
Sep 20 03:00:00 - 03:59:59	96845	3.3%	26.90	30.8 GB	3.5%	8969.16
Sep 20 04:00:00 - 04:15:04	24771	0.8%	27.40	8.4 GB	1.0%	9794.85
TOTAL: 24:00:02	2952544	100.0%	34.17	867.5 GB	100.0%	10528.10

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12449	18	252	1	12178
2	newsfeed.pionier.net.pl	4220	198	3007	0	1015
3	news.icm.edu.pl	24	0	1	0	23
TOTAL: 3		16693	216	3260	1	13216

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	139
it.tlc.cellulari.android	26
comp.mobile.android	13
it.comp.os.win.windows10	6
uk.rec.cycling.moderated	6
comp.mobile.ipad	5
it.comp.os.win.windows7	5
de.rec.sf.startrek	3
it.discussioni.energia	3
hr.alt.cellular.gsm.iphone	2
rec.arts.tv.x-factor	2
hr.rec.glazba.hifi	1
comp.sys.mac.vintage	1
alt.sex.telephones	1
it.comp.os.linux.ubuntu	1
de.comp.lang.vbclassic	1
it.tlc.cellulari.iphone	1
TOTAL: 17	216

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11583
Binary in non-binary group	867
EMP (phl)	120
Scoring filter (8)	78
Scoring filter (9)	16
Scoring filter (13)	7
Scoring filter (10)	7
Scoring filter (12)	6
Scoring filter (11)	5
EMP (fsl)	1
Poison newsgroup	1
TOTAL: 11	12691

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	27623	1366	24521	375	29	32369	4%	24:03:18
2	icm	37316	142	23084	7316	0	18	0%	23:56:28
3	poznan	16593	112	10536	14	0	0	0%	23:57:19
4	nask	7178	22	4844	27	0	0	0%	23:58:29
5	okapi	0	0	0	0	0	2321	0%	24:00:02
TOTAL: 5		88710	1642	62985	7732	29	34708	1%	119:55:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	6.6 MB	1.7 MB	8.4 MB	0.1 KB/s	4.9 KB	24:03:18
2	icm	4.3 MB	1.8 GB	1.8 GB	21.5 KB/s	248.7 KB	23:56:28
3	poznan	441.8 KB	29.2 KB	471.0 KB	0.0 KB/s	3.7 KB	23:57:19
4	nask	163.9 KB	8.7 MB	8.8 MB	0.1 KB/s	184.3 KB	23:58:29
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		11.6 MB	1.8 GB	1.8 GB	4.3 KB/s	199.8 KB	119:55:36

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	84	88.5 KB	39	0	00:00:21
2	5.172.236.68	2	3	2.7 KB	2	0	00:20:07
3	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 3		294	87	91.2 KB	41	4	01:14:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	84	88.5 KB	39	4	00:00:26
2	unresolved	5	3	2.7 KB	2	0	01:14:31
TOTAL: 2		681	87	91.2 KB	41	4	01:14:58

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.41.67	0.469	0.638	00:54:24
5.172.236.68	0.033	0.043	00:20:07
web.man.lodz.pl	0.825	4.969	00:00:21
mon.man.lodz.pl	0.931	4.741	00:00:03
david.man.lodz.pl	0.322	1.641	00:00:01
isvcs01.man.lodz.pl	0.021	0.076	00:00:00
TOTAL: 6	2.601	12.108	01:14:58

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
89.38.41.67	3
TOTAL: 3	387

NNRP client timeouts [Top 20]:

System	Conn	Peer
89.38.41.67	2	1
TOTAL: 1	2	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	84	96.6%
2	lodzman	2	2.3%
3	lodman	1	1.1%
TOTAL: 3		87	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	58
2	pl.comp.os.ms-windows.winnt	26
3	lodzman.test	2
4	lodman.test	1
TOTAL: 4		87

Daily Usenet report

Sep 19 04:15:02 -- Sep 20 04:15:04