Daily Usenet report: May 2 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

May 2 16:08:51 newsfeed nnrpd[675930]: SERVER perl filter not defined
May 2 16:08:51 newsfeed nnrpd[675930]: SERVER perl filter not defined
May 2 16:26:43 newsfeed nnrpd[678132]: SERVER perl filter not defined
May 2 16:26:43 newsfeed nnrpd[678132]: SERVER perl filter not defined
May 2 20:54:21 newsfeed nnrpd[710497]: SERVER perl filter not defined
May 2 20:54:21 newsfeed nnrpd[710497]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	347599	87.0%	38.2 MB	88.8%
innd	34052	8.5%	3.2 MB	7.3%
nnrpd	16498	4.1%	1.5 MB	3.5%
innfeed	1228	0.3%	160.8 KB	0.4%
overchan	2	0.0%	0.3 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	399381	100.0%	43.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	692132	99.9%
Negative hits	758	0.1%
Positive hits	106	0.0%
Cache misses	12	0.0%
TOTAL: 4	693008	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.194	0.0%	60	0.000	3.233	38.000
article cleanup	00:00:03.768	0.0%	695244	0.002	0.005	0.011
article logging	00:00:14.014	0.0%	695272	0.011	0.020	0.032
article parse	00:00:33.998	0.0%	2046194	0.011	0.017	0.023
article write	00:02:58.070	0.1%	695222	0.205	0.256	0.569
artlog/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
data move	00:00:02.328	0.0%	2916932	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.012	0.0%	92	0.000	0.130	1.000
hishave/artcncl	00:00:00.000	0.0%	32	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:32.216	0.0%	696386	0.004	0.046	0.310
history sync	00:00:00.024	0.0%	712	0.000	0.034	1.000
history write	00:00:59.944	0.0%	695244	0.034	0.086	0.287
idle	47:41:57.054	99.3%	2343486	11.870	73.274	189.189
nntp read	00:00:31.676	0.0%	1876158	0.010	0.017	0.024
overview write	00:00:02.090	0.0%	695222	0.000	0.003	0.007
perl filter	00:11:50.976	0.4%	695244	0.753	1.023	1.404
python filter	00:00:00.194	0.0%	695250	0.000	0.000	0.001
site send	00:00:16.906	0.0%	1402508	0.006	0.012	0.018
TOTAL: 48:01:28.582	48:00:03.464	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.038	0.0%	12030	0.000	0.003	0.037
article prepare	00:00:00.000	0.0%	264	0.000	0.000	0.000
article read	00:00:00.006	0.0%	66	0.000	0.091	1.000
backlog stats	00:00:00.022	0.0%	71742	0.000	0.000	0.011
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.412	0.0%	33274	0.000	0.012	0.048
data write	00:00:01.194	0.0%	21242	0.000	0.056	0.300
idle	47:42:26.776	100.0%	71742	1169.264	2393.950	10026.867
status file	00:00:00.090	0.0%	314	0.000	0.287	1.000
TOTAL: 47:42:29.372	47:42:28.538	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:03:28.382	84.8%	9418	0.000	22.126	2738.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.434	0.2%	31868	0.000	0.014	0.500
readart	00:00:00.100	0.0%	452	0.000	0.221	0.231
TOTAL: 00:04:05.794	00:03:28.916	85.0%	-	-	-	-

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	74	694724	694724	0	0	100%	57:12:06
2	localhost	8	6	6	0	0	100%	00:00:00
3	news.icm.edu.pl	74	114	2	90	22	1%	15:18:30
TOTAL: 3		156	694844	694732	90	22	99%	72:30:36

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	6.3 GB	0.0 KB	6.3 GB	100%	9.4 KB
2	news.icm.edu.pl	19.5 KB	876.5 KB	896.0 KB	2%	37.3 KB
3	localhost	7.7 KB	0.0 KB	7.7 KB	100%	1.3 KB
TOTAL: 3		6.3 GB	876.5 KB	6.3 GB	99%	9.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 2 04:15:02 - 04:59:59	8652	2.5%	3.21	73.2 MB	2.3%	27.80
May 2 05:00:00 - 05:59:59	12057	3.5%	3.35	103.4 MB	3.2%	29.43
May 2 06:00:00 - 06:59:59	14064	4.0%	3.91	110.0 MB	3.4%	31.30
May 2 07:00:00 - 07:59:59	23068	6.6%	6.41	253.4 MB	7.9%	72.07
May 2 08:00:00 - 08:59:59	31403	9.0%	8.72	364.8 MB	11.4%	103.78
May 2 09:00:00 - 09:59:59	14516	4.2%	4.03	125.1 MB	3.9%	35.60
May 2 10:00:00 - 10:59:59	14102	4.1%	3.92	118.5 MB	3.7%	33.70
May 2 11:00:00 - 11:59:59	14740	4.2%	4.09	116.6 MB	3.6%	33.17
May 2 12:00:00 - 12:59:59	13666	3.9%	3.80	113.8 MB	3.6%	32.38
May 2 13:00:00 - 13:59:59	14210	4.1%	3.95	114.7 MB	3.6%	32.63
May 2 14:00:00 - 14:59:59	13897	4.0%	3.86	112.2 MB	3.5%	31.92
May 2 15:00:00 - 15:59:59	13504	3.9%	3.75	112.8 MB	3.5%	32.08
May 2 16:00:00 - 16:59:59	12011	3.5%	3.34	103.9 MB	3.2%	29.57
May 2 17:00:00 - 17:59:59	12788	3.7%	3.55	115.6 MB	3.6%	32.87
May 2 18:00:00 - 18:59:59	13198	3.8%	3.67	120.0 MB	3.7%	34.13
May 2 19:00:00 - 19:59:59	13458	3.9%	3.74	123.9 MB	3.9%	35.25
May 2 20:00:00 - 20:59:59	13037	3.8%	3.62	119.5 MB	3.7%	34.00
May 2 21:00:00 - 21:59:59	12831	3.7%	3.56	128.1 MB	4.0%	36.45
May 2 22:00:00 - 22:59:59	11971	3.4%	3.33	104.1 MB	3.2%	29.60
May 2 23:00:00 - 23:59:59	13162	3.8%	3.66	110.9 MB	3.5%	31.54
May 3 00:00:00 - 00:59:59	13998	4.0%	3.89	142.2 MB	4.4%	40.45
May 3 01:00:00 - 01:59:59	13413	3.9%	3.73	133.7 MB	4.2%	38.04
May 3 02:00:00 - 02:59:59	12812	3.7%	3.56	121.8 MB	3.8%	34.65
May 3 03:00:00 - 03:59:59	13230	3.8%	3.67	124.3 MB	3.9%	35.37
May 3 04:00:00 - 04:15:01	3769	1.1%	4.18	38.2 MB	1.2%	43.37
TOTAL: 23:59:59	347557	100.0%	4.02	3.1 GB	100.0%	37.99

Sites sending bad articles:

Server		Total	Other
1	newsfeed.pionier.net.pl	14	14
2	news.icm.edu.pl	12	12
TOTAL: 2		26	26

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	icm	21424	44	11984	22	0%	47:59:54
2	poznan	2	0	2	0	0%	00:40:00
TOTAL: 2		21426	44	11986	22	0%	48:39:54

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	181.9 KB	313.0 KB	495.0 KB	7.5 KB	47:59:54
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:40:00
TOTAL: 2		181.9 KB	313.0 KB	495.0 KB	7.5 KB	48:39:54

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	syn-066-061-096-239.res.spectrum.com	4	432	403.8 KB	10	0	00:02:38
2	172.16.2.4	576	20	30.8 KB	10	0	00:00:35
3	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 3		586	452	434.6 KB	20	6	00:04:06

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.res.spectrum.com	4	432	403.8 KB	10	0	00:02:38
2	unresolved	784	20	30.8 KB	10	0	00:00:51
3	*.man.lodz.pl	2886	0	0.0 KB	0	6	00:00:31
4	*.monitoring.internet-measurement.com	2	0	0.0 KB	0	0	00:00:03
TOTAL: 4		3676	452	434.6 KB	20	6	00:04:06

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
syn-066-061-096-239.res.spectrum.com	0.058	0.094	00:02:38
172.16.2.4	2.302	4.552	00:00:35
nms1.man.lodz.pl	11.490	21.554	00:00:31
198.235.24.35	0.010	0.016	00:00:05
80.111.142.213	0.030	0.078	00:00:04
invigorating.monitoring.internet-measurement.com	0.006	0.008	00:00:03
205.210.31.97	0.002	0.026	00:00:03
212.51.192.185	0.764	1.442	00:00:02
isvcs01.man.lodz.pl	0.026	0.052	00:00:00
172.202.104.23	0.004	0.010	00:00:00
205.210.31.21	0.016	0.016	00:00:00
TOTAL: 11	14.708	27.848	00:04:06

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	2880
212.51.192.185	192
80.111.142.213	8
205.210.31.21	2
205.210.31.97	2
198.235.24.35	2
invigorating.monitoring.internet-measurement.com	2
172.202.104.23	2
TOTAL: 8	3090

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

System	Conn
172.202.104.23	2
TOTAL: 1	2

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

Command	Count
MGLNDD_212.191.2.21_119	2
TOTAL: 1	2

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	lodz	208	46.0%
2	lodman	208	46.0%
3	pl	20	4.4%
4	lodzman	16	3.5%
TOTAL: 4		452	100.0%

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

Newsgroup		Count
1	lodman.info	200
2	lodz.test	200
3	pl.comp.os.ms-windows.winnt	20
4	lodzman.test	16
5	lodz.ogloszenia	8
6	lodman.test	8
TOTAL: 6		452

Daily Usenet report

May 2 04:15:02 -- May 3 04:15:01