Daily Usenet report: Nov 23 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 23 04:17:23 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Nov 23 05:47:58 newsfeed overchan[367161]: input line too long, skipping
Nov 23 09:21:36 newsfeed overchan[367161]: input line too long, skipping
Nov 23 10:21:47 newsfeed overchan[367161]: input line too long, skipping
Nov 23 12:51:19 newsfeed nnrpd[392628]: SERVER perl filter not defined
Nov 23 21:21:59 newsfeed overchan[367161]: input line too long, skipping
Nov 23 23:14:52 newsfeed overchan[367161]: input line too long, skipping
Nov 24 01:07:58 newsfeed overchan[367161]: input line too long, skipping
Nov 24 03:03:50 newsfeed overchan[367161]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	735226	95.2%	80.8 MB	94.6%
innfeed	23541	3.0%	2.8 MB	3.3%
innd	9716	1.3%	1.5 MB	1.7%
nnrpd	3406	0.4%	331.0 KB	0.4%
overchan	8	0.0%	1.5 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	771899	100.0%	85.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	728839	99.7%
Negative hits	1802	0.2%
Positive hits	222	0.0%
Cache misses	21	0.0%
TOTAL: 4	730884	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.343	0.0%	53	0.000	6.472	56.000
article cleanup	00:00:05.081	0.0%	734272	0.004	0.007	0.010
article logging	00:00:16.963	0.0%	734548	0.018	0.023	0.030
article parse	00:09:22.814	0.7%	162924802	0.003	0.003	0.004
article write	00:06:11.503	0.4%	734131	0.401	0.506	0.814
artlog/artcncl	00:00:00.000	0.0%	53	0.000	0.000	0.000
data move	00:00:43.974	0.1%	169160048	0.000	0.000	0.000
hisgrep/artcncl	00:00:00.072	0.0%	53	0.000	1.358	16.000
hishave/artcncl	00:00:00.020	0.0%	53	0.000	0.377	2.857
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:32.357	0.8%	736764	0.168	0.940	8.563
history sync	00:00:00.006	0.0%	291	0.000	0.021	0.500
history write	00:19:28.198	1.4%	734263	0.307	1.591	10.203
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	21:45:09.771	90.6%	160721900	0.386	0.487	0.814
nntp read	00:28:41.584	2.0%	162423519	0.008	0.011	0.013
overview write	00:00:02.155	0.0%	734131	0.001	0.003	0.005
perl filter	00:39:50.590	2.8%	734263	2.701	3.256	3.625
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:19.759	0.0%	1479055	0.010	0.013	0.017
TOTAL: 24:00:00.884	23:41:45.190	98.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.049	0.0%	30878	0.000	0.002	0.029
article prepare	00:00:00.000	0.0%	4750	0.000	0.000	0.000
article read	00:00:12.660	0.0%	1219	0.000	10.386	191.667
backlog stats	00:00:00.045	0.0%	86362	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	31	0.000	0.000	0.000
data read	00:00:00.404	0.0%	40917	0.000	0.010	0.032
data write	00:00:00.959	0.0%	30803	0.000	0.031	0.071
idle	23:55:47.765	100.0%	86362	571.210	997.519	2349.642
status file	00:00:07.673	0.0%	7813	0.200	0.982	21.917
TOTAL: 23:56:11.619	23:56:09.555	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:15:59.088	99.3%	2788	0.000	344.006	25595.270
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.089	0.0%	6007	0.000	0.015	0.500
readart	00:00:00.001	0.0%	20	0.000	0.050	0.500
TOTAL: 00:16:05.872	00:15:59.178	99.3%	-	-	-	-

Control commands to INND:

Command	Number
flush	27
flushlogs	2
go	2
logmode	2
lowmark	1
mode	147
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	191

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	228	734590	734470	0	120	99%	92:36:37
2	news.icm.edu.pl	46	231	30	179	22	12%	14:24:23
3	localhost	1439	1	1	0	0	100%	00:00:00
TOTAL: 3		1713	734822	734501	179	142	99%	107:01:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	383.9 GB	526.4 KB	878.3 KB	383.9 GB	99%	548.0 KB
2	news.icm.edu.pl	1.1 MB	97.3 KB	744.2 KB	1.9 MB	56%	37.1 KB
3	localhost	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
TOTAL: 3		383.9 GB	623.6 KB	1.6 MB	383.9 GB	99%	548.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 23 04:15:02 - 04:59:59	18803	2.6%	6.97	10.6 GB	2.8%	4128.06
Nov 23 05:00:00 - 05:59:59	21590	2.9%	6.00	12.3 GB	3.2%	3570.34
Nov 23 06:00:00 - 06:59:59	25308	3.4%	7.03	14.2 GB	3.7%	4144.32
Nov 23 07:00:00 - 07:59:59	27555	3.8%	7.65	15.8 GB	4.1%	4593.05
Nov 23 08:00:00 - 08:59:59	29313	4.0%	8.14	16.7 GB	4.4%	4876.71
Nov 23 09:00:00 - 09:59:59	31849	4.3%	8.85	16.6 GB	4.3%	4838.46
Nov 23 10:00:00 - 10:59:59	33321	4.5%	9.26	17.8 GB	4.6%	5176.03
Nov 23 11:00:00 - 11:59:59	30623	4.2%	8.51	15.9 GB	4.2%	4642.72
Nov 23 12:00:00 - 12:59:59	33558	4.6%	9.32	16.8 GB	4.4%	4886.96
Nov 23 13:00:00 - 13:59:59	35186	4.8%	9.77	17.4 GB	4.5%	5059.13
Nov 23 14:00:00 - 14:59:59	33133	4.5%	9.20	16.5 GB	4.3%	4799.95
Nov 23 15:00:00 - 15:59:59	34171	4.7%	9.49	16.6 GB	4.3%	4846.21
Nov 23 16:00:00 - 16:59:59	31071	4.2%	8.63	15.8 GB	4.1%	4595.56
Nov 23 17:00:00 - 17:59:59	33088	4.5%	9.19	17.6 GB	4.6%	5114.32
Nov 23 18:00:00 - 18:59:59	35893	4.9%	9.97	18.0 GB	4.7%	5247.10
Nov 23 19:00:00 - 19:59:59	39747	5.4%	11.04	19.4 GB	5.0%	5642.89
Nov 23 20:00:00 - 20:59:59	34420	4.7%	9.56	17.3 GB	4.5%	5045.88
Nov 23 21:00:00 - 21:59:59	37104	5.0%	10.31	18.7 GB	4.9%	5455.82
Nov 23 22:00:00 - 22:59:59	32302	4.4%	8.97	18.1 GB	4.7%	5263.63
Nov 23 23:00:00 - 23:59:59	27887	3.8%	7.75	13.7 GB	3.6%	4004.23
Nov 24 00:00:00 - 00:59:59	26921	3.7%	7.48	12.8 GB	3.3%	3737.13
Nov 24 01:00:00 - 01:59:59	26295	3.6%	7.30	13.1 GB	3.4%	3823.51
Nov 24 02:00:00 - 02:59:59	21722	3.0%	6.03	12.3 GB	3.2%	3592.93
Nov 24 03:00:00 - 03:59:59	25947	3.5%	7.21	15.4 GB	4.0%	4472.50
Nov 24 04:00:00 - 04:15:02	7948	1.1%	8.81	4.6 GB	1.2%	5351.95
TOTAL: 24:00:00	734755	100.0%	8.50	384.1 GB	100.0%	4661.00

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	396	109	8	3	276
2	news.icm.edu.pl	22	0	1	0	21
TOTAL: 2		418	109	9	3	297

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	48
comp.mobile.android	31
it.tlc.cellulari.android	12
alt.comp.software.seamonkey	10
it.comp.os.win.windows10	4
alt.comp.software.firefox	2
nl.comp.os.linux.techniek	2
TOTAL: 7	109

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

Groups	Count
pl.praca.oferowana	3
TOTAL: 1	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	18
Binary in non-binary group	3
TOTAL: 2	21

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	18213	271	9029	230	0	4	1%	23:59:57
2	panorama	20844	206	7598	164	63	22941	0%	23:59:55
3	nask	0	0	0	0	0	7685	0%	23:57:46
4	poznan	27	0	26	0	0	0	0%	00:55:10
5	okapi	0	0	0	0	0	981	0%	23:57:46
TOTAL: 5		39084	477	16653	394	63	31611	1%	96:50:34

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	3.3 MB	47.9 MB	51.2 MB	0.6 KB/s	104.6 KB	23:59:57
2	panorama	669.6 KB	1.3 MB	1.9 MB	0.0 KB/s	5.3 KB	23:59:55
3	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
4	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	00:55:10
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
TOTAL: 5		3.9 MB	49.2 MB	53.1 MB	0.2 KB/s	62.4 KB	96:50:34

Backlog files shrunk by innfeed:

Server	Size
panorama	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	291	20	20.4 KB	10	0	0	00:00:09
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	0	00:00:00
3	staticline57022.toya.net.pl	1	0	0.0 KB	0	0	1	00:15:47
TOTAL: 3		293	20	20.4 KB	10	1	1	00:16:05

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	292	20	20.4 KB	10	1	0	00:00:09
2	*.medicom.bg	1	0	0.0 KB	0	0	0	00:00:02
3	*.toya.net.pl	1	0	0.0 KB	0	0	1	00:15:47
4	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	0	00:00:02
5	unresolved	109	0	0.0 KB	0	0	0	00:00:05
TOTAL: 5		404	20	20.4 KB	10	1	1	00:16:05

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
staticline57022.toya.net.pl	0.019	0.014	00:15:47
web.man.lodz.pl	0.843	1.565	00:00:09
hst-214-9.medicom.bg	0.000	0.008	00:00:02
80.111.142.213	0.007	0.027	00:00:02
scanner-27.ch1.censys-scanner.com	0.000	0.011	00:00:02
164.92.111.134	0.030	0.027	00:00:01
212.51.192.185	0.255	0.488	00:00:01
192.241.207.142	0.000	0.007	00:00:00
isvcs01.man.lodz.pl	0.000	0.013	00:00:00
TOTAL: 9	1.154	2.160	00:16:05

Curious NNRP server explorers [Top 20]:

System	Conn
212.51.192.185	96
164.92.111.134	8
80.111.142.213	4
192.241.207.142	1
scanner-27.ch1.censys-scanner.com	1
hst-214-9.medicom.bg	1
TOTAL: 6	111

NNRP unrecognized commands (by host):

System	Conn
164.92.111.134	42
scanner-27.ch1.censys-scanner.com	1
192.241.207.142	1
TOTAL: 3	44

NNRP unrecognized commands (by command):

Command	Count
Accept-Encoding: gzip, deflate	7
Connection: keep-alive	7
Accept: /	7
Host: 212.191.2.21:119	7
User-Agent: Mozilla/5.0 (Windows NT 10.0...	6
User-Agent: Roku/DVP-9.10 (289.10E04111A...	1
EHLO www.censys.io	1
GET /c/version.js HTTP/1.1	1
GET /stream/live.php HTTP/1.1	1
GET /stalker_portal/c/version.js HTTP/1....	1
MGLNDD_212.191.2.21_119	1
GET /flu/403.html HTTP/1.1	1
GET /streaming/clients_live.php HTTP/1.1	1
GET /system_api.php HTTP/1.1	1
GET / HTTP/1.1	1
TOTAL: 15	44

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	20
TOTAL: 1		20

Daily Usenet report

Nov 23 04:15:02 -- Nov 24 04:15:02