Daily Usenet report: Oct 29 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Oct 29 15:29:22 newsfeed nnrpd[1437321]: SERVER perl filter not defined
Oct 29 15:29:22 newsfeed nnrpd[1437321]: SERVER perl filter not defined
Oct 29 15:30:12 newsfeed nnrpd[1437410]: SERVER perl filter not defined
Oct 29 15:30:12 newsfeed nnrpd[1437410]: SERVER perl filter not defined
Oct 29 15:30:35 newsfeed nnrpd[1437647]: SERVER perl filter not defined
Oct 29 15:30:35 newsfeed nnrpd[1437647]: SERVER perl filter not defined
Oct 29 15:30:58 newsfeed nnrpd[1437652]: SERVER perl filter not defined
Oct 29 15:30:58 newsfeed nnrpd[1437652]: SERVER perl filter not defined
Oct 29 15:31:49 newsfeed nnrpd[1437799]: SERVER perl filter not defined
Oct 29 15:31:49 newsfeed nnrpd[1437799]: SERVER perl filter not defined
Oct 29 15:32:12 newsfeed nnrpd[1437800]: SERVER perl filter not defined
Oct 29 15:32:12 newsfeed nnrpd[1437800]: SERVER perl filter not defined
Oct 29 15:33:47 newsfeed nnrpd[1438070]: SERVER perl filter not defined
Oct 29 15:33:47 newsfeed nnrpd[1438070]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	156608	79.2%	17.3 MB	81.7%
innd	24130	12.2%	2.3 MB	10.6%
nnrpd	15682	7.9%	1.5 MB	6.9%
innfeed	1240	0.6%	164.6 KB	0.8%
overchan	2	0.0%	0.3 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	197664	100.0%	21.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	312936	99.7%
Negative hits	846	0.3%
Positive hits	152	0.0%
Cache misses	6	0.0%
TOTAL: 4	313940	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.028	0.0%	60	0.000	0.467	3.000
article cleanup	00:00:01.000	0.0%	313264	0.000	0.003	0.008
article logging	00:00:04.938	0.0%	313324	0.006	0.016	0.026
article parse	00:00:06.310	0.0%	1069590	0.001	0.006	0.013
article write	00:00:27.344	0.0%	313260	0.027	0.087	6.775
artlog/artcncl	00:00:00.000	0.0%	14	0.000	0.000	0.000
data move	00:00:01.134	0.0%	1600890	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.016	0.0%	74	0.000	0.216	2.000
hishave/artcncl	00:00:00.000	0.0%	14	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.620	0.0%	314280	0.000	0.043	0.432
history sync	00:00:00.006	0.0%	614	0.000	0.010	0.500
history write	00:00:36.880	0.0%	313262	0.034	0.118	0.404
idle	47:53:00.634	99.7%	1309212	74.380	131.667	478.926
nntp read	00:00:09.944	0.0%	1032792	0.004	0.010	0.017
overview write	00:00:00.460	0.0%	313260	0.000	0.001	0.007
perl filter	00:03:05.020	0.1%	313262	0.439	0.591	0.764
python filter	00:00:00.086	0.0%	313276	0.000	0.000	0.003
site send	00:00:04.936	0.0%	646944	0.001	0.008	0.014
TOTAL: 48:00:49.694	47:57:52.356	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	20412	0.000	0.002	0.025
article prepare	00:00:00.000	0.0%	1096	0.000	0.000	0.000
article read	00:00:00.010	0.0%	274	0.000	0.036	1.000
backlog stats	00:00:00.012	0.0%	114224	0.000	0.000	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.454	0.0%	57246	0.000	0.008	0.025
data write	00:00:01.288	0.0%	35836	0.000	0.036	0.104
idle	47:55:35.080	100.0%	114224	830.387	1510.498	3777.226
status file	00:00:02.044	0.0%	320	0.000	6.388	953.000
TOTAL: 47:55:39.986	47:55:38.920	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:14.442	52.5%	8806	0.000	8.454	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.320	0.2%	29646	0.000	0.011	0.333
TOTAL: 00:02:21.718	00:01:14.762	52.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	54
flushlogs	4
go	4
logmode	4
lowmark	2
mode	298
name	4
pause	4
paused	4
reload	4
reserve	4
TOTAL: 11	386

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	196	313298	313296	0	2	99%	78:19:42
2	localhost	16	14	14	0	0	100%	00:00:00
3	news.icm.edu.pl	70	150	2	146	2	1%	17:11:58
TOTAL: 3		282	313462	313312	146	4	99%	95:31:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	3.4 GB	17.0 KB	0.0 KB	3.4 GB	99%	11.2 KB
2	localhost	20.9 KB	0.0 KB	0.0 KB	20.9 KB	100%	1.5 KB
3	news.icm.edu.pl	17.0 KB	0.0 KB	29.0 KB	46.0 KB	36%	11.5 KB
TOTAL: 3		3.4 GB	17.0 KB	29.0 KB	3.4 GB	99%	11.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 29 04:15:02 - 04:59:59	2678	1.7%	0.99	34.3 MB	2.0%	13.00
Oct 29 05:00:00 - 05:59:59	4212	2.7%	1.17	45.9 MB	2.7%	13.06
Oct 29 06:00:00 - 06:59:59	4789	3.1%	1.33	53.5 MB	3.1%	15.21
Oct 29 07:00:00 - 07:59:59	5332	3.4%	1.48	55.9 MB	3.3%	15.91
Oct 29 08:00:00 - 08:59:59	6896	4.4%	1.92	78.1 MB	4.5%	22.22
Oct 29 09:00:00 - 09:59:59	8620	5.5%	2.39	87.2 MB	5.1%	24.80
Oct 29 10:00:00 - 10:59:59	7706	4.9%	2.14	83.7 MB	4.9%	23.82
Oct 29 11:00:00 - 11:59:59	6150	3.9%	1.71	79.2 MB	4.6%	22.52
Oct 29 12:00:00 - 12:59:59	6528	4.2%	1.81	78.3 MB	4.6%	22.28
Oct 29 13:00:00 - 13:59:59	6465	4.1%	1.80	70.5 MB	4.1%	20.05
Oct 29 14:00:00 - 14:59:59	8095	5.2%	2.25	86.3 MB	5.0%	24.55
Oct 29 15:00:00 - 15:59:59	7114	4.5%	1.98	83.9 MB	4.9%	23.86
Oct 29 16:00:00 - 16:59:59	6974	4.5%	1.94	81.8 MB	4.8%	23.26
Oct 29 17:00:00 - 17:59:59	6245	4.0%	1.73	74.3 MB	4.3%	21.13
Oct 29 18:00:00 - 18:59:59	8233	5.3%	2.29	85.1 MB	4.9%	24.21
Oct 29 19:00:00 - 19:59:59	9415	6.0%	2.62	111.6 MB	6.5%	31.76
Oct 29 20:00:00 - 20:59:59	6560	4.2%	1.82	68.2 MB	4.0%	19.41
Oct 29 21:00:00 - 21:59:59	6559	4.2%	1.82	81.8 MB	4.8%	23.28
Oct 29 22:00:00 - 22:59:59	6760	4.3%	1.88	75.6 MB	4.4%	21.51
Oct 29 23:00:00 - 23:59:59	7776	5.0%	2.16	81.1 MB	4.7%	23.07
Oct 30 00:00:00 - 00:59:59	6622	4.2%	1.84	57.6 MB	3.4%	16.40
Oct 30 01:00:00 - 01:59:59	5899	3.8%	1.64	58.0 MB	3.4%	16.50
Oct 30 02:00:00 - 02:59:59	5538	3.5%	1.54	59.7 MB	3.5%	16.97
Oct 30 03:00:00 - 03:59:59	4080	2.6%	1.13	37.0 MB	2.1%	10.51
Oct 30 04:00:00 - 04:15:01	1323	0.8%	1.47	11.3 MB	0.7%	12.84
TOTAL: 23:59:59	156569	100.0%	1.81	1.7 GB	100.0%	20.39

Sites sending bad articles:

Server		Total	Duplic	Other
1	newsfeed.pionier.net.pl	31	1	30
2	news.icm.edu.pl	1	0	1
TOTAL: 2		32	1	31

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	2
TOTAL: 1	2

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	38292	270	20136	4	4	0%	47:59:50
2	poznan	2	0	2	0	0	0%	00:40:00
TOTAL: 2		38294	270	20138	4	4	0%	48:39:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	386.5 KB	13.1 KB	399.6 KB	1.5 KB	47:59:50
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:40:00
TOTAL: 2		386.5 KB	13.1 KB	399.6 KB	1.5 KB	48:39:50

NNRP readership statistics:

System		Conn	Post	Elapsed
1	147.185.132.67	2	0	00:00:02
2	66.61.98.95	4	0	00:00:05
3	isvcs01.man.lodz.pl	14	14	00:00:00
4	azpdssq15i3w.stretchoid.com	4	0	00:00:20
5	nms1.man.lodz.pl	1162	0	00:00:09
6	80.111.142.213	8	0	00:00:50
7	205.210.31.133	2	0	00:00:08
8	nms2.man.lodz.pl	1694	0	00:00:13
9	172.16.2.4	576	0	00:00:33
TOTAL: 9		3466	14	00:02:23

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	*.stretchoid.com	4	0	00:00:20
2	unresolved	592	0	00:01:39
3	*.man.lodz.pl	2870	14	00:00:23
TOTAL: 3		3466	14	00:02:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
80.111.142.213	0.024	0.038	00:00:50
172.16.2.4	1.290	2.916	00:00:33
azpdssq15i3w.stretchoid.com	0.010	0.018	00:00:20
nms2.man.lodz.pl	3.508	7.806	00:00:13
nms1.man.lodz.pl	2.526	5.268	00:00:09
205.210.31.133	0.002	0.012	00:00:08
66.61.98.95	0.014	0.016	00:00:05
147.185.132.67	0.008	0.006	00:00:02
isvcs01.man.lodz.pl	0.050	0.070	00:00:00
TOTAL: 9	7.432	16.150	00:02:23

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
azpdssq15i3w.stretchoid.com	2
TOTAL: 1	2

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
MGLNDD_212.191.2.21_119	2
TOTAL: 1	2

Daily Usenet report

Oct 29 04:15:02 -- Oct 30 04:15:01