Daily Usenet report: May 6 04:15:01

Unknown entries from news log file:

First 50 / 80 lines (62.5%)

May 6 06:50:34 newsfeed nnrpd[823874]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823873]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823903]: 172.16.2.4 load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823908]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823910]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823904]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823907]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823902]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823906]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823874]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823873]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823903]: 172.16.2.4 load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823908]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823910]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823904]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823907]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823902]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823906]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823909]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823909]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823905]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823905]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823916]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823916]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823911]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823911]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823913]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823914]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823915]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823912]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[824169]: nms1.man.lodz.pl load 23.88 > 16
May 6 06:50:34 newsfeed nnrpd[824254]: nms1.man.lodz.pl load 22.58 > 16
May 6 06:50:34 newsfeed nnrpd[823913]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823914]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823915]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[823912]: nms1.man.lodz.pl load 24.68 > 16
May 6 06:50:34 newsfeed nnrpd[824169]: nms1.man.lodz.pl load 23.88 > 16
May 6 06:50:34 newsfeed nnrpd[824254]: nms1.man.lodz.pl load 22.58 > 16
May 6 06:50:34 newsfeed nnrpd[824334]: nms1.man.lodz.pl load 28.38 > 16
May 6 06:50:34 newsfeed nnrpd[824334]: nms1.man.lodz.pl load 28.38 > 16
May 6 06:50:34 newsfeed nnrpd[824358]: nms1.man.lodz.pl load 33.10 > 16
May 6 06:50:34 newsfeed nnrpd[824365]: nms1.man.lodz.pl load 34.94 > 16
May 6 06:50:34 newsfeed nnrpd[824358]: nms1.man.lodz.pl load 33.10 > 16
May 6 06:50:34 newsfeed nnrpd[824365]: nms1.man.lodz.pl load 34.94 > 16
May 6 06:50:34 newsfeed nnrpd[824802]: nms1.man.lodz.pl load 35.44 > 16
May 6 06:50:34 newsfeed nnrpd[824822]: nms1.man.lodz.pl load 25.95 > 16
May 6 06:50:34 newsfeed nnrpd[824878]: nms1.man.lodz.pl load 24.94 > 16
May 6 06:50:34 newsfeed nnrpd[824802]: nms1.man.lodz.pl load 35.44 > 16
May 6 06:50:34 newsfeed nnrpd[824822]: nms1.man.lodz.pl load 25.95 > 16
May 6 06:50:34 newsfeed nnrpd[824878]: nms1.man.lodz.pl load 24.94 > 16

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	136766	82.3%	15.2 MB	84.3%
innd	18698	11.2%	1.8 MB	9.8%
nnrpd	9564	5.8%	957.4 KB	5.2%
innfeed	1186	0.7%	132.2 KB	0.7%
controlchan	26	0.0%	4.1 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 6	166242	100.0%	18.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	272988	99.6%
Negative hits	1082	0.4%
Positive hits	80	0.0%
Cache misses	2	0.0%
TOTAL: 4	274152	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.020	0.0%	66	0.000	0.303	1.000
article cleanup	00:00:00.702	0.0%	273342	0.000	0.003	0.008
article logging	00:00:06.682	0.0%	273428	0.003	0.024	2.458
article parse	00:00:04.896	0.0%	847634	0.001	0.006	0.011
article write	00:00:31.856	0.0%	273340	0.012	0.117	7.153
artlog/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
data move	00:00:00.882	0.0%	1222994	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.004	0.0%	78	0.000	0.051	1.000
hishave/artcncl	00:00:00.000	0.0%	12	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:22.084	0.0%	274512	0.000	0.080	0.776
history sync	00:00:00.034	0.0%	744	0.000	0.046	0.500
history write	00:01:02.748	0.0%	273342	0.022	0.230	11.587
idle	47:09:16.476	98.2%	1048770	85.505	161.862	348.262
nntp read	00:00:07.492	0.0%	810038	0.005	0.009	0.014
overview write	00:00:00.386	0.0%	273340	0.000	0.001	0.011
perl filter	00:02:22.970	0.1%	273342	0.404	0.523	0.762
python filter	00:00:00.036	0.0%	273348	0.000	0.000	0.002
site send	00:00:03.786	0.0%	560626	0.003	0.007	0.018
TOTAL: 48:02:09.176	47:14:01.054	98.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.036	0.0%	13918	0.000	0.003	0.043
article prepare	00:00:00.000	0.0%	816	0.000	0.000	0.000
article read	00:00:00.002	0.0%	204	0.000	0.010	0.333
backlog stats	00:00:00.014	0.0%	81882	0.000	0.000	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.352	0.0%	38850	0.000	0.009	0.045
data write	00:00:00.726	0.0%	24756	0.000	0.029	0.296
idle	47:13:39.412	98.9%	81882	900.202	2076.395	7428.901
status file	00:26:44.988	0.9%	306	0.000	5245.059	752724.000
TOTAL: 47:46:14.968	47:40:25.530	99.8%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:02:07.906	80.1%	3512	0.000	36.420	10051.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.166	0.1%	10902	0.000	0.015	1.000
readart	00:00:00.000	0.0%	12	0.000	0.000	0.000
TOTAL: 00:02:39.772	00:02:08.072	80.2%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
newsmaster@ausics.net	12	0	0	0	12	12
TOTAL	12	0	0	0	12	12

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	56	273532	273530	2	0	99%	54:24:54
2	localhost	8	6	6	0	0	100%	00:00:00
3	news.icm.edu.pl	52	72	2	68	2	2%	10:07:14
TOTAL: 3		116	273610	273538	70	2	99%	64:32:08

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	2.5 GB	0.0 KB	2.5 GB	100%	9.5 KB
2	news.icm.edu.pl	21.0 KB	35.5 KB	56.4 KB	37%	14.1 KB
3	localhost	11.0 KB	0.0 KB	11.0 KB	100%	1.8 KB
TOTAL: 3		2.5 GB	35.5 KB	2.5 GB	99%	9.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 6 04:15:01 - 04:59:59	3650	2.7%	1.35	40.6 MB	3.2%	15.40
May 6 05:00:00 - 05:59:59	3956	2.9%	1.10	44.0 MB	3.5%	12.52
May 6 06:00:00 - 06:59:59	3005	2.2%	0.83	32.4 MB	2.5%	9.21
May 6 07:00:00 - 07:59:59	6214	4.5%	1.73	58.2 MB	4.6%	16.55
May 6 08:00:00 - 08:59:59	4686	3.4%	1.30	46.7 MB	3.7%	13.30
May 6 09:00:00 - 09:59:59	4889	3.6%	1.36	47.2 MB	3.7%	13.44
May 6 10:00:00 - 10:59:59	5895	4.3%	1.64	57.3 MB	4.5%	16.31
May 6 11:00:00 - 11:59:59	6174	4.5%	1.72	52.8 MB	4.2%	15.02
May 6 12:00:00 - 12:59:59	5112	3.7%	1.42	51.5 MB	4.1%	14.66
May 6 13:00:00 - 13:59:59	5920	4.3%	1.64	59.8 MB	4.7%	17.00
May 6 14:00:00 - 14:59:59	4887	3.6%	1.36	44.0 MB	3.5%	12.53
May 6 15:00:00 - 15:59:59	6268	4.6%	1.74	53.6 MB	4.2%	15.23
May 6 16:00:00 - 16:59:59	7540	5.5%	2.09	70.6 MB	5.6%	20.09
May 6 17:00:00 - 17:59:59	6630	4.8%	1.84	56.7 MB	4.5%	16.13
May 6 18:00:00 - 18:59:59	6221	4.6%	1.73	54.8 MB	4.3%	15.58
May 6 19:00:00 - 19:59:59	7582	5.5%	2.11	68.9 MB	5.4%	19.60
May 6 20:00:00 - 20:59:59	6554	4.8%	1.82	62.6 MB	4.9%	17.81
May 6 21:00:00 - 21:59:59	5487	4.0%	1.52	53.4 MB	4.2%	15.20
May 6 22:00:00 - 22:59:59	5632	4.1%	1.56	60.3 MB	4.7%	17.14
May 6 23:00:00 - 23:59:59	6467	4.7%	1.80	61.2 MB	4.8%	17.41
May 7 00:00:00 - 00:59:59	5985	4.4%	1.66	57.8 MB	4.5%	16.43
May 7 01:00:00 - 01:59:59	5360	3.9%	1.49	48.3 MB	3.8%	13.75
May 7 02:00:00 - 02:59:59	4298	3.1%	1.19	34.0 MB	2.7%	9.68
May 7 03:00:00 - 03:59:59	6808	5.0%	1.89	44.5 MB	3.5%	12.66
May 7 04:00:00 - 04:15:01	1496	1.1%	1.66	9.0 MB	0.7%	10.23
TOTAL: 24:00:00	136716	100.0%	1.58	1.2 GB	100.0%	15.06

Sites sending bad articles:

Server		Total	Other
1	newsfeed.pionier.net.pl	43	43
2	news.icm.edu.pl	1	1
TOTAL: 2		44	44

INND Perl filter [Top 20]:

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

INND misc events:

Events	Count
CCreader	2
TOTAL: 1	2

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	icm	25546	198	13734	6	0%	47:59:56
2	poznan	0	0	0	0	0%	00:20:00
TOTAL: 2		25546	198	13734	6	0%	48:19:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	616.4 KB	12.2 KB	628.6 KB	3.1 KB	47:59:56
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:20:00
TOTAL: 2		616.4 KB	12.2 KB	628.6 KB	3.1 KB	48:19:56

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	66.61.98.95	8	12	15.1 KB	2	0	00:00:13
2	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 2		14	12	15.1 KB	2	6	00:02:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	76	12	15.1 KB	2	0	00:01:03
2	*.internet-census.org	8	0	0.0 KB	0	0	00:00:33
3	*.stretchoid.com	4	0	0.0 KB	0	0	00:00:20
4	*.man.lodz.pl	2886	0	0.0 KB	0	6	00:00:35
5	*.155.45.199.censys-scanner.com	6	0	0.0 KB	0	0	00:00:08
TOTAL: 5		2980	12	15.1 KB	2	6	00:02:40

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
80.82.77.202	0.014	0.016	00:00:40
nms1.man.lodz.pl	8.390	14.388	00:00:34
azpdwsle4074.stretchoid.com	0.012	0.018	00:00:20
zl-amsc-nl-gp1-wk117b.internet-census.org	0.004	0.008	00:00:20
66.61.98.95	0.014	0.048	00:00:13
83.155.45.199.censys-scanner.com	0.072	0.032	00:00:08
80.111.142.213	0.022	0.044	00:00:05
zl-laxd-us-cpp-wk110.internet-census.org	0.002	0.012	00:00:04
zl-laxd-us-cpp-wk111.internet-census.org	0.008	0.008	00:00:04
sh-ams-nl-cpp-wk104.internet-census.org	0.006	0.010	00:00:04
172.16.2.4	0.136	0.276	00:00:03
198.235.24.161	0.000	0.016	00:00:00
isvcs01.man.lodz.pl	0.026	0.032	00:00:00
69.5.169.230	0.004	0.012	00:00:00
TOTAL: 14	8.710	14.920	00:02:40

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	2880
172.16.2.4	52
80.111.142.213	8
83.155.45.199.censys-scanner.com	6
azpdwsle4074.stretchoid.com	4
80.82.77.202	4
zl-laxd-us-cpp-wk111.internet-census.org	2
69.5.169.230	2
zl-laxd-us-cpp-wk110.internet-census.org	2
198.235.24.161	2
zl-amsc-nl-gp1-wk117b.internet-census.org	2
sh-ams-nl-cpp-wk104.internet-census.org	2
TOTAL: 12	2966

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

System	Conn
azpdwsle4074.stretchoid.com	2
83.155.45.199.censys-scanner.com	2
TOTAL: 2	4

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

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
83.155.45.199.censys-scanner.com	2	4
TOTAL: 1	2	8

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	lodman	12	100.0%
TOTAL: 1		12	100.0%

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

Newsgroup		Count
1	lodman.info	12
TOTAL: 1		12

Daily Usenet report

May 6 04:15:01 -- May 7 04:15:01