Daily Usenet report: Jun 29 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jun 29 09:07:37 newsfeed nnrpd[13312]: SERVER perl filter not defined
Jun 29 09:09:19 newsfeed nnrpd[13333]: SERVER perl filter not defined
Jun 29 09:11:46 newsfeed nnrpd[13400]: SERVER perl filter not defined
Jun 29 09:41:22 newsfeed nnrpd[14413]: SERVER perl filter not defined
Jun 29 13:27:38 newsfeed nnrpd[22386]: SERVER perl filter not defined
Jun 29 13:28:37 newsfeed nnrpd[22405]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2702587	98.5%	315.4 MB	98.2%
innd	31668	1.2%	4.6 MB	1.4%
nnrpd	4851	0.2%	503.5 KB	0.2%
innfeed	4842	0.2%	660.7 KB	0.2%
TOTAL: 4	2743948	100.0%	321.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2696264	95.5%
Negative hits	109754	3.9%
Positive hits	16304	0.6%
Cache misses	144	0.0%
TOTAL: 4	2822466	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.283	0.0%	182	0.000	18.038	133.333
article cleanup	00:00:35.740	0.0%	2702469	0.002	0.013	0.025
article logging	00:01:13.947	0.1%	2703096	0.014	0.027	0.379
article parse	01:09:54.924	4.9%	221270306	0.011	0.019	0.055
article write	00:39:30.715	2.7%	2686936	0.311	0.882	5.035
artlog/artcncl	00:00:00.004	0.0%	171	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:40.610	0.2%	238686657	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.633	0.0%	162	0.000	3.907	29.000
hishave/artcncl	00:00:00.094	0.0%	182	0.000	0.516	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:46.227	1.8%	2823459	0.078	0.548	13.515
history sync	00:00:00.007	0.0%	290	0.000	0.024	1.000
history write	00:37:41.009	2.6%	2697308	0.172	0.838	48.374
hiswrite/artcncl	00:00:00.030	0.0%	20	0.000	1.500	13.000
idle	13:37:06.580	56.7%	163525254	0.130	0.300	0.610
nntp read	01:08:47.487	4.8%	219215645	0.013	0.019	0.028
overview write	00:00:14.656	0.0%	2686936	0.001	0.005	0.012
perl filter	05:19:16.092	22.2%	2697308	4.872	7.102	9.399
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:25.023	0.3%	5515984	0.031	0.048	0.074
TOTAL: 24:00:20.982	23:07:17.061	96.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.480	0.0%	166588	0.000	0.003	0.333
article prepare	00:00:00.103	0.0%	490700	0.000	0.000	0.042
article read	00:03:13.128	0.2%	122455	0.000	1.577	215.000
backlog stats	00:00:00.754	0.0%	810978	0.000	0.001	0.045
callbacks	00:00:00.000	0.0%	11	0.000	0.000	0.000
data read	00:00:03.764	0.0%	345350	0.000	0.011	0.074
data write	00:00:56.497	0.1%	472241	0.000	0.120	0.667
idle	23:56:17.914	99.7%	810978	12.677	106.264	4378.000
status file	00:00:00.811	0.0%	1121	0.000	0.723	2.000
TOTAL: 24:00:49.699	24:00:33.451	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.186	0.0%	656	0.220	0.284	0.381
idle	02:30:27.049	99.8%	3807	0.000	2371.171	360039.200
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.199	0.0%	8298	0.000	0.024	0.500
readart	00:00:00.748	0.0%	76	0.000	9.842	37.421
TOTAL: 02:30:40.775	02:30:28.182	99.9%	-	-	-	-

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	1170	2688089	2672582	8228	7279	99%	333:57:47
2	news.nask.pl	2	24523	13618	2630	8275	55%	23:54:04
3	news.icm.edu.pl	51	284	26	244	14	9%	17:06:49
4	localhost	7	6	6	0	0	100%	00:00:00
TOTAL: 4		1230	2712902	2686232	11102	15568	99%	374:58:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	820.4 GB	158.8 MB	579.2 MB	821.1 GB	99%	321.3 KB
2	news.nask.pl	96.1 MB	1.9 MB	179.6 MB	277.6 MB	34%	13.0 KB
3	news.icm.edu.pl	587.8 KB	15.4 KB	317.4 KB	920.6 KB	63%	23.0 KB
4	localhost	9.1 KB	0.0 KB	0.0 KB	9.1 KB	100%	1.5 KB
TOTAL: 4		820.5 GB	160.7 MB	759.2 MB	821.4 GB	99%	318.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 29 04:15:02 - 04:59:59	71936	2.7%	26.66	23.1 GB	2.8%	8986.32
Jun 29 05:00:00 - 05:59:59	96236	3.6%	26.73	31.6 GB	3.9%	9189.64
Jun 29 06:00:00 - 06:59:59	95687	3.6%	26.58	32.9 GB	4.0%	9597.16
Jun 29 07:00:00 - 07:59:59	96959	3.6%	26.93	34.0 GB	4.1%	9890.43
Jun 29 08:00:00 - 08:59:59	97641	3.6%	27.12	33.1 GB	4.0%	9651.98
Jun 29 09:00:00 - 09:59:59	111392	4.1%	30.94	34.1 GB	4.2%	9931.26
Jun 29 10:00:00 - 10:59:59	99249	3.7%	27.57	32.1 GB	3.9%	9336.67
Jun 29 11:00:00 - 11:59:59	108450	4.0%	30.12	35.9 GB	4.4%	10444.39
Jun 29 12:00:00 - 12:59:59	120029	4.5%	33.34	36.8 GB	4.5%	10711.41
Jun 29 13:00:00 - 13:59:59	119710	4.5%	33.25	37.5 GB	4.6%	10933.14
Jun 29 14:00:00 - 14:59:59	129836	4.8%	36.07	37.4 GB	4.6%	10894.63
Jun 29 15:00:00 - 15:59:59	140581	5.2%	39.05	39.2 GB	4.8%	11420.73
Jun 29 16:00:00 - 16:59:59	124115	4.6%	34.48	38.1 GB	4.7%	11098.82
Jun 29 17:00:00 - 17:59:59	119122	4.4%	33.09	38.7 GB	4.7%	11261.23
Jun 29 18:00:00 - 18:59:59	105531	3.9%	29.31	35.7 GB	4.4%	10395.74
Jun 29 19:00:00 - 19:59:59	131288	4.9%	36.47	35.4 GB	4.3%	10303.22
Jun 29 20:00:00 - 20:59:59	121730	4.5%	33.81	33.1 GB	4.0%	9628.91
Jun 29 21:00:00 - 21:59:59	105078	3.9%	29.19	30.6 GB	3.7%	8907.98
Jun 29 22:00:00 - 22:59:59	137146	5.1%	38.10	38.4 GB	4.7%	11193.16
Jun 29 23:00:00 - 23:59:59	140190	5.2%	38.94	38.2 GB	4.7%	11126.30
Jun 30 00:00:00 - 00:59:59	95951	3.6%	26.65	27.8 GB	3.4%	8095.95
Jun 30 01:00:00 - 01:59:59	111032	4.1%	30.84	32.0 GB	3.9%	9312.02
Jun 30 02:00:00 - 02:59:59	82221	3.1%	22.84	25.8 GB	3.1%	7500.74
Jun 30 03:00:00 - 03:59:59	104492	3.9%	29.03	31.8 GB	3.9%	9269.78
Jun 30 04:00:00 - 04:15:02	20655	0.8%	22.90	6.4 GB	0.8%	7391.71
TOTAL: 24:00:00	2686257	100.0%	31.09	819.4 GB	100.0%	9945.09

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	8458	42	420	9	7987
2	newsfeed.pionier.net.pl	7687	184	4741	0	2762
3	news.icm.edu.pl	14	0	1	0	13
TOTAL: 3		16159	226	5162	9	10762

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	124
comp.mobile.ipad	24
comp.mobile.android	21
it.comp.os.win.windows10	20
it.tlc.cellulari.android	12
hr.ponuda.hardver.komponente	10
it.comp.os.win.windows7	7
de.rec.sf.startrek	3
uk.rec.cycling.moderated	3
hr.ponuda.hardver.periferije	1
hr.ponuda.hardver.konfiguracije	1
TOTAL: 11	226

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

Groups	Count
pl.praca.oferowana	8
bit.listserv.catholic	1
TOTAL: 2	9

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	6399
Binary in non-binary group	3123
Scoring filter (8)	248
EMP (phl)	131
PFM bot misc	100
Scoring filter (9)	39
HTML post	25
Scoring filter (10)	20
Scoring filter (11)	14
Scoring filter (12)	8
Poison newsgroup	6
Scoring filter (20)	5
Scoring filter (13)	4
Scoring filter (15)	4
Scoring filter (23)	2
Scoring filter (17)	2
Scoring filter (24)	2
Scoring filter (14)	1
Scoring filter (18)	1
Scoring filter (16)	1
TOTAL: 20	10135

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	144172	96787	20341	22234	2	12008	67%	23:59:42
2	panorama	28082	2143	23139	915	28	128206	7%	23:57:17
3	poznan	21300	214	13158	101	0	0	1%	23:51:16
4	nask	4894	12	3300	1	0	0	0%	23:54:21
5	okapi	0	0	0	0	0	2252	0%	24:00:01
TOTAL: 5		198448	99156	59938	23251	30	142466	49%	119:42:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	17.3 GB	4.7 GB	21.9 GB	266.3 KB/s	193.3 KB	23:59:42
2	panorama	9.6 MB	22.9 MB	32.5 MB	0.4 KB/s	10.9 KB	23:57:17
3	poznan	1.1 MB	421.3 KB	1.6 MB	0.0 KB/s	5.1 KB	23:51:16
4	nask	113.0 KB	1.8 KB	114.8 KB	0.0 KB/s	8.8 KB	23:54:21
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		17.3 GB	4.7 GB	22.0 GB	53.5 KB/s	188.2 KB	119:42:37

Backlog files shrunk by innfeed:

Server	Size
panorama	11.0 MB
TOTAL: 1	11.0 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	48	41.0 KB	21	0	00:00:26
2	pc-mstarzak.cm.p.lodz.pl	2	19	29.2 KB	2	0	01:03:31
3	staticline-31-182-94-33.toya.net.pl	4	9	13.2 KB	1	0	01:26:23
4	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 4		300	76	83.4 KB	24	6	02:30:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	678	48	41.0 KB	21	6	00:00:31
2	*.cm.p.lodz.pl	2	19	29.2 KB	2	0	01:03:31
3	*.toya.net.pl	4	9	13.2 KB	1	0	01:26:23
4	*.elsnet.pl	4	0	0.0 KB	0	0	00:00:14
TOTAL: 4		688	76	83.4 KB	24	6	02:30:40

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
staticline-31-182-94-33.toya.net.pl	0.026	0.148	01:26:23
pc-mstarzak.cm.p.lodz.pl	0.004	0.039	01:03:31
web.man.lodz.pl	0.966	4.168	00:00:26
host227.elsnet.pl	0.008	0.047	00:00:14
mon.man.lodz.pl	0.916	3.327	00:00:03
david.man.lodz.pl	0.275	1.134	00:00:01
isvcs01.man.lodz.pl	0.040	0.053	00:00:00
TOTAL: 7	2.235	8.916	02:30:40

Curious NNRP server explorers [Top 20]:

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-mstarzak.cm.p.lodz.pl	2	0
staticline-31-182-94-33.toya.net.pl	1	0
TOTAL: 2	3	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	63	82.9%
2	lodman	13	17.1%
TOTAL: 2		76	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	26
2	pl.comp.pecet	22
3	pl.regionalne.lodz	15
4	lodman.info	13
TOTAL: 4		76

Daily Usenet report

Jun 29 04:15:02 -- Jun 30 04:15:02