Daily Usenet report: Nov 4 04:15:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Nov 4 09:44:36 newsfeed nnrpd[20778]: SERVER perl filter not defined
Nov 4 10:06:04 newsfeed nnrpd[21559]: SERVER perl filter not defined
Nov 4 10:10:00 newsfeed nnrpd[21613]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2982729	98.6%	348.3 MB	98.3%
innd	33556	1.1%	4.9 MB	1.4%
nnrpd	5050	0.2%	522.5 KB	0.1%
innfeed	4818	0.2%	666.2 KB	0.2%
TOTAL: 4	3026153	100.0%	354.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2977020	97.0%
Negative hits	81054	2.6%
Positive hits	12398	0.4%
Cache misses	111	0.0%
TOTAL: 4	3070583	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.010	0.0%	281	0.000	17.829	1652.000
article cleanup	00:00:48.186	0.1%	2982247	0.008	0.016	0.031
article logging	00:01:43.254	0.1%	2982852	0.019	0.035	0.982
article parse	01:19:55.128	5.5%	157044828	0.016	0.031	0.064
article write	00:27:12.967	1.9%	2966895	0.333	0.550	2.145
artlog/artcncl	00:00:00.003	0.0%	203	0.000	0.015	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:18.828	0.2%	174333003	0.001	0.001	0.003
hisgrep/artcncl	00:00:00.618	0.0%	250	0.000	2.472	335.000
hishave/artcncl	00:00:00.102	0.0%	281	0.000	0.363	5.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:29:20.297	2.0%	3071049	0.151	0.573	9.050
history sync	00:00:00.019	0.0%	290	0.000	0.066	2.000
history write	00:40:38.529	2.8%	2977639	0.250	0.819	10.120
hiswrite/artcncl	00:00:00.035	0.0%	31	0.000	1.129	10.000
idle	12:45:45.621	53.2%	92910672	0.325	0.495	1.252
nntp read	01:08:17.847	4.7%	154496507	0.015	0.027	0.044
overview write	00:00:19.581	0.0%	2966895	0.001	0.007	0.014
perl filter	06:15:16.975	26.1%	2977639	5.592	7.562	9.811
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:09.156	0.4%	5959932	0.035	0.052	0.100
TOTAL: 24:00:17.898	23:17:52.156	97.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.122	0.0%	34557	0.000	0.004	0.200
article prepare	00:00:00.006	0.0%	18940	0.000	0.000	0.062
article read	00:00:26.673	0.0%	4796	0.000	5.562	579.000
backlog stats	00:00:00.137	0.0%	153662	0.000	0.001	0.036
callbacks	00:00:00.000	0.0%	44	0.000	0.000	0.000
data read	00:00:01.192	0.0%	85194	0.000	0.014	0.150
data write	00:00:03.586	0.0%	63238	0.000	0.057	0.253
idle	23:58:55.892	100.0%	153662	133.817	561.856	4024.333
status file	00:00:00.657	0.0%	848	0.000	0.775	10.000
TOTAL: 23:59:32.972	23:59:28.265	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:31:38.254	99.8%	3352	0.000	2714.276	236874.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.357	0.0%	7588	0.000	0.047	8.056
readart	00:00:02.751	0.0%	150	0.000	18.340	42.222
TOTAL: 02:31:54.529	02:31:41.362	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	1197	2969419	2958201	4342	6876	99%	427:33:32
2	news.nask.pl	2	20048	8488	3091	8469	42%	24:00:03
3	news.icm.edu.pl	42	259	4	247	8	1%	16:46:19
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		1245	2989729	2966696	7680	15353	99%	468:19:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	854.9 GB	51.0 MB	568.5 MB	855.5 GB	99%	302.6 KB
2	news.nask.pl	40.4 MB	1.5 MB	115.1 MB	156.9 MB	25%	9.5 KB
3	news.icm.edu.pl	58.5 KB	0.0 KB	440.2 KB	498.7 KB	11%	41.6 KB
4	localhost	5.4 KB	0.0 KB	0.0 KB	5.4 KB	100%	1.8 KB
TOTAL: 4		855.0 GB	52.5 MB	684.0 MB	855.7 GB	99%	300.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 4 04:15:01 - 04:59:59	66599	2.2%	24.68	22.3 GB	2.6%	8672.28
Nov 4 05:00:00 - 05:59:59	112629	3.8%	31.29	37.8 GB	4.4%	11008.74
Nov 4 06:00:00 - 06:59:59	116116	3.9%	32.25	39.0 GB	4.6%	11351.66
Nov 4 07:00:00 - 07:59:59	123119	4.2%	34.20	37.9 GB	4.4%	11030.18
Nov 4 08:00:00 - 08:59:59	92355	3.1%	25.65	26.8 GB	3.1%	7815.88
Nov 4 09:00:00 - 09:59:59	126911	4.3%	35.25	35.3 GB	4.1%	10281.00
Nov 4 10:00:00 - 10:59:59	126280	4.3%	35.08	34.1 GB	4.0%	9925.97
Nov 4 11:00:00 - 11:59:59	108547	3.7%	30.15	32.3 GB	3.8%	9402.61
Nov 4 12:00:00 - 12:59:59	106827	3.6%	29.67	34.9 GB	4.1%	10177.77
Nov 4 13:00:00 - 13:59:59	108302	3.7%	30.08	35.1 GB	4.1%	10229.54
Nov 4 14:00:00 - 14:59:59	127770	4.3%	35.49	36.8 GB	4.3%	10729.18
Nov 4 15:00:00 - 15:59:59	143308	4.8%	39.81	40.5 GB	4.7%	11791.37
Nov 4 16:00:00 - 16:59:59	146085	4.9%	40.58	40.6 GB	4.8%	11833.87
Nov 4 17:00:00 - 17:59:59	142913	4.8%	39.70	39.2 GB	4.6%	11430.75
Nov 4 18:00:00 - 18:59:59	126663	4.3%	35.18	35.4 GB	4.1%	10323.84
Nov 4 19:00:00 - 19:59:59	114367	3.9%	31.77	32.8 GB	3.8%	9561.17
Nov 4 20:00:00 - 20:59:59	134235	4.5%	37.29	35.8 GB	4.2%	10425.03
Nov 4 21:00:00 - 21:59:59	119996	4.0%	33.33	35.0 GB	4.1%	10201.50
Nov 4 22:00:00 - 22:59:59	135300	4.6%	37.58	37.1 GB	4.3%	10820.25
Nov 4 23:00:00 - 23:59:59	146149	4.9%	40.60	39.3 GB	4.6%	11439.57
Nov 5 00:00:00 - 00:59:59	120818	4.1%	33.56	34.0 GB	4.0%	9917.06
Nov 5 01:00:00 - 01:59:59	120304	4.1%	33.42	32.2 GB	3.8%	9373.63
Nov 5 02:00:00 - 02:59:59	151862	5.1%	42.18	39.5 GB	4.6%	11493.27
Nov 5 03:00:00 - 03:59:59	119913	4.0%	33.31	32.3 GB	3.8%	9406.79
Nov 5 04:00:00 - 04:15:02	29199	1.0%	32.37	8.2 GB	1.0%	9489.64
TOTAL: 24:00:01	2966567	100.0%	34.33	854.4 GB	100.0%	10368.63

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	8665	33	567	10	8055
2	newsfeed.pionier.net.pl	7285	119	4043	0	3123
3	news.icm.edu.pl	9	0	0	0	9
TOTAL: 3		15959	152	4610	10	11187

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	67
it.tlc.cellulari.android	17
de.rec.sf.startrek	13
it.comp.os.win.windows7	11
uk.net.providers.gradwell	5
it.comp.os.win.windows10	4
comp.sys.raspberry-pi	4
it.tlc.cellulari.iphone	4
de.comp.lang.vbclassic	4
comp.mobile.ipad	4
nl.comp.os.linux.techniek	4
comp.mobile.android	4
de.comp.office-pakete.ms-office.outlook	3
comp.sys.mac.vintage	3
alt.sex.telephones	2
uk.rec.cycling.moderated	2
hr.ponuda.hardver.konfiguracije	1
TOTAL: 17	152

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

Groups	Count
pl.sci.matematyka	8
bit.listserv.catholic	1
pl.praca.oferowana	1
TOTAL: 3	10

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	7465
Binary in non-binary group	2933
EMP (phl)	88
Scoring filter (8)	56
Scoring filter (9)	16
Scoring filter (10)	7
Scoring filter (11)	5
Scoring filter (13)	5
Too many newsgroups	4
HTML post	2
Scoring filter (14)	1
TOTAL: 11	10582

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	8540	1557	4909	625	128	27372	18%	24:02:34
2	icm	33233	74	21717	2161	0	0	0%	23:57:28
3	nask	6808	36	4884	0	0	0	0%	24:02:33
4	poznan	11785	20	8360	15	0	0	0%	23:59:33
5	okapi	0	0	0	0	0	1903	0%	24:00:03
TOTAL: 5		60366	1687	39870	2801	128	29275	2%	120:02:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	5.2 MB	3.3 MB	8.5 MB	0.1 KB/s	4.0 KB	24:02:34
2	icm	2.5 MB	502.4 MB	504.9 MB	6.0 KB/s	231.3 KB	23:57:28
3	nask	121.7 KB	0.0 KB	121.7 KB	0.0 KB/s	3.4 KB	24:02:33
4	poznan	112.5 KB	30.9 KB	143.4 KB	0.0 KB/s	4.1 KB	23:59:33
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		7.9 MB	505.8 MB	513.7 MB	1.2 KB/s	117.2 KB	120:02:11

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	Elapsed
1	lze200.lze.lodz.pl	21	88	464.0 KB	11	0	02:20:21
2	web.man.lodz.pl	288	44	43.3 KB	22	0	00:00:22
3	176.221.123.77	7	2	2.2 KB	2	0	00:11:03
4	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 4		319	134	509.5 KB	35	3	02:31:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.lze.lodz.pl	21	88	464.0 KB	11	0	02:20:21
2	*.man.lodz.pl	675	44	43.3 KB	22	3	00:00:26
3	unresolved	8	2	2.2 KB	2	0	00:11:06
TOTAL: 3		704	134	509.5 KB	35	3	02:31:54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
lze200.lze.lodz.pl	0.110	0.466	02:20:21
176.221.123.77	0.082	0.149	00:11:03
web.man.lodz.pl	0.959	5.838	00:00:22
mon.man.lodz.pl	0.931	5.554	00:00:03
199.189.26.21	0.010	0.016	00:00:02
david.man.lodz.pl	0.304	1.770	00:00:01
isvcs01.man.lodz.pl	0.029	0.049	00:00:00
TOTAL: 7	2.425	13.842	02:31:54

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
199.189.26.21	1
TOTAL: 3	385

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	9	1
TOTAL: 1	9	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	132	98.5%
2	lodzman	1	0.7%
3	lodman	1	0.7%
TOTAL: 3		134	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	98
2	pl.comp.os.ms-windows.winnt	12
3	pl.comp.os.linux	12
4	pl.rec.kuchnia	7
5	pl.internet.polip	2
6	lodzman.test	1
7	lodman.info	1
8	pl.comp.os.linux.sieci	1
TOTAL: 8		134

Daily Usenet report

Nov 4 04:15:01 -- Nov 5 04:15:02