Daily Usenet report: Feb 18 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 18 08:05:41 newsfeed nnrpd[14791]: SERVER perl filter not defined
Feb 18 15:19:00 newsfeed overchan[6068]: input line too long, skipping
Feb 19 00:59:15 newsfeed overchan[6068]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1573890	96.2%	183.0 MB	96.0%
innfeed	44660	2.7%	5.2 MB	2.7%
innd	12048	0.7%	2.0 MB	1.0%
nnrpd	4887	0.3%	522.7 KB	0.3%
overchan	3	0.0%	0.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	1635489	100.0%	190.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1556312	98.5%
Negative hits	13627	0.9%
Positive hits	10748	0.7%
Cache misses	27	0.0%
TOTAL: 4	1580714	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.733	0.0%	82	0.000	8.939	74.000
article cleanup	00:00:24.866	0.0%	1568479	0.011	0.016	0.020
article logging	00:01:19.590	0.1%	1568973	0.041	0.051	0.065
article parse	00:29:06.817	2.0%	48780823	0.024	0.036	0.042
article write	00:12:11.324	0.8%	1564015	0.248	0.468	0.690
artlog/artcncl	00:00:00.004	0.0%	81	0.000	0.049	0.333
data move	00:01:10.097	0.1%	57139274	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.094	0.0%	80	0.000	1.175	16.000
hishave/artcncl	00:00:00.008	0.0%	82	0.000	0.098	0.700
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:16:48.696	1.2%	1590115	0.098	0.634	4.023
history sync	00:00:00.025	0.0%	290	0.000	0.086	0.500
history write	00:31:21.650	2.2%	1565699	0.289	1.202	6.069
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
idle	18:26:39.304	76.8%	39559348	0.970	1.678	3.537
nntp read	00:45:39.452	3.2%	47485930	0.047	0.058	0.067
overview write	00:00:09.071	0.0%	1564015	0.003	0.006	0.009
perl filter	02:51:32.150	11.9%	1565699	4.988	6.574	7.757
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:44.511	0.3%	3145624	0.056	0.071	0.089
TOTAL: 24:00:01.450	23:40:08.392	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.161	0.0%	54811	0.000	0.003	0.013
article prepare	00:00:00.005	0.0%	9010	0.000	0.001	0.028
article read	00:00:13.273	0.0%	2244	0.000	5.915	63.588
backlog stats	00:00:00.175	0.0%	162128	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:01.824	0.0%	80810	0.003	0.023	0.045
data write	00:00:08.766	0.0%	72364	0.035	0.121	0.325
idle	23:53:19.521	99.9%	162128	367.576	530.442	896.991
status file	00:00:23.134	0.0%	16858	0.927	1.372	7.475
TOTAL: 23:54:19.008	23:54:06.859	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.202	0.0%	1144	0.108	0.177	0.185
idle	03:28:26.629	99.9%	4198	0.000	2979.187	34133.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.417	0.0%	9099	0.000	0.046	0.579
readart	00:00:00.021	0.0%	59	0.000	0.356	18.000
TOTAL: 03:28:40.364	03:28:27.269	99.9%	-	-	-	-

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	477	1568931	1567938	21	972	99%	157:45:24
2	news.nask.pl	2	12523	973	8071	3479	7%	25:01:44
3	news.icm.edu.pl	42	370	54	257	59	14%	19:14:44
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		523	1581825	1568966	8349	4510	99%	202:01:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	412.3 GB	11.4 MB	11.8 MB	412.3 GB	99%	275.6 KB
2	news.nask.pl	11.0 MB	9.6 MB	21.3 MB	41.9 MB	26%	9.6 KB
3	news.icm.edu.pl	1.4 MB	18.9 KB	3.7 MB	5.2 MB	27%	46.9 KB
4	localhost	1.2 KB	0.0 KB	0.0 KB	1.2 KB	100%	1.2 KB
TOTAL: 4		412.3 GB	21.1 MB	36.9 MB	412.4 GB	99%	274.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 18 04:15:02 - 04:59:59	44435	2.8%	16.47	12.4 GB	3.0%	4830.78
Feb 18 05:00:00 - 05:59:59	41469	2.6%	11.52	11.5 GB	2.8%	3361.41
Feb 18 06:00:00 - 06:59:59	32234	2.1%	8.95	8.3 GB	2.0%	2428.84
Feb 18 07:00:00 - 07:59:59	40322	2.6%	11.20	10.6 GB	2.6%	3075.86
Feb 18 08:00:00 - 08:59:59	40460	2.6%	11.24	11.2 GB	2.7%	3263.08
Feb 18 09:00:00 - 09:59:59	68366	4.4%	18.99	21.6 GB	5.2%	6286.95
Feb 18 10:00:00 - 10:59:59	71694	4.6%	19.91	20.5 GB	5.0%	5971.60
Feb 18 11:00:00 - 11:59:59	73280	4.7%	20.36	21.2 GB	5.2%	6179.90
Feb 18 12:00:00 - 12:59:59	70568	4.5%	19.60	21.4 GB	5.2%	6234.74
Feb 18 13:00:00 - 13:59:59	75727	4.8%	21.04	21.5 GB	5.2%	6271.12
Feb 18 14:00:00 - 14:59:59	141141	9.0%	39.21	23.0 GB	5.6%	6708.40
Feb 18 15:00:00 - 15:59:59	67546	4.3%	18.76	18.7 GB	4.5%	5456.05
Feb 18 16:00:00 - 16:59:59	55925	3.6%	15.53	13.8 GB	3.4%	4033.99
Feb 18 17:00:00 - 17:59:59	49763	3.2%	13.82	14.6 GB	3.6%	4264.72
Feb 18 18:00:00 - 18:59:59	82674	5.3%	22.96	21.5 GB	5.2%	6266.96
Feb 18 19:00:00 - 19:59:59	110156	7.0%	30.60	23.1 GB	5.6%	6720.00
Feb 18 20:00:00 - 20:59:59	80011	5.1%	22.23	22.4 GB	5.4%	6534.99
Feb 18 21:00:00 - 21:59:59	56968	3.6%	15.82	14.5 GB	3.5%	4225.67
Feb 18 22:00:00 - 22:59:59	51640	3.3%	14.34	12.4 GB	3.0%	3617.39
Feb 18 23:00:00 - 23:59:59	51767	3.3%	14.38	13.9 GB	3.4%	4040.35
Feb 19 00:00:00 - 00:59:59	53174	3.4%	14.77	14.4 GB	3.5%	4204.26
Feb 19 01:00:00 - 01:59:59	53858	3.4%	14.96	12.2 GB	3.0%	3548.85
Feb 19 02:00:00 - 02:59:59	59019	3.8%	16.39	16.4 GB	4.0%	4787.02
Feb 19 03:00:00 - 03:59:59	77302	4.9%	21.47	24.2 GB	5.9%	7034.38
Feb 19 04:00:00 - 04:15:02	19358	1.2%	21.46	6.2 GB	1.5%	7201.65
TOTAL: 24:00:00	1568857	100.0%	18.16	411.8 GB	100.0%	4997.56

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	3440	1	1991	2	1446
2	newsfeed.pionier.net.pl	1452	181	784	1	486
3	news.icm.edu.pl	60	0	2	0	58
TOTAL: 3		4952	182	2777	3	1990

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	89
it.comp.os.win.windows10	25
comp.mobile.android	18
it.tlc.cellulari.android	18
it.comp.os.win.windows7	12
nl.comp.os.linux.techniek	5
it.politica.m5s	5
uk.rec.cycling.moderated	4
de.rec.sf.startrek	3
comp.sys.raspberry-pi	2
de.comm.software.mailreader	1
TOTAL: 11	182

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

Groups	Count
bit.listserv.catholic	1
pl.praca.oferowana	1
christnet.christianlife	1
TOTAL: 3	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1366
Binary in non-binary group	92
Scoring filter (9)	18
Scoring filter (10)	10
Scoring filter (8)	4
Scoring filter (11)	3
Scoring filter (14)	2
Too many newsgroups	2
Scoring filter (12)	2
TOTAL: 9	1499

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	25648	1429	15944	7	0	0	5%	23:59:58
2	panorama	42176	297	13785	100	5	40658	0%	23:59:58
3	poznan	1460	17	985	0	0	0	1%	23:38:36
4	nask	11525	8	9614	2	0	0	0%	23:59:58
5	okapi	0	0	0	0	0	1133	0%	23:57:51
TOTAL: 5		80809	1751	40328	109	5	41791	2%	119:36:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	939.2 MB	27.7 KB	939.3 MB	11.1 KB/s	669.8 KB	23:59:58
2	panorama	836.7 KB	361.1 KB	1.2 MB	0.0 KB/s	3.0 KB	23:59:58
3	nask	99.2 KB	3.8 KB	103.0 KB	0.0 KB/s	10.3 KB	23:59:58
4	poznan	49.8 KB	0.0 KB	49.8 KB	0.0 KB/s	2.9 KB	23:38:36
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		940.2 MB	392.6 KB	940.6 MB	2.2 KB/s	517.8 KB	119:36:21

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	58	54.7 KB	27	0	00:00:18
2	az1-ss13.a2hosting.com	2	1	0.7 KB	1	0	00:00:12
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		291	59	55.4 KB	28	1	03:28:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	577	58	54.7 KB	27	1	00:00:22
2	*.a2hosting.com	2	1	0.7 KB	1	0	00:00:12
3	*.consolidated.net	3	0	0.0 KB	0	0	03:28:03
4	unresolved	96	0	0.0 KB	0	0	00:00:01
TOTAL: 4		678	59	55.4 KB	28	1	03:28:39

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
client-66-116-2-88.consolidated.net	0.112	0.272	03:28:03
web.man.lodz.pl	1.588	4.048	00:00:18
az1-ss13.a2hosting.com	0.028	0.028	00:00:12
mon.man.lodz.pl	1.344	3.732	00:00:03
212.51.192.185	0.480	1.172	00:00:01
isvcs01.man.lodz.pl	0.004	0.020	00:00:00
TOTAL: 6	3.556	9.272	03:28:39

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	96
client-66-116-2-88.consolidated.net	3
TOTAL: 3	387

NNRP client timeouts [Top 20]:

System	Conn	Peer
client-66-116-2-88.consolidated.net	3	1
TOTAL: 1	3	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	58	98.3%
2	lodz	1	1.7%
TOTAL: 2		59	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	40
2	pl.comp.os.ms-windows.winnt	18
3	lodz.test	1
TOTAL: 3		59

Daily Usenet report

Feb 18 04:15:02 -- Feb 19 04:15:02