Daily Usenet report: Nov 25 04:15:01

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 25 09:13:38 newsfeed overchan[503291]: input line too long, skipping
Nov 25 10:38:07 newsfeed nnrpd[521351]: SERVER perl filter not defined
Nov 25 11:42:04 newsfeed overchan[503291]: input line too long, skipping
Nov 25 11:44:03 newsfeed overchan[503291]: input line too long, skipping
Nov 25 16:11:31 newsfeed overchan[503291]: input line too long, skipping
Nov 25 16:37:47 newsfeed overchan[503291]: input line too long, skipping
Nov 25 17:25:17 newsfeed overchan[503291]: input line too long, skipping
Nov 25 19:57:35 newsfeed overchan[503291]: input line too long, skipping
Nov 26 01:10:37 newsfeed overchan[503291]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	868782	95.7%	95.5 MB	95.1%
innfeed	25738	2.8%	3.1 MB	3.0%
innd	10411	1.1%	1.6 MB	1.6%
nnrpd	3337	0.4%	319.3 KB	0.3%
overchan	9	0.0%	1.4 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	908278	100.0%	100.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	862344	99.6%
Negative hits	3297	0.4%
Positive hits	182	0.0%
Cache misses	21	0.0%
TOTAL: 4	865844	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.685	0.0%	41	0.000	16.707	35.000
article cleanup	00:00:05.321	0.0%	866445	0.004	0.006	0.010
article logging	00:00:16.693	0.0%	866653	0.013	0.019	0.029
article parse	00:09:54.378	0.7%	148547202	0.003	0.004	0.008
article write	00:06:01.222	0.4%	866143	0.226	0.417	0.611
artlog/artcncl	00:00:00.000	0.0%	40	0.000	0.000	0.000
data move	00:00:41.502	0.0%	155251340	0.000	0.000	0.000
hisgrep/artcncl	00:00:00.160	0.0%	36	0.000	4.444	22.000
hishave/artcncl	00:00:00.006	0.0%	41	0.000	0.146	0.400
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:45.150	0.3%	870091	0.150	0.259	1.961
history sync	00:00:00.006	0.0%	291	0.000	0.021	0.500
history write	00:12:53.574	0.9%	866441	0.239	0.893	12.375
hiswrite/artcncl	00:00:00.001	0.0%	5	0.000	0.200	1.000
idle	22:02:24.256	91.8%	146634093	0.378	0.541	1.270
nntp read	00:29:09.565	2.0%	147979149	0.011	0.012	0.018
overview write	00:00:02.038	0.0%	866143	0.001	0.002	0.005
perl filter	00:41:04.121	2.9%	866441	2.182	2.844	3.704
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:21.533	0.0%	1741332	0.010	0.012	0.017
TOTAL: 24:00:01.858	23:46:40.211	99.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.038	0.0%	32153	0.000	0.001	0.012
article prepare	00:00:00.001	0.0%	9044	0.000	0.000	0.008
article read	00:00:11.682	0.0%	2296	0.000	5.088	78.444
backlog stats	00:00:00.044	0.0%	83264	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	39	0.000	0.000	0.000
data read	00:00:00.366	0.0%	39289	0.000	0.009	0.033
data write	00:00:00.841	0.0%	30661	0.000	0.027	0.071
idle	23:56:51.100	100.0%	83264	690.451	1035.395	2079.308
status file	00:00:04.687	0.0%	8622	0.317	0.544	2.928
TOTAL: 23:57:10.942	23:57:08.759	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:01:15.512	99.8%	2753	0.000	1335.093	364450.400
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.095	0.0%	5819	0.000	0.016	0.500
readart	00:00:00.000	0.0%	6	0.000	0.000	0.000
TOTAL: 01:01:22.816	01:01:15.607	99.8%	-	-	-	-

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
TOTAL: 11	193

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	202	868620	868322	0	298	99%	96:19:26
2	news.icm.edu.pl	43	317	149	163	5	47%	14:19:24
3	localhost	1441	1	1	0	0	100%	00:00:01
TOTAL: 3		1686	868938	868472	163	303	99%	110:38:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	371.0 GB	185.3 KB	3.5 MB	371.0 GB	99%	447.9 KB
2	news.icm.edu.pl	4.1 MB	76.3 KB	197.9 KB	4.4 MB	93%	29.1 KB
3	localhost	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
TOTAL: 3		371.0 GB	261.6 KB	3.7 MB	371.0 GB	99%	447.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 25 04:15:01 - 04:59:59	15484	1.8%	5.74	8.7 GB	2.3%	3374.32
Nov 25 05:00:00 - 05:59:59	23086	2.7%	6.41	12.5 GB	3.4%	3655.42
Nov 25 06:00:00 - 06:59:59	25243	2.9%	7.01	13.1 GB	3.5%	3827.74
Nov 25 07:00:00 - 07:59:59	28145	3.2%	7.82	13.9 GB	3.8%	4060.53
Nov 25 08:00:00 - 08:59:59	26399	3.0%	7.33	13.2 GB	3.6%	3841.10
Nov 25 09:00:00 - 09:59:59	27402	3.2%	7.61	12.1 GB	3.3%	3516.53
Nov 25 10:00:00 - 10:59:59	27262	3.1%	7.57	13.0 GB	3.5%	3778.90
Nov 25 11:00:00 - 11:59:59	36362	4.2%	10.10	14.0 GB	3.8%	4070.03
Nov 25 12:00:00 - 12:59:59	27229	3.1%	7.56	12.8 GB	3.4%	3728.43
Nov 25 13:00:00 - 13:59:59	40709	4.7%	11.31	14.7 GB	4.0%	4292.18
Nov 25 14:00:00 - 14:59:59	29154	3.4%	8.10	14.0 GB	3.8%	4086.80
Nov 25 15:00:00 - 15:59:59	36099	4.2%	10.03	15.9 GB	4.3%	4629.95
Nov 25 16:00:00 - 16:59:59	53411	6.2%	14.84	15.7 GB	4.2%	4580.47
Nov 25 17:00:00 - 17:59:59	38577	4.4%	10.72	16.5 GB	4.5%	4816.33
Nov 25 18:00:00 - 18:59:59	31156	3.6%	8.65	16.2 GB	4.4%	4705.24
Nov 25 19:00:00 - 19:59:59	49200	5.7%	13.67	17.5 GB	4.7%	5102.21
Nov 25 20:00:00 - 20:59:59	67168	7.7%	18.66	19.7 GB	5.3%	5741.95
Nov 25 21:00:00 - 21:59:59	48026	5.5%	13.34	18.3 GB	4.9%	5322.59
Nov 25 22:00:00 - 22:59:59	33926	3.9%	9.42	15.8 GB	4.2%	4588.44
Nov 25 23:00:00 - 23:59:59	43838	5.0%	12.18	17.1 GB	4.6%	4980.79
Nov 26 00:00:00 - 00:59:59	38730	4.5%	10.76	19.5 GB	5.3%	5693.08
Nov 26 01:00:00 - 01:59:59	42855	4.9%	11.90	19.3 GB	5.2%	5630.90
Nov 26 02:00:00 - 02:59:59	40590	4.7%	11.28	18.4 GB	5.0%	5361.27
Nov 26 03:00:00 - 03:59:59	30434	3.5%	8.45	15.1 GB	4.1%	4409.00
Nov 26 04:00:00 - 04:15:02	7745	0.9%	8.59	3.9 GB	1.1%	4574.83
TOTAL: 24:00:01	868230	100.0%	10.05	371.1 GB	100.0%	4503.95

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	506	187	3	4	312
2	news.icm.edu.pl	5	0	1	0	4
TOTAL: 2		511	187	4	4	316

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	128
it.tlc.cellulari.android	23
comp.mobile.android	15
it.comp.os.win.windows10	15
alt.comp.software.seamonkey	2
nl.comp.os.linux.techniek	2
it.comp.os.win.windows7	1
de.comp.lang.php	1
TOTAL: 8	187

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

Groups	Count
pl.praca.oferowana	3
pl.sci.matematyka	1
TOTAL: 2	4

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	104
Scoring filter (8)	3
Too many newsgroups	1
TOTAL: 3	108

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	14967	1430	6827	107	0	0	9%	23:59:58
2	panorama	24027	227	9433	175	73	22321	0%	23:59:30
3	okapi	0	0	0	0	0	738	0%	23:57:49
4	nask	0	0	0	0	0	6111	0%	23:57:49
5	poznan	184	0	146	2	0	0	0%	02:08:14
TOTAL: 5		39178	1657	16406	284	73	29170	4%	98:03:20

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	7.8 MB	747.1 KB	8.6 MB	0.1 KB/s	5.7 KB	23:59:58
2	panorama	858.1 KB	937.7 KB	1.8 MB	0.0 KB/s	4.5 KB	23:59:30
3	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
5	poznan	0.0 KB	54.6 KB	54.6 KB	0.0 KB/s	27.3 KB	02:08:14
TOTAL: 5		8.7 MB	1.7 MB	10.4 MB	0.0 KB/s	5.5 KB	98:03:20

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	6	3.7 KB	3	0	00:00:09
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	6	3.7 KB	3	1	01:01:22

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	291	6	3.7 KB	3	1	01:00:52
2	*.internet-census.org	1	0	0.0 KB	0	0	00:00:05
3	*.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
5	unresolved	103	0	0.0 KB	0	0	00:00:24
TOTAL: 5		397	6	3.7 KB	3	1	01:01:22

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-tom.man.lodz.pl	0.005	0.016	01:00:43
172.105.78.101	0.004	0.004	00:00:10
192.241.197.129	0.000	0.008	00:00:09
web.man.lodz.pl	0.841	1.623	00:00:09
zl-lax-us-gp1-wk133.internet-census.org	0.009	0.000	00:00:05
80.111.142.213	0.018	0.019	00:00:02
212.51.192.185	0.265	0.476	00:00:01
census8.shodan.io	0.000	0.008	00:00:00
scanner-05.ch1.censys-scanner.com	0.007	0.007	00:00:00
192.241.206.131	0.003	0.006	00:00:00
isvcs01.man.lodz.pl	0.012	0.000	00:00:00
TOTAL: 11	1.164	2.167	01:01:22

Curious NNRP server explorers [Top 20]:

System	Conn
212.51.192.185	96
80.111.142.213	4
pc-tom.man.lodz.pl	2
scanner-05.ch1.censys-scanner.com	1
192.241.206.131	1
192.241.197.129	1
zl-lax-us-gp1-wk133.internet-census.org	1
172.105.78.101	1
census8.shodan.io	1
TOTAL: 9	108

NNRP unrecognized commands (by host):

System	Conn
192.241.206.131	1
scanner-05.ch1.censys-scanner.com	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_212.191.2.21_119	1
EHLO www.censys.io	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-tom.man.lodz.pl	2	0
TOTAL: 1	2	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	4
2	pl.comp.pecet	2
TOTAL: 2		6

Daily Usenet report

Nov 25 04:15:01 -- Nov 26 04:15:02