Daily Usenet report: Mar 12 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Mar 12 15:20:29 newsfeed overchan[6099]: input line too long, skipping
Mar 12 16:52:51 newsfeed nnrpd[31854]: SERVER perl filter not defined
Mar 12 17:09:51 newsfeed nnrpd[32466]: SERVER perl filter not defined
Mar 12 18:11:54 newsfeed nnrpd[2107]: SERVER perl filter not defined
Mar 12 18:36:46 newsfeed overchan[6099]: input line too long, skipping
Mar 13 00:09:14 newsfeed nnrpd[13990]: SERVER perl filter not defined
Mar 13 02:07:24 newsfeed nnrpd[17955]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2355615	97.8%	272.0 MB	97.5%
innfeed	30445	1.3%	3.6 MB	1.3%
innd	16975	0.7%	2.8 MB	1.0%
nnrpd	4891	0.2%	521.2 KB	0.2%
overchan	2	0.0%	0.4 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	2407929	100.0%	278.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2341450	98.8%
Negative hits	17405	0.7%
Positive hits	10361	0.4%
Cache misses	31	0.0%
TOTAL: 4	2369247	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.733	0.0%	95	0.000	7.716	62.000
article cleanup	00:00:29.902	0.0%	2355367	0.009	0.013	0.017
article logging	00:01:36.038	0.1%	2355858	0.030	0.041	0.060
article parse	00:34:11.329	2.4%	72072470	0.020	0.028	0.034
article write	00:13:58.892	1.0%	2351293	0.240	0.357	0.553
artlog/artcncl	00:00:00.005	0.0%	93	0.000	0.054	1.000
data move	00:01:22.583	0.1%	84480405	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.150	0.0%	89	0.000	1.685	14.000
hishave/artcncl	00:00:00.010	0.0%	95	0.000	0.105	1.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:21:06.003	1.5%	2380527	0.018	0.532	5.263
history sync	00:00:00.016	0.0%	292	0.000	0.055	0.500
history write	00:47:59.515	3.3%	2352139	0.116	1.224	6.874
hiswrite/artcncl	00:00:00.003	0.0%	6	0.000	0.500	2.000
idle	17:14:44.987	71.9%	53891858	0.757	1.152	2.746
nntp read	00:51:35.707	3.6%	70044943	0.031	0.044	0.054
overview write	00:00:11.632	0.0%	2351293	0.003	0.005	0.008
perl filter	03:26:55.907	14.4%	2352139	3.933	5.279	6.593
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:24.659	0.3%	4718741	0.041	0.056	0.072
TOTAL: 24:00:02.168	23:38:38.071	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.124	0.0%	54047	0.000	0.002	0.013
article prepare	00:00:00.001	0.0%	6540	0.000	0.000	0.015
article read	00:00:16.306	0.0%	1638	0.000	9.955	217.500
backlog stats	00:00:00.123	0.0%	142933	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:01.398	0.0%	75706	0.003	0.018	0.051
data write	00:00:03.291	0.0%	59639	0.007	0.055	0.150
idle	23:53:58.145	99.9%	142933	50.775	601.947	1347.226
status file	00:00:10.486	0.0%	10769	0.000	0.974	5.274
TOTAL: 23:54:42.515	23:54:29.874	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:26.121	68.0%	3049	0.000	8.567	1293.800
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.252	0.7%	6716	0.000	0.038	2.053
readart	00:00:00.022	0.1%	23	0.000	0.957	19.000
TOTAL: 00:00:38.391	00:00:26.395	68.8%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	192

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	934	2350409	2349353	6	1050	99%	245:58:24
2	news.nask.pl	2	10880	1049	6849	2982	9%	24:52:50
3	news.icm.edu.pl	39	291	25	222	44	8%	18:16:38
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		981	2361585	2350432	7077	4076	99%	289:07:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	585.0 GB	13.8 MB	14.2 MB	585.1 GB	99%	261.0 KB
2	news.nask.pl	12.9 MB	10.4 MB	23.9 MB	47.2 MB	27%	12.0 KB
3	news.icm.edu.pl	855.5 KB	17.3 KB	2.6 MB	3.5 MB	24%	51.5 KB
4	localhost	6.9 KB	0.0 KB	0.0 KB	6.9 KB	100%	1.4 KB
TOTAL: 4		585.0 GB	24.2 MB	40.7 MB	585.1 GB	99%	260.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 12 04:15:02 - 04:59:59	86454	3.7%	32.04	19.2 GB	3.3%	7475.56
Mar 12 05:00:00 - 05:59:59	95000	4.0%	26.39	21.4 GB	3.7%	6239.64
Mar 12 06:00:00 - 06:59:59	68303	2.9%	18.97	17.0 GB	2.9%	4947.86
Mar 12 07:00:00 - 07:59:59	110219	4.7%	30.62	24.3 GB	4.2%	7064.48
Mar 12 08:00:00 - 08:59:59	98271	4.2%	27.30	26.8 GB	4.6%	7812.10
Mar 12 09:00:00 - 09:59:59	111153	4.7%	30.88	24.3 GB	4.2%	7082.57
Mar 12 10:00:00 - 10:59:59	98717	4.2%	27.42	22.8 GB	3.9%	6642.13
Mar 12 11:00:00 - 11:59:59	77948	3.3%	21.65	22.5 GB	3.9%	6553.36
Mar 12 12:00:00 - 12:59:59	97460	4.1%	27.07	27.7 GB	4.7%	8074.49
Mar 12 13:00:00 - 13:59:59	96598	4.1%	26.83	26.5 GB	4.5%	7723.20
Mar 12 14:00:00 - 14:59:59	111131	4.7%	30.87	27.6 GB	4.7%	8042.94
Mar 12 15:00:00 - 15:59:59	107920	4.6%	29.98	28.9 GB	5.0%	8425.45
Mar 12 16:00:00 - 16:59:59	98560	4.2%	27.38	28.2 GB	4.8%	8201.06
Mar 12 17:00:00 - 17:59:59	96139	4.1%	26.71	28.4 GB	4.9%	8284.53
Mar 12 18:00:00 - 18:59:59	75309	3.2%	20.92	23.1 GB	4.0%	6738.33
Mar 12 19:00:00 - 19:59:59	88493	3.8%	24.58	22.8 GB	3.9%	6655.05
Mar 12 20:00:00 - 20:59:59	124999	5.3%	34.72	27.4 GB	4.7%	7967.51
Mar 12 21:00:00 - 21:59:59	95470	4.1%	26.52	22.8 GB	3.9%	6632.56
Mar 12 22:00:00 - 22:59:59	80533	3.4%	22.37	23.0 GB	3.9%	6696.90
Mar 12 23:00:00 - 23:59:59	121757	5.2%	33.82	26.0 GB	4.4%	7563.94
Mar 13 00:00:00 - 00:59:59	68865	2.9%	19.13	14.1 GB	2.4%	4108.87
Mar 13 01:00:00 - 01:59:59	99254	4.2%	27.57	25.8 GB	4.4%	7505.28
Mar 13 02:00:00 - 02:59:59	110631	4.7%	30.73	24.7 GB	4.2%	7182.40
Mar 13 03:00:00 - 03:59:59	109527	4.7%	30.42	22.5 GB	3.9%	6558.83
Mar 13 04:00:00 - 04:15:03	22246	0.9%	24.64	6.5 GB	1.1%	7561.54
TOTAL: 24:00:01	2350957	100.0%	27.21	584.3 GB	100.0%	7091.70

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	2985	0	2301	1	683
2	newsfeed.pionier.net.pl	1534	123	927	0	484
3	news.icm.edu.pl	46	0	2	0	44
TOTAL: 3		4565	123	3230	1	1211

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	46
it.comp.os.win.windows10	27
it.comp.os.win.windows7	16
de.comp.office-pakete.ms-office.outlook	12
comp.mobile.android	10
it.tlc.cellulari.android	9
it.comp.os.linux.ubuntu	1
de.rec.sf.startrek	1
nl.comp.os.linux.techniek	1
TOTAL: 9	123

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)	569
Binary in non-binary group	82
EMP (phl)	31
Scoring filter (8)	15
Scoring filter (10)	13
Scoring filter (9)	4
Scoring filter (11)	4
Scoring filter (12)	2
TOTAL: 8	720

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	480
	news.nask.pl	9
	news.icm.edu.pl	2
	TOTAL: 3	491
TOTAL: 1		491

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	40553	623	21481	627	6	31310	1%	23:54:25
2	icm	24483	124	15648	7	0	0	0%	23:53:42
3	poznan	1575	10	1061	1	0	0	0%	23:42:40
4	nask	10612	4	9164	3	0	0	0%	23:50:00
5	okapi	0	0	0	0	0	969	0%	23:50:00
TOTAL: 5		77223	761	47354	638	6	32279	0%	119:10:47

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	2.2 MB	2.6 MB	4.8 MB	0.1 KB/s	3.9 KB	23:54:25
2	icm	892.6 KB	45.1 KB	937.7 KB	0.0 KB/s	7.2 KB	23:53:42
3	poznan	30.6 KB	12.5 KB	43.1 KB	0.0 KB/s	3.9 KB	23:42:40
4	nask	9.0 KB	4.7 KB	13.8 KB	0.0 KB/s	2.0 KB	23:50:00
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:00
TOTAL: 5		3.1 MB	2.6 MB	5.7 MB	0.0 KB/s	4.2 KB	119:10:47

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	22	19.2 KB	11	0	00:00:17
2	az1-ss13.a2hosting.com	2	1	0.6 KB	1	0	00:00:13
3	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 3		295	23	19.8 KB	12	5	00:00:37

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	581	22	19.2 KB	11	5	00:00:21
2	*.a2hosting.com	2	1	0.6 KB	1	0	00:00:13
3	*.208-100-26.static.steadfastdns.net	2	0	0.0 KB	0	0	00:00:01
4	*.security.ipip.net	1	0	0.0 KB	0	0	00:00:00
5	unresolved	96	0	0.0 KB	0	0	00:00:01
TOTAL: 5		682	23	19.8 KB	12	5	00:00:37

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.252	2.960	00:00:17
az1-ss13.a2hosting.com	0.032	0.036	00:00:13
mon.man.lodz.pl	1.108	2.716	00:00:03
ip232.208-100-26.static.steadfastdns.net	0.000	0.016	00:00:01
212.51.192.185	0.400	0.840	00:00:01
scan-141.security.ipip.net	0.000	0.008	00:00:00
isvcs01.man.lodz.pl	0.048	0.072	00:00:00
TOTAL: 7	2.840	6.648	00:00:37

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	96
ip232.208-100-26.static.steadfastdns.net	2
scan-141.security.ipip.net	1
TOTAL: 4	387

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
User-Agent: HTTP Banner Detection (https...	1
GET / HTTP/1.1	1
Connection: close	1
Host: 212.191.2.21:119	1
TOTAL: 4	4

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	22	95.7%
2	lodman	1	4.3%
TOTAL: 2		23	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	12
2	pl.comp.os.ms-windows.winnt	10
3	lodman.info	1
TOTAL: 3		23

Daily Usenet report

Mar 12 04:15:02 -- Mar 13 04:15:03