Daily Usenet report: Sep 20 04:15:05

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Sep 20 11:27:14 newsfeed nnrpd[3842]: message repeated 6 times: [ abcl198.neoplus.adsl.tpnet.pl group lodzman.listserv 0]
Sep 20 11:39:55 newsfeed nnrpd[4352]: message repeated 3 times: [ abcl198.neoplus.adsl.tpnet.pl group lodz.ogolne 0]
Sep 20 16:20:11 newsfeed nnrpd[14019]: SERVER perl filter not defined
Sep 20 16:21:44 newsfeed nnrpd[14035]: SERVER perl filter not defined
Sep 20 16:23:50 newsfeed nnrpd[14054]: SERVER perl filter not defined
Sep 20 16:28:07 newsfeed nnrpd[14284]: SERVER perl filter not defined
Sep 20 16:29:22 newsfeed nnrpd[14305]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2622212	98.4%	310.2 MB	98.2%
innd	31613	1.2%	4.5 MB	1.4%
nnrpd	4862	0.2%	503.1 KB	0.2%
innfeed	4830	0.2%	666.8 KB	0.2%
TOTAL: 4	2663517	100.0%	315.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2616180	95.9%
Negative hits	95501	3.5%
Positive hits	15248	0.6%
Cache misses	109	0.0%
TOTAL: 4	2727038	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.636	0.0%	178	0.000	3.573	91.000
article cleanup	00:00:38.732	0.0%	2622164	0.000	0.015	0.034
article logging	00:01:23.281	0.1%	2622787	0.000	0.032	0.777
article parse	01:10:44.062	4.9%	204028770	0.000	0.021	0.077
article write	00:24:10.320	1.7%	2607619	0.000	0.556	3.926
artlog/artcncl	00:00:00.005	0.0%	175	0.000	0.029	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:37.779	0.2%	220711828	0.000	0.001	0.034
hisgrep/artcncl	00:00:00.109	0.0%	160	0.000	0.681	17.000
hishave/artcncl	00:00:00.044	0.0%	178	0.000	0.247	7.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:28:52.858	2.0%	2729571	0.080	0.635	8.131
history sync	00:00:00.016	0.0%	297	0.000	0.054	1.000
history write	00:39:11.654	2.7%	2618689	0.227	0.898	9.645
hiswrite/artcncl	00:00:00.054	0.0%	18	0.000	3.000	20.000
idle	13:34:08.593	56.5%	153748252	0.142	0.318	1680.972
nntp read	01:08:39.146	4.8%	202004430	0.000	0.020	0.079
overview write	00:00:15.089	0.0%	2607619	0.000	0.006	0.062
perl filter	05:30:10.574	22.9%	2618689	1.147	7.565	31.227
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:23.645	0.3%	5255454	0.029	0.050	0.222
TOTAL: 24:00:20.033	23:05:16.597	96.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.159	0.0%	45509	0.000	0.003	0.143
article prepare	00:00:00.022	0.0%	70488	0.000	0.000	0.022
article read	00:00:33.949	0.0%	17624	0.000	1.926	457.750
backlog stats	00:00:00.234	0.0%	252700	0.000	0.001	0.030
callbacks	00:00:00.000	0.0%	3	0.000	0.000	0.000
data read	00:00:01.767	0.0%	127503	0.000	0.014	0.125
data write	00:00:13.001	0.0%	121841	0.000	0.107	0.354
idle	23:59:02.151	99.9%	252700	18.005	341.678	2633.870
status file	00:00:00.587	0.0%	847	0.000	0.693	2.000
TOTAL: 23:59:58.459	23:59:51.870	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:05:35.749	99.6%	21007	0.000	187.354	188857.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.412	0.0%	42731	0.000	0.033	18.719
readart	00:00:00.099	0.0%	50	0.000	1.980	20.000
TOTAL: 01:05:51.560	01:05:37.260	99.6%	-	-	-	-

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	1067	2606362	2595120	7821	3421	99%	324:07:59
2	news.nask.pl	2	26111	11281	3655	11175	43%	24:12:05
3	news.icm.edu.pl	48	282	21	254	7	7%	17:08:00
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		1123	2632760	2606427	11730	14603	98%	365:28:04

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	814.8 GB	39.7 MB	41.1 MB	814.9 GB	99%	328.8 KB
2	news.nask.pl	58.5 MB	976.7 KB	126.9 MB	186.3 MB	31%	8.5 KB
3	news.icm.edu.pl	674.0 KB	20.3 KB	75.2 KB	769.5 KB	87%	27.5 KB
4	localhost	9.0 KB	0.0 KB	0.0 KB	9.0 KB	100%	1.8 KB
TOTAL: 4		814.9 GB	40.7 MB	168.0 MB	815.1 GB	99%	326.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 20 04:15:05 - 04:59:59	80094	3.1%	29.72	28.0 GB	3.4%	10909.14
Sep 20 05:00:00 - 05:59:59	104626	4.0%	29.06	37.2 GB	4.6%	10830.09
Sep 20 06:00:00 - 06:59:59	100614	3.9%	27.95	37.1 GB	4.6%	10812.73
Sep 20 07:00:00 - 07:59:59	137099	5.3%	38.08	41.3 GB	5.1%	12028.42
Sep 20 08:00:00 - 08:59:59	142873	5.5%	39.69	43.3 GB	5.3%	12624.03
Sep 20 09:00:00 - 09:59:59	141891	5.4%	39.41	42.3 GB	5.2%	12326.36
Sep 20 10:00:00 - 10:59:59	138542	5.3%	38.48	41.3 GB	5.1%	12015.52
Sep 20 11:00:00 - 11:59:59	138461	5.3%	38.46	39.1 GB	4.8%	11392.65
Sep 20 12:00:00 - 12:59:59	128335	4.9%	35.65	37.9 GB	4.7%	11039.21
Sep 20 13:00:00 - 13:59:59	121651	4.7%	33.79	36.9 GB	4.5%	10745.85
Sep 20 14:00:00 - 14:59:59	143364	5.5%	39.82	40.9 GB	5.0%	11910.07
Sep 20 15:00:00 - 15:59:59	122781	4.7%	34.11	38.0 GB	4.7%	11079.52
Sep 20 16:00:00 - 16:59:59	142072	5.4%	39.46	40.2 GB	4.9%	11696.31
Sep 20 17:00:00 - 17:59:59	144950	5.6%	40.26	41.1 GB	5.0%	11964.03
Sep 20 18:00:00 - 18:59:59	101564	3.9%	28.21	31.9 GB	3.9%	9294.40
Sep 20 19:00:00 - 19:59:59	57620	2.2%	16.01	20.5 GB	2.5%	5971.41
Sep 20 20:00:00 - 20:59:59	67573	2.6%	18.77	24.7 GB	3.0%	7190.74
Sep 20 21:00:00 - 21:59:59	64512	2.5%	17.92	22.3 GB	2.7%	6509.10
Sep 20 22:00:00 - 22:59:59	67062	2.6%	18.63	22.9 GB	2.8%	6659.35
Sep 20 23:00:00 - 23:59:59	63334	2.4%	17.59	20.5 GB	2.5%	5962.34
Sep 21 00:00:00 - 00:59:59	73608	2.8%	20.45	23.3 GB	2.9%	6779.40
Sep 21 01:00:00 - 01:59:59	113522	4.4%	31.53	35.3 GB	4.3%	10270.30
Sep 21 02:00:00 - 02:59:59	90405	3.5%	25.11	29.3 GB	3.6%	8525.20
Sep 21 03:00:00 - 03:59:59	97007	3.7%	26.95	31.0 GB	3.8%	9031.30
Sep 21 04:00:00 - 04:15:01	23309	0.9%	25.87	7.5 GB	0.9%	8742.56
TOTAL: 23:59:56	2606869	100.0%	30.17	813.7 GB	100.0%	9876.00

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	11349	11	313	4	11021
2	newsfeed.pionier.net.pl	3812	184	3160	1	467
3	news.icm.edu.pl	7	0	2	0	5
TOTAL: 3		15168	195	3475	5	11493

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	131
it.tlc.cellulari.android	17
it.comp.os.win.windows7	14
comp.mobile.android	13
it.comp.os.win.windows10	9
uk.rec.cycling.moderated	4
it.discussioni.energia	2
comp.mobile.ipad	2
alt.sex.telephones	1
nl.comp.os.linux.techniek	1
hr.alt.cellular.gsm.android	1
TOTAL: 11	195

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10399
Binary in non-binary group	172
Scoring filter (8)	107
EMP (phl)	81
Scoring filter (10)	36
Scoring filter (9)	34
Scoring filter (11)	12
Adult group ECP	8
Scoring filter (12)	6
HTML post	5
Scoring filter (13)	4
Too many newsgroups	1
Angle-bracket bot	1
Scoring filter (23)	1
Scoring filter (20)	1
Scoring filter (24)	1
Scoring filter (14)	1
TOTAL: 17	10870

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	5220	1565	1792	547	10	41432	29%	23:56:38
2	icm	47802	409	24449	14733	0	0	0%	23:59:04
3	poznan	17316	133	11054	23	0	101	0%	24:03:52
4	nask	7405	26	4817	2	0	0	0%	23:58:28
5	okapi	0	0	0	0	0	2094	0%	24:00:01
TOTAL: 5		77743	2133	42112	15305	10	43627	2%	119:58:03

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	10.3 MB	3.4 MB	13.7 MB	0.2 KB/s	6.6 KB	23:56:38
2	icm	3.4 MB	3.6 GB	3.6 GB	43.5 KB/s	248.2 KB	23:59:04
3	poznan	506.9 KB	59.8 KB	566.7 KB	0.0 KB/s	3.6 KB	24:03:52
4	nask	222.4 KB	3.7 KB	226.1 KB	0.0 KB/s	8.1 KB	23:58:28
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		14.4 MB	3.6 GB	3.6 GB	8.7 KB/s	216.4 KB	119:58:03

Backlog files shrunk by innfeed:

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

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	44	88.6 KB	21	0	00:00:21
2	abcl198.neoplus.adsl.tpnet.pl	6	6	6.8 KB	4	0	00:05:19
3	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:01
TOTAL: 3		299	50	95.4 KB	25	5	01:05:51

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	677	44	88.6 KB	21	5	00:00:27
2	*.neoplus.adsl.tpnet.pl	6	6	6.8 KB	4	0	00:05:19
3	unresolved	4	0	0.0 KB	0	0	01:00:03
TOTAL: 3		687	50	95.4 KB	25	5	01:05:51

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.41.67	1.090	1.138	00:33:32
89.231.4.237	0.042	0.040	00:26:31
abcl198.neoplus.adsl.tpnet.pl	0.186	0.142	00:05:19
web.man.lodz.pl	0.971	5.053	00:00:21
mon.man.lodz.pl	0.929	4.883	00:00:03
isvcs01.man.lodz.pl	0.014	0.089	00:00:01
david.man.lodz.pl	0.255	1.512	00:00:00
TOTAL: 7	3.487	12.857	01:05:51

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
89.231.4.237	2
89.38.41.67	2
TOTAL: 4	388

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	44	88.0%
2	lodzman	4	8.0%
3	lodz	2	4.0%
TOTAL: 3		50	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	44
2	lodzman.test	4
3	lodz.ogloszenia	2
TOTAL: 3		50

Daily Usenet report

Sep 20 04:15:05 -- Sep 21 04:15:01