Daily Usenet report: Feb 20 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Feb 20 04:20:59 newsfeed nnrpd[19885]: 212.51.192.185 rejected Expiring process 19831
Feb 20 15:18:48 newsfeed nnrpd[11119]: SERVER perl filter not defined
Feb 20 15:30:04 newsfeed overchan[19552]: input line too long, skipping
Feb 20 20:27:47 newsfeed overchan[19552]: input line too long, skipping
Feb 20 21:49:03 newsfeed overchan[19552]: input line too long, skipping
Feb 20 21:58:17 newsfeed controlchan[19549]: skipping newgroup free.impeach.trump y oppie@guardian-21.frontierlocal.net (would be created): Empty description
Feb 20 22:13:52 newsfeed overchan[19552]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1757301	96.5%	205.9 MB	96.2%
innfeed	45531	2.5%	5.4 MB	2.5%
innd	13843	0.8%	2.3 MB	1.1%
nnrpd	4883	0.3%	520.4 KB	0.2%
overchan	5	0.0%	1.0 KB	0.0%
controlchan	3	0.0%	0.5 KB	0.0%
TOTAL: 6	1821566	100.0%	214.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1739369	98.5%
Negative hits	14495	0.8%
Positive hits	11624	0.7%
Cache misses	43	0.0%
TOTAL: 4	1765531	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.903	0.0%	147	0.000	6.143	63.000
article cleanup	00:00:27.945	0.0%	1752387	0.012	0.016	0.020
article logging	00:01:29.048	0.1%	1752899	0.043	0.051	0.060
article parse	00:35:31.382	2.5%	59087541	0.026	0.036	0.045
article write	00:13:26.552	0.9%	1747468	0.343	0.462	0.601
artlog/artcncl	00:00:00.005	0.0%	147	0.000	0.034	0.500
data move	00:01:21.505	0.1%	68978689	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.114	0.0%	140	0.000	0.814	22.000
hishave/artcncl	00:00:00.029	0.0%	147	0.000	0.197	20.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:25:46.179	1.8%	1775123	0.022	0.871	5.927
history sync	00:00:00.020	0.0%	292	0.000	0.068	1.000
history write	00:23:15.574	1.6%	1748909	0.147	0.798	2.597
hiswrite/artcncl	00:00:00.001	0.0%	7	0.000	0.143	0.500
idle	17:43:52.348	73.9%	44347274	1.062	1.439	3.527
nntp read	00:54:15.132	3.8%	57629139	0.044	0.056	0.071
overview write	00:00:10.324	0.0%	1747468	0.004	0.006	0.008
perl filter	03:13:27.356	13.4%	1748909	5.306	6.637	7.875
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:03.409	0.3%	3511975	0.052	0.069	0.084
TOTAL: 24:00:01.911	23:37:07.826	98.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.142	0.0%	56477	0.000	0.003	0.010
article prepare	00:00:00.002	0.0%	5698	0.000	0.000	0.045
article read	00:00:20.104	0.0%	1406	0.000	14.299	160.182
backlog stats	00:00:00.160	0.0%	155363	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:01.786	0.0%	81303	0.005	0.022	0.040
data write	00:00:04.557	0.0%	64661	0.033	0.070	0.196
idle	23:52:59.211	99.9%	155363	381.235	553.409	970.604
status file	00:00:21.523	0.0%	16468	0.867	1.307	1.867
TOTAL: 23:53:59.295	23:53:47.485	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.090	0.0%	604	0.120	0.149	0.208
idle	02:11:58.422	99.8%	3621	0.000	2186.805	19787.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.552	0.0%	7888	0.000	0.070	5.474
readart	00:00:00.015	0.0%	17	0.000	0.882	15.000
TOTAL: 02:12:13.812	02:11:59.079	99.8%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
oppie@guardian-21.frontierlocal.net	1	0	0	0	1	1
TOTAL	1	0	0	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	735	1751369	1749951	64	1354	99%	203:33:45
2	news.nask.pl	2	12802	1447	7790	3565	11%	24:08:06
3	news.icm.edu.pl	39	367	56	300	11	15%	18:53:12
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		778	1764539	1751455	8154	4930	99%	246:35:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	508.8 GB	13.1 MB	13.3 MB	508.8 GB	99%	304.6 KB
2	news.nask.pl	12.7 MB	10.5 MB	19.8 MB	43.0 MB	29%	8.8 KB
3	news.icm.edu.pl	1.4 MB	41.1 KB	117.7 KB	1.6 MB	90%	23.9 KB
4	localhost	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
TOTAL: 4		508.8 GB	23.6 MB	33.3 MB	508.8 GB	99%	303.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 20 04:15:02 - 04:59:59	44016	2.5%	16.31	13.0 GB	2.6%	5071.23
Feb 20 05:00:00 - 05:59:59	53689	3.1%	14.91	16.6 GB	3.3%	4830.10
Feb 20 06:00:00 - 06:59:59	59527	3.4%	16.54	18.3 GB	3.6%	5316.05
Feb 20 07:00:00 - 07:59:59	66618	3.8%	18.50	21.2 GB	4.2%	6171.40
Feb 20 08:00:00 - 08:59:59	73986	4.2%	20.55	22.9 GB	4.5%	6682.31
Feb 20 09:00:00 - 09:59:59	71748	4.1%	19.93	22.9 GB	4.5%	6679.71
Feb 20 10:00:00 - 10:59:59	74408	4.2%	20.67	23.8 GB	4.7%	6920.76
Feb 20 11:00:00 - 11:59:59	76310	4.4%	21.20	23.2 GB	4.6%	6746.01
Feb 20 12:00:00 - 12:59:59	80505	4.6%	22.36	23.9 GB	4.7%	6974.43
Feb 20 13:00:00 - 13:59:59	89749	5.1%	24.93	26.0 GB	5.1%	7563.24
Feb 20 14:00:00 - 14:59:59	76238	4.4%	21.18	22.4 GB	4.4%	6533.49
Feb 20 15:00:00 - 15:59:59	72458	4.1%	20.13	21.4 GB	4.2%	6232.83
Feb 20 16:00:00 - 16:59:59	82798	4.7%	23.00	22.6 GB	4.4%	6584.15
Feb 20 17:00:00 - 17:59:59	55006	3.1%	15.28	15.4 GB	3.0%	4477.15
Feb 20 18:00:00 - 18:59:59	74310	4.2%	20.64	21.8 GB	4.3%	6349.05
Feb 20 19:00:00 - 19:59:59	84602	4.8%	23.50	23.5 GB	4.6%	6838.10
Feb 20 20:00:00 - 20:59:59	88208	5.0%	24.50	24.4 GB	4.8%	7097.37
Feb 20 21:00:00 - 21:59:59	73570	4.2%	20.44	20.0 GB	3.9%	5834.63
Feb 20 22:00:00 - 22:59:59	66299	3.8%	18.42	17.5 GB	3.4%	5089.95
Feb 20 23:00:00 - 23:59:59	69694	4.0%	19.36	21.2 GB	4.2%	6171.32
Feb 21 00:00:00 - 00:59:59	60233	3.4%	16.73	15.8 GB	3.1%	4601.86
Feb 21 01:00:00 - 01:59:59	91388	5.2%	25.39	25.1 GB	4.9%	7311.86
Feb 21 02:00:00 - 02:59:59	60601	3.5%	16.83	17.0 GB	3.3%	4940.76
Feb 21 03:00:00 - 03:59:59	88221	5.0%	24.51	23.4 GB	4.6%	6820.57
Feb 21 04:00:00 - 04:15:02	17520	1.0%	19.42	4.9 GB	1.0%	5746.86
TOTAL: 24:00:00	1751702	100.0%	20.27	508.1 GB	100.0%	6166.98

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	3597	0	2226	2	1369
2	newsfeed.pionier.net.pl	1844	92	1250	1	501
3	news.icm.edu.pl	13	0	4	0	9
TOTAL: 3		5454	92	3480	3	1879

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	39
it.tlc.cellulari.android	17
it.comp.os.win.windows7	14
it.comp.os.win.windows10	14
comp.sys.raspberry-pi	3
comp.mobile.android	3
de.comm.software.mailreader	1
nl.comp.os.linux.techniek	1
TOTAL: 8	92

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1219
Binary in non-binary group	113
Scoring filter (9)	19
Scoring filter (8)	13
Scoring filter (10)	3
TOTAL: 5	1367

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	490
	news.nask.pl	20
	news.icm.edu.pl	2
	TOTAL: 3	512
TOTAL: 1		512

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	44161	522	16049	149	11	40027	1%	23:59:58
2	icm	25594	81	16557	111	0	0	0%	23:59:54
3	poznan	2318	26	1476	4	0	0	1%	23:48:54
4	nask	12185	7	10052	1	0	0	0%	23:59:58
5	okapi	0	0	0	0	0	1031	0%	23:57:51
TOTAL: 5		84258	636	44134	265	11	41058	0%	119:46:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	1.3 MB	501.0 KB	1.8 MB	0.0 KB/s	2.8 KB	23:59:58
2	icm	509.1 KB	38.8 MB	39.3 MB	0.5 KB/s	209.6 KB	23:59:54
3	poznan	152.6 KB	24.5 KB	177.1 KB	0.0 KB/s	5.9 KB	23:48:54
4	nask	30.9 KB	48.7 KB	79.6 KB	0.0 KB/s	9.9 KB	23:59:58
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		2.0 MB	39.4 MB	41.4 MB	0.1 KB/s	47.0 KB	119:46:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	16	18.5 KB	8	0	00:00:20
2	az1-ss13.a2hosting.com	2	1	2.1 KB	1	0	00:00:12
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		291	17	20.7 KB	9	1	02:12:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	577	16	18.5 KB	8	1	00:00:24
2	*.a2hosting.com	2	1	2.1 KB	1	0	00:00:12
3	*.consolidated.net	4	0	0.0 KB	0	0	02:11:32
4	*.security.ipip.net	1	0	0.0 KB	0	0	00:00:00
5	unresolved	99	0	0.0 KB	0	0	00:00:02
TOTAL: 5		683	17	20.7 KB	9	1	02:12:12

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
client-66-116-2-88.consolidated.net	0.060	0.192	02:11:32
web.man.lodz.pl	1.936	4.840	00:00:20
az1-ss13.a2hosting.com	0.024	0.024	00:00:12
mon.man.lodz.pl	1.348	3.880	00:00:03
212.51.192.185	0.416	1.320	00:00:01
scan-141.security.ipip.net	0.000	0.020	00:00:00
122.228.19.80	0.012	0.020	00:00:00
106.75.79.172	0.008	0.012	00:00:00
isvcs01.man.lodz.pl	0.016	0.024	00:00:00
TOTAL: 9	3.820	10.332	02:12:12

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	4
122.228.19.80	2
scan-141.security.ipip.net	1
106.75.79.172	1
TOTAL: 6	392

NNRP unrecognized commands (by host):

System	Conn
122.228.19.80	10
scan-141.security.ipip.net	4
TOTAL: 2	14

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	3
Host: 212.191.2.21:119	3
Connection: keep-alive	2
Accept: /	2
User-Agent: Mozilla/5.0 (Macintosh; Inte...	2
User-Agent: HTTP Banner Detection (https...	1
Connection: close	1
TOTAL: 7	14

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	16	94.1%
2	lodman	1	5.9%
TOTAL: 2		17	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	10
2	pl.comp.pecet	6
3	lodman.test	1
TOTAL: 3		17

Daily Usenet report

Feb 20 04:15:02 -- Feb 21 04:15:02