Daily Usenet report: Apr 25 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Apr 25 08:14:11 newsfeed nnrpd[311010]: SERVER perl filter not defined
Apr 25 10:51:06 newsfeed overchan[299898]: input line too long, skipping
Apr 25 12:04:52 newsfeed overchan[319513]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	822458	95.4%	90.6 MB	94.9%
innfeed	25989	3.0%	3.1 MB	3.2%
nnrpd	7665	0.9%	854.4 KB	0.9%
innd	5999	0.7%	949.6 KB	1.0%
controlchan	49	0.0%	6.7 KB	0.0%
overchan	21	0.0%	4.2 KB	0.0%
TOTAL: 6	862181	100.0%	95.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	817803	99.0%
Negative hits	7940	1.0%
Positive hits	226	0.0%
Cache misses	22	0.0%
TOTAL: 4	825991	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.400	0.0%	67	0.000	5.970	22.000
article cleanup	00:00:03.542	0.0%	821797	0.002	0.004	0.008
article logging	00:00:12.124	0.0%	822111	0.011	0.015	0.020
article parse	00:05:14.789	0.4%	158120611	0.002	0.002	0.003
article write	00:03:41.856	0.3%	821554	0.131	0.270	0.487
artlog/artcncl	00:00:00.002	0.0%	67	0.000	0.030	1.000
data move	00:00:43.392	0.1%	163937871	0.000	0.000	0.000
hisgrep/artcncl	00:00:00.075	0.0%	66	0.000	1.136	11.000
hishave/artcncl	00:00:00.011	0.0%	67	0.000	0.164	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:07:57.860	0.6%	830167	0.095	0.576	10.356
history sync	00:00:00.007	0.0%	291	0.000	0.024	0.500
history write	00:24:13.325	1.7%	821768	0.167	1.769	21.444
hiswrite/artcncl	00:00:00.001	0.0%	1	1.000	1.000	1.000
idle	22:28:58.321	93.7%	156775478	0.395	0.516	0.796
nntp read	00:16:08.749	1.1%	157550252	0.005	0.006	0.007
overview write	00:00:01.713	0.0%	821554	0.001	0.002	0.006
perl filter	00:24:54.586	1.7%	821768	1.368	1.819	2.286
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:13.452	0.0%	1653079	0.005	0.008	0.013
TOTAL: 24:00:02.373	23:52:24.205	99.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	29117	0.000	0.001	0.010
article prepare	00:00:00.000	0.0%	3080	0.000	0.000	0.000
article read	00:00:10.471	0.0%	793	0.000	13.204	106.333
backlog stats	00:00:00.032	0.0%	74335	0.000	0.000	0.004
callbacks	00:00:00.000	0.0%	33	0.000	0.000	0.000
data read	00:00:00.258	0.0%	35868	0.000	0.007	0.086
data write	00:00:00.428	0.0%	26346	0.000	0.016	0.065
idle	23:26:28.097	100.0%	74335	647.820	1135.240	2901.713
status file	00:00:04.378	0.0%	8268	0.125	0.530	4.632
TOTAL: 23:26:45.404	23:26:43.696	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:20.434	49.1%	4204	0.000	4.861	7063.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.105	0.3%	10269	0.000	0.010	0.500
readart	00:00:00.031	0.1%	17	0.000	1.824	3.667
TOTAL: 00:00:41.577	00:00:20.570	49.5%	-	-	-	-

Control commands to INND:

Command	Number
flush	27
flushlogs	2
go	2
logmode	2
lowmark	1
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
rmgroup	18
TOTAL: 12	211

Newsgroups removed:

Group
bln.comp.misc
bln.comp.pc
bln.freizeit.essen
bln.humor
bln.kultur
bln.kultur.tuerkisch
bln.lv.tub.cs.infet
bln.lv.tub.cs.informatik1
bln.lv.tub.cs.informatik2
bln.lv.tub.cs.informatik3
bln.lv.tub.cs.informatik4
bln.markt.arbeit
bln.medien
bln.net.news
bln.net.statistik
bln.politik.rassismus
bln.sci.mathematik
bln.termine
TOTAL: 18

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
news@fu-berlin.de	0	18	1	0	19	19
TOTAL	0	18	1	0	19	19

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	205	821717	821523	0	194	99%	78:41:22
2	news.icm.edu.pl	44	441	236	155	50	53%	17:36:38
3	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 3		251	822159	821760	155	244	99%	96:18:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	307.1 GB	2.7 MB	3.4 MB	307.2 GB	99%	392.0 KB
2	news.icm.edu.pl	7.3 MB	8.6 KB	842.4 KB	8.2 MB	89%	29.2 KB
3	localhost	1.6 KB	0.0 KB	0.0 KB	1.6 KB	100%	1.6 KB
TOTAL: 3		307.2 GB	2.7 MB	4.2 MB	307.2 GB	99%	391.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 25 04:15:02 - 04:59:59	19084	2.3%	7.07	8.0 GB	2.6%	3123.05
Apr 25 05:00:00 - 05:59:59	30582	3.7%	8.49	11.2 GB	3.7%	3271.87
Apr 25 06:00:00 - 06:59:59	28561	3.5%	7.93	12.5 GB	4.1%	3644.66
Apr 25 07:00:00 - 07:59:59	31003	3.8%	8.61	13.8 GB	4.5%	4029.87
Apr 25 08:00:00 - 08:59:59	32020	3.9%	8.89	13.5 GB	4.4%	3920.00
Apr 25 09:00:00 - 09:59:59	33217	4.0%	9.23	12.4 GB	4.0%	3606.22
Apr 25 10:00:00 - 10:59:59	31835	3.9%	8.84	14.2 GB	4.6%	4142.68
Apr 25 11:00:00 - 11:59:59	31975	3.9%	8.88	13.6 GB	4.4%	3948.00
Apr 25 12:00:00 - 12:59:59	32446	3.9%	9.01	14.5 GB	4.7%	4214.51
Apr 25 13:00:00 - 13:59:59	34968	4.3%	9.71	14.4 GB	4.7%	4188.29
Apr 25 14:00:00 - 14:59:59	31836	3.9%	8.84	13.1 GB	4.3%	3828.81
Apr 25 15:00:00 - 15:59:59	28616	3.5%	7.95	11.7 GB	3.8%	3404.96
Apr 25 16:00:00 - 16:59:59	26975	3.3%	7.49	11.8 GB	3.8%	3429.03
Apr 25 17:00:00 - 17:59:59	39502	4.8%	10.97	12.7 GB	4.1%	3702.23
Apr 25 18:00:00 - 18:59:59	51918	6.3%	14.42	14.7 GB	4.8%	4288.73
Apr 25 19:00:00 - 19:59:59	41282	5.0%	11.47	13.0 GB	4.2%	3793.40
Apr 25 20:00:00 - 20:59:59	52049	6.3%	14.46	13.0 GB	4.2%	3799.00
Apr 25 21:00:00 - 21:59:59	32878	4.0%	9.13	11.8 GB	3.8%	3424.40
Apr 25 22:00:00 - 22:59:59	31604	3.8%	8.78	11.8 GB	3.8%	3426.98
Apr 25 23:00:00 - 23:59:59	31967	3.9%	8.88	11.5 GB	3.7%	3351.63
Apr 26 00:00:00 - 00:59:59	33134	4.0%	9.20	12.0 GB	3.9%	3501.82
Apr 26 01:00:00 - 01:59:59	42741	5.2%	11.87	13.1 GB	4.3%	3824.82
Apr 26 02:00:00 - 02:59:59	30071	3.7%	8.35	12.0 GB	3.9%	3483.25
Apr 26 03:00:00 - 03:59:59	33480	4.1%	9.30	13.9 GB	4.5%	4040.83
Apr 26 04:00:00 - 04:15:02	8089	1.0%	8.97	3.3 GB	1.1%	3829.79
TOTAL: 24:00:00	821833	100.0%	9.51	307.5 GB	100.0%	3731.92

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	508	147	29	5	327
2	news.icm.edu.pl	50	0	1	0	49
TOTAL: 2		558	147	30	5	376

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	102
alt.comp.software.firefox	10
de.rec.sf.startrek	8
it.tlc.cellulari.android	7
comp.mobile.android	7
it.comp.os.win.windows10	5
it.comp.os.win.windows7	3
comp.mobile.ipad	3
nl.comp.sys.android	1
comp.sys.raspberry-pi	1
TOTAL: 10	147

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

Groups	Count
pl.sci.matematyka	5
TOTAL: 1	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	47
Too many newsgroups (low_xpost)	8
Binary in non-binary group	7
TOTAL: 3	62

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	314
	TOTAL: 1	314
TOTAL: 1		314

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	21029	135	6663	163	49	23150	0%	23:59:15
2	icm	14330	72	8737	81	0	2	0%	23:59:22
3	poznan	251	0	220	0	0	0	0%	04:44:11
4	nask	0	0	0	0	0	7514	0%	23:41:32
5	okapi	0	0	0	0	0	777	0%	23:41:32
TOTAL: 5		35610	207	15620	244	49	31443	0%	100:05:52

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	578.4 KB	983.2 KB	1.5 MB	0.0 KB/s	5.2 KB	23:59:15
2	icm	315.3 KB	9.7 MB	10.0 MB	0.1 KB/s	66.7 KB	23:59:22
3	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	04:44:11
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:41:32
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:41:32
TOTAL: 5		893.7 KB	10.6 MB	11.5 MB	0.0 KB/s	26.1 KB	100:05:52

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	290	6	5.7 KB	3	0	00:00:09
2	46.219.209.156	3	5	7.2 KB	3	0	00:00:03
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		294	11	12.9 KB	6	1	00:00:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	1731	6	5.7 KB	3	1	00:00:22
2	unresolved	105	5	7.2 KB	3	0	00:00:19
3	*.census.shodan.io	1	0	0.0 KB	0	0	00:00:00
4	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
TOTAL: 4		1838	11	12.9 KB	6	1	00:00:42

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms2.man.lodz.pl	2.271	10.370	00:00:12
web.man.lodz.pl	0.471	2.161	00:00:09
45.227.254.19	0.000	0.009	00:00:07
94.232.45.238	0.005	0.004	00:00:05
46.219.209.156	0.031	0.026	00:00:03
80.111.142.213	0.009	0.030	00:00:02
212.51.192.185	0.154	0.668	00:00:00
scanner-29.ch1.censys-scanner.com	0.000	0.010	00:00:00
cloud.census.shodan.io	0.000	0.008	00:00:00
isvcs01.man.lodz.pl	0.003	0.013	00:00:00
TOTAL: 10	2.944	13.299	00:00:42

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	1440
212.51.192.185	96
80.111.142.213	4
scanner-29.ch1.censys-scanner.com	1
94.232.45.238	1
cloud.census.shodan.io	1
45.227.254.19	1
TOTAL: 7	1544

NNRP unrecognized commands (by host):

System	Conn
94.232.45.238	1
scanner-29.ch1.censys-scanner.com	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	1
#003	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
94.232.45.238	1	1
TOTAL: 1	1	2

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	6	54.5%
2	lodman	5	45.5%
TOTAL: 2		11	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	6
2	lodman.info	5
TOTAL: 2		11

Daily Usenet report

Apr 25 04:15:02 -- Apr 26 04:15:02