Daily Usenet report: Mar 10 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Mar 10 09:54:23 newsfeed nnrpd[16917]: SERVER perl filter not defined
Mar 10 13:30:04 newsfeed controlchan[2612]: Multiple control headers in article <tjrQf-3VY-47@gated-at.bofh.it>
Mar 10 15:29:07 newsfeed nnrpd[28381]: SERVER perl filter not defined
Mar 10 18:54:52 newsfeed nnrpd[3129]: SERVER perl filter not defined
Mar 11 00:09:11 newsfeed nnrpd[13881]: SERVER perl filter not defined
Mar 11 01:51:24 newsfeed nnrpd[17491]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2967199	98.4%	343.9 MB	98.1%
innd	39779	1.3%	5.5 MB	1.6%
innfeed	4829	0.2%	667.7 KB	0.2%
nnrpd	4762	0.2%	478.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	3016570	100.0%	350.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2956910	96.7%
Negative hits	86128	2.8%
Positive hits	15672	0.5%
Cache misses	110	0.0%
TOTAL: 4	3058820	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.115	0.0%	237	0.000	4.705	328.000
article cleanup	00:00:40.653	0.0%	2965162	0.006	0.014	0.027
article logging	00:01:34.814	0.1%	2965843	0.015	0.032	0.855
article parse	01:16:45.926	5.3%	207017832	0.015	0.022	0.061
article write	00:26:17.146	1.8%	2942368	0.341	0.536	2.050
artlog/artcncl	00:00:00.007	0.0%	175	0.000	0.040	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:50.002	0.2%	225465170	0.000	0.001	0.007
hisgrep/artcncl	00:00:00.139	0.0%	219	0.000	0.635	16.000
hishave/artcncl	00:00:00.346	0.0%	237	0.000	1.460	316.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:35:56.603	2.5%	3060363	0.102	0.705	7.803
history sync	00:00:00.021	0.0%	295	0.000	0.071	1.000
history write	00:51:12.389	3.6%	2958225	0.217	1.039	11.115
hiswrite/artcncl	00:00:00.064	0.0%	18	0.000	3.556	15.000
idle	12:47:22.727	53.3%	142899675	0.191	0.322	0.747
nntp read	01:14:25.468	5.2%	204697010	0.016	0.022	0.036
overview write	00:00:16.290	0.0%	2942368	0.001	0.006	0.014
perl filter	05:57:22.718	24.8%	2958225	5.507	7.249	9.534
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:52.041	0.3%	5916793	0.035	0.049	0.086
TOTAL: 23:59:31.226	23:19:38.469	97.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.164	0.0%	52798	0.000	0.003	0.167
article prepare	00:00:00.011	0.0%	32650	0.000	0.000	0.125
article read	00:00:36.327	0.0%	8171	0.000	4.446	1806.000
backlog stats	00:00:00.193	0.0%	206191	0.000	0.001	0.031
callbacks	00:00:00.000	0.0%	7	0.000	0.000	0.000
data read	00:00:01.396	0.0%	107228	0.000	0.013	0.188
data write	00:00:08.315	0.0%	96639	0.000	0.086	0.312
idle	23:58:42.076	99.9%	206191	24.145	418.651	4068.688
status file	00:00:00.662	0.0%	851	0.000	0.778	6.333
TOTAL: 23:59:34.586	23:59:29.144	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:13.752	52.0%	3029	0.000	4.540	177.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.162	0.6%	6637	0.000	0.024	0.500
readart	00:00:00.001	0.0%	14	0.000	0.071	0.500
TOTAL: 00:00:26.440	00:00:13.915	52.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	1500	2946353	2932398	4597	9358	99%	389:03:37
2	news.nask.pl	2	28650	11362	3878	13410	39%	24:00:26
3	news.icm.edu.pl	52	224	5	215	4	2%	17:13:21
4	localhost	6	5	5	0	0	100%	00:00:01
TOTAL: 4		1560	2975232	2943770	8690	22772	98%	430:17:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	889.3 GB	187.9 MB	593.3 MB	890.0 GB	99%	317.2 KB
2	news.nask.pl	208.7 MB	2.0 MB	205.4 MB	416.2 MB	50%	17.2 KB
3	news.icm.edu.pl	109.1 KB	0.0 KB	125.6 KB	234.7 KB	46%	26.1 KB
4	localhost	7.9 KB	0.0 KB	0.0 KB	7.9 KB	100%	1.6 KB
TOTAL: 4		889.5 GB	190.0 MB	798.8 MB	890.4 GB	99%	314.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 10 04:15:02 - 04:59:59	78150	2.7%	28.97	27.2 GB	3.1%	10586.13
Mar 10 05:00:00 - 05:59:59	98449	3.3%	27.35	36.1 GB	4.1%	10505.11
Mar 10 06:00:00 - 06:59:59	105028	3.6%	29.17	38.3 GB	4.3%	11158.05
Mar 10 07:00:00 - 07:59:59	121402	4.1%	33.72	37.8 GB	4.3%	10997.82
Mar 10 08:00:00 - 08:59:59	112687	3.8%	31.30	37.3 GB	4.2%	10871.93
Mar 10 09:00:00 - 09:59:59	120358	4.1%	33.43	37.3 GB	4.2%	10865.80
Mar 10 10:00:00 - 10:59:59	123007	4.2%	34.17	36.7 GB	4.1%	10699.40
Mar 10 11:00:00 - 11:59:59	118498	4.0%	32.92	36.4 GB	4.1%	10609.25
Mar 10 12:00:00 - 12:59:59	124896	4.2%	34.69	36.9 GB	4.2%	10748.90
Mar 10 13:00:00 - 13:59:59	122374	4.2%	33.99	36.8 GB	4.2%	10725.95
Mar 10 14:00:00 - 14:59:59	118086	4.0%	32.80	36.4 GB	4.1%	10614.14
Mar 10 15:00:00 - 15:59:59	116977	4.0%	32.49	36.7 GB	4.1%	10686.35
Mar 10 16:00:00 - 16:59:59	134226	4.6%	37.28	38.2 GB	4.3%	11132.63
Mar 10 17:00:00 - 17:59:59	129566	4.4%	35.99	37.9 GB	4.3%	11048.66
Mar 10 18:00:00 - 18:59:59	125241	4.3%	34.79	37.1 GB	4.2%	10817.48
Mar 10 19:00:00 - 19:59:59	125432	4.3%	34.84	37.2 GB	4.2%	10831.25
Mar 10 20:00:00 - 20:59:59	134467	4.6%	37.35	38.6 GB	4.4%	11240.75
Mar 10 21:00:00 - 21:59:59	143773	4.9%	39.94	38.8 GB	4.4%	11299.34
Mar 10 22:00:00 - 22:59:59	142153	4.8%	39.49	39.5 GB	4.5%	11492.81
Mar 10 23:00:00 - 23:59:59	135687	4.6%	37.69	38.5 GB	4.3%	11212.67
Mar 11 00:00:00 - 00:59:59	109279	3.7%	30.36	31.4 GB	3.5%	9132.24
Mar 11 01:00:00 - 01:59:59	137564	4.7%	38.21	39.1 GB	4.4%	11383.11
Mar 11 02:00:00 - 02:59:59	116140	3.9%	32.26	33.3 GB	3.8%	9693.04
Mar 11 03:00:00 - 03:59:59	119073	4.0%	33.08	34.0 GB	3.8%	9906.60
Mar 11 04:00:00 - 04:15:02	31061	1.1%	34.44	8.8 GB	1.0%	10268.59
TOTAL: 24:00:00	2943574	100.0%	34.07	886.4 GB	100.0%	10757.49

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	13753	24	397	6	13326
2	newsfeed.pionier.net.pl	9692	212	6502	1	2977
3	news.icm.edu.pl	5	0	0	0	5
TOTAL: 3		23450	236	6899	7	16308

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.tlc.cellulari.android	124
uk.railway	75
comp.mobile.android	22
comp.sys.raspberry-pi	4
uk.rec.cycling.moderated	3
it.comp.os.win.windows10	3
hr.rec.glazba.hifi	2
de.comp.lang.vbclassic	1
nl.actueel	1
hr.comp.softver.slobodni	1
TOTAL: 10	236

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

Groups	Count
pl.praca.oferowana	6
bit.listserv.catholic	1
TOTAL: 2	7

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	12001
Binary in non-binary group	3380
Scoring filter (8)	97
Poison newsgroup	74
Scoring filter (9)	28
Scoring filter (10)	21
Scoring filter (14)	5
HTML post	5
Scoring filter (13)	5
Scoring filter (17)	3
Scoring filter (12)	3
Too many newsgroups	2
Attached HTML file	1
Angle-bracket bot	1
Scoring filter (11)	1
TOTAL: 15	15627

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	20962	1308	17808	508	23	32998	6%	23:57:46
2	icm	32307	662	24582	1325	0	0	2%	23:59:59
3	poznan	16664	234	10486	10	0	0	1%	24:02:56
4	nask	11634	11	5113	4084	0	0	0%	24:03:06
5	okapi	0	0	0	0	0	2963	0%	24:00:01
TOTAL: 5		81567	2215	57989	5927	23	35961	2%	120:03:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	102.2 MB	375.1 MB	477.4 MB	5.7 KB/s	246.0 KB	23:59:59
2	panorama	5.2 MB	2.9 MB	8.1 MB	0.1 KB/s	4.6 KB	23:57:46
3	poznan	983.7 KB	185.8 KB	1.1 MB	0.0 KB/s	4.8 KB	24:02:56
4	nask	772.0 KB	1.5 GB	1.5 GB	18.3 KB/s	386.3 KB	24:03:06
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		109.2 MB	1.9 GB	2.0 GB	4.8 KB/s	255.5 KB	120:03:48

Backlog files shrunk by innfeed:

Server	Size
panorama	2.4 MB
TOTAL: 1	2.4 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	14	10.4 KB	7	0	00:00:19
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:01
TOTAL: 2		293	14	10.4 KB	7	5	00:00:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	676	14	10.4 KB	7	5	00:00:25
2	unresolved	1	0	0.0 KB	0	0	00:00:00
TOTAL: 2		677	14	10.4 KB	7	5	00:00:26

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	0.932	4.047	00:00:19
mon.man.lodz.pl	0.990	3.548	00:00:03
isvcs01.man.lodz.pl	0.027	0.060	00:00:01
david.man.lodz.pl	0.317	1.152	00:00:01
122.224.153.122	0.000	0.017	00:00:00
TOTAL: 5	2.266	8.824	00:00:26

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	95
122.224.153.122	1
TOTAL: 3	384

NNRP unrecognized commands (by host):

System	Conn
122.224.153.122	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.0	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
122.224.153.122	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	14	100.0%
TOTAL: 1		14	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	12
2	pl.comp.os.ms-windows.winnt	2
TOTAL: 2		14

Daily Usenet report

Mar 10 04:15:02 -- Mar 11 04:15:02