Daily Usenet report: Mar 24 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Mar 24 05:11:07 newsfeed nnrpd[1205435]: SERVER perl filter not defined
Mar 24 06:32:50 newsfeed overchan[1202611]: input line too long, skipping
Mar 24 09:12:38 newsfeed nnrpd[1216591]: SERVER perl filter not defined
Mar 24 13:08:02 newsfeed overchan[1202611]: input line too long, skipping
Mar 24 15:57:17 newsfeed overchan[1202611]: input line too long, skipping
Mar 24 16:45:46 newsfeed overchan[1202611]: input line too long, skipping
Mar 24 16:46:42 newsfeed overchan[1202611]: input line too long, skipping
Mar 24 19:11:35 newsfeed overchan[1202611]: input line too long, skipping
Mar 24 21:27:31 newsfeed overchan[1202611]: input line too long, skipping
Mar 25 01:58:07 newsfeed overchan[1202611]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1022235	96.1%	111.9 MB	95.7%
innfeed	26066	2.5%	3.1 MB	2.6%
nnrpd	7895	0.7%	888.3 KB	0.7%
innd	7032	0.7%	1.1 MB	1.0%
overchan	9	0.0%	1.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	1063238	100.0%	117.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1019725	99.7%
Negative hits	3086	0.3%
Positive hits	200	0.0%
Cache misses	111	0.0%
TOTAL: 4	1023122	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.178	0.0%	159	0.000	7.409	21.667
article cleanup	00:00:04.270	0.0%	1021559	0.002	0.004	0.009
article logging	00:00:14.888	0.0%	1021935	0.009	0.015	0.033
article parse	00:06:18.996	0.4%	173477155	0.002	0.002	0.003
article write	00:04:29.329	0.3%	1021406	0.155	0.264	0.446
artlog/artcncl	00:00:00.002	0.0%	158	0.000	0.013	1.000
data move	00:00:29.754	0.0%	180863588	0.000	0.000	0.000
hisgrep/artcncl	00:00:00.490	0.0%	159	0.000	3.082	11.000
hishave/artcncl	00:00:00.013	0.0%	159	0.000	0.082	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:10:13.012	0.7%	1025239	0.105	0.598	10.163
history sync	00:00:00.010	0.0%	290	0.000	0.034	0.500
history write	00:20:31.188	1.4%	1021540	0.153	1.205	12.342
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	22:21:05.874	93.1%	172118801	0.329	0.468	0.776
nntp read	00:16:35.623	1.2%	172823660	0.005	0.006	0.008
overview write	00:00:02.070	0.0%	1021406	0.001	0.002	0.004
perl filter	00:29:17.223	2.0%	1021540	1.371	1.720	2.269
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:16.339	0.0%	2052768	0.006	0.008	0.013
TOTAL: 24:00:01.384	23:49:40.259	99.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.028	0.0%	34213	0.000	0.001	0.012
article prepare	00:00:00.000	0.0%	5400	0.000	0.000	0.000
article read	00:00:12.232	0.0%	1371	0.000	8.922	80.500
backlog stats	00:00:00.041	0.0%	86089	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.265	0.0%	41222	0.000	0.006	0.042
data write	00:00:00.542	0.0%	31397	0.000	0.017	0.047
idle	23:55:17.499	100.0%	86089	311.387	1000.331	1806.296
status file	00:00:08.617	0.0%	8814	0.100	0.978	19.656
TOTAL: 23:55:40.955	23:55:39.224	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:02:45.314	88.3%	4399	0.000	37.580	882.800
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.124	0.1%	10638	0.000	0.012	0.579
readart	00:00:00.017	0.0%	50	0.000	0.340	3.500
TOTAL: 00:03:07.313	00:02:45.455	88.3%	-	-	-	-

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	261	1021610	1021490	0	120	99%	102:26:15
2	news.icm.edu.pl	46	188	22	133	33	11%	12:58:21
3	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 3		310	1021800	1021514	133	153	99%	115:24:36

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	372.1 GB	911.8 KB	1.8 MB	372.1 GB	99%	381.9 KB
2	news.icm.edu.pl	888.3 KB	22.6 KB	498.7 KB	1.4 MB	63%	25.6 KB
3	localhost	2.8 KB	0.0 KB	0.0 KB	2.8 KB	100%	1.4 KB
TOTAL: 3		372.1 GB	934.4 KB	2.3 MB	372.1 GB	99%	381.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 24 04:15:02 - 04:59:59	27354	2.7%	10.14	11.0 GB	3.0%	4291.68
Mar 24 05:00:00 - 05:59:59	38468	3.8%	10.69	15.8 GB	4.2%	4589.76
Mar 24 06:00:00 - 06:59:59	32914	3.2%	9.14	15.0 GB	4.0%	4355.75
Mar 24 07:00:00 - 07:59:59	35889	3.5%	9.97	15.5 GB	4.2%	4522.34
Mar 24 08:00:00 - 08:59:59	37135	3.6%	10.32	15.5 GB	4.2%	4501.39
Mar 24 09:00:00 - 09:59:59	42330	4.1%	11.76	16.2 GB	4.4%	4732.72
Mar 24 10:00:00 - 10:59:59	38918	3.8%	10.81	16.3 GB	4.4%	4746.16
Mar 24 11:00:00 - 11:59:59	45558	4.5%	12.65	17.3 GB	4.6%	5027.50
Mar 24 12:00:00 - 12:59:59	52364	5.1%	14.55	17.0 GB	4.6%	4948.25
Mar 24 13:00:00 - 13:59:59	49838	4.9%	13.84	17.5 GB	4.7%	5105.68
Mar 24 14:00:00 - 14:59:59	68955	6.8%	19.15	17.7 GB	4.7%	5144.20
Mar 24 15:00:00 - 15:59:59	43472	4.3%	12.08	13.1 GB	3.5%	3808.87
Mar 24 16:00:00 - 16:59:59	47748	4.7%	13.26	15.1 GB	4.1%	4399.83
Mar 24 17:00:00 - 17:59:59	38127	3.7%	10.59	14.4 GB	3.9%	4208.73
Mar 24 18:00:00 - 18:59:59	41506	4.1%	11.53	14.2 GB	3.8%	4124.06
Mar 24 19:00:00 - 19:59:59	36914	3.6%	10.25	14.1 GB	3.8%	4102.20
Mar 24 20:00:00 - 20:59:59	39046	3.8%	10.85	13.7 GB	3.7%	3992.10
Mar 24 21:00:00 - 21:59:59	48998	4.8%	13.61	14.6 GB	3.9%	4246.48
Mar 24 22:00:00 - 22:59:59	34909	3.4%	9.70	13.4 GB	3.6%	3906.29
Mar 24 23:00:00 - 23:59:59	42351	4.1%	11.76	13.5 GB	3.6%	3935.38
Mar 25 00:00:00 - 00:59:59	54023	5.3%	15.01	15.2 GB	4.1%	4424.22
Mar 25 01:00:00 - 01:59:59	32956	3.2%	9.15	15.8 GB	4.2%	4603.06
Mar 25 02:00:00 - 02:59:59	43604	4.3%	12.11	18.8 GB	5.0%	5462.43
Mar 25 03:00:00 - 03:59:59	38418	3.8%	10.67	16.9 GB	4.5%	4930.21
Mar 25 04:00:00 - 04:15:02	9753	1.0%	10.81	4.8 GB	1.3%	5630.78
TOTAL: 24:00:00	1021548	100.0%	11.82	372.3 GB	100.0%	4518.53

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	495	75	17	9	394
2	news.icm.edu.pl	34	0	2	0	32
TOTAL: 2		529	75	19	9	426

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	42
it.tlc.cellulari.android	12
alt.comp.software.seamonkey	6
de.comp.lang.vbclassic	4
alt.comp.software.firefox	3
comp.mobile.android	3
comp.sys.raspberry-pi	3
nl.comp.os.linux.techniek	1
nl.comp.sys.android	1
TOTAL: 9	75

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	36
Binary in non-binary group	14
TOTAL: 2	50

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	375
	news.icm.edu.pl	1
	TOTAL: 2	376
TOTAL: 1		376

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	25368	625	9962	274	60	23355	2%	23:59:56
2	icm	16220	82	9442	2	0	0	0%	23:59:55
3	poznan	19	0	15	0	0	0	0%	01:49:14
4	nask	0	0	0	0	0	6796	0%	23:57:47
5	okapi	0	0	0	0	0	603	0%	23:57:47
TOTAL: 5		41607	707	19419	276	60	30754	1%	97:44:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	2.1 MB	3.3 MB	5.4 MB	0.1 KB/s	6.2 KB	23:59:56
2	icm	333.2 KB	5.5 KB	338.7 KB	0.0 KB/s	4.0 KB	23:59:55
3	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	01:49:14
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:47
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:47
TOTAL: 5		2.5 MB	3.3 MB	5.7 MB	0.0 KB/s	6.0 KB	97:44:39

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	291	46	39.5 KB	20	0	00:00:08
2	178.218.114.238	18	2	2.8 KB	2	0	00:02:36
3	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 3		311	48	42.3 KB	22	2	00:03:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	1728	46	39.5 KB	20	2	00:00:21
2	unresolved	120	2	2.8 KB	2	0	00:02:45
3	*.ch1.censys-scanner.com	2	0	0.0 KB	0	0	00:00:00
TOTAL: 3		1850	48	42.3 KB	22	2	00:03:07

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
178.218.114.238	0.030	0.240	00:02:36
nms2.man.lodz.pl	2.280	16.884	00:00:13
web.man.lodz.pl	0.472	3.687	00:00:08
212.51.192.185	0.168	1.127	00:00:06
80.111.142.213	0.003	0.059	00:00:02
scanner-04.ch1.censys-scanner.com	0.002	0.027	00:00:00
107.170.236.18	0.004	0.013	00:00:00
isvcs01.man.lodz.pl	0.014	0.020	00:00:00
195.226.194.70	0.004	0.008	00:00:00
TOTAL: 9	2.977	22.065	00:03:07

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	1435
212.51.192.185	96
80.111.142.213	4
scanner-04.ch1.censys-scanner.com	2
195.226.194.70	1
107.170.236.18	1
TOTAL: 6	1539

NNRP unrecognized commands (by host):

System	Conn
195.226.194.70	1
107.170.236.18	1
scanner-04.ch1.censys-scanner.com	1
TOTAL: 3	3

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	1
#003	1
MGLNDD_212.191.2.21_119	1
TOTAL: 3	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
195.226.194.70	1	1
TOTAL: 1	1	2

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	46	95.8%
2	lodman	2	4.2%
TOTAL: 2		48	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	36
2	pl.comp.os.ms-windows.winnt	10
3	lodman.info	2
TOTAL: 3		48

Daily Usenet report

Mar 24 04:15:02 -- Mar 25 04:15:02