Daily Usenet report: Jan 22 04:15:03

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 22 08:21:55 newsfeed controlchan[22907]: skipping newgroup alt.binaries.big-pharma y presidentobola@mail.com (would not change): Empty description
Jan 22 10:35:46 newsfeed nnrpd[24873]: SERVER perl filter not defined
Jan 22 19:17:04 newsfeed nnrpd[9662]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	828827	97.2%	98.0 MB	96.7%
innd	9632	1.1%	1.6 MB	1.6%
nnrpd	7373	0.9%	766.0 KB	0.7%
innfeed	6906	0.8%	1011.4 KB	1.0%
controlchan	5	0.0%	0.8 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	852744	100.0%	101.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	816512	96.0%
Positive hits	17197	2.0%
Negative hits	16693	2.0%
Cache misses	144	0.0%
TOTAL: 4	850546	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.071	0.0%	274	0.000	25.807	633.000
article cleanup	00:00:11.969	0.0%	819331	0.000	0.015	0.053
article logging	00:00:23.771	0.0%	828756	0.000	0.029	1.061
article parse	00:24:01.793	1.7%	66064174	0.005	0.022	0.056
article write	00:08:42.979	0.6%	816033	0.183	0.641	9.151
artlog/artcncl	00:00:00.009	0.0%	271	0.000	0.033	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:01:06.644	0.1%	70926623	0.000	0.001	0.009
hisgrep/artcncl	00:00:01.054	0.0%	264	0.000	3.992	277.000
hishave/artcncl	00:00:00.267	0.0%	274	0.000	0.974	18.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:51:01.252	3.5%	850850	0.405	3.598	11.128
history sync	00:00:00.016	0.0%	399	0.000	0.040	1.000
history write	01:12:57.631	5.1%	817047	2.237	5.358	14.895
hiswrite/artcncl	00:00:00.041	0.0%	10	0.000	4.100	16.000
idle	18:56:55.829	79.0%	54068171	0.307	1.262	9.232
nntp read	00:24:03.766	1.7%	65436987	0.007	0.022	0.043
overview write	00:00:05.015	0.0%	816033	0.000	0.006	0.039
perl filter	01:36:00.650	6.7%	817045	3.800	7.051	11.891
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:45.433	0.1%	1679338	0.011	0.063	0.137
TOTAL: 23:59:50.471	23:37:25.190	98.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.159	0.0%	49073	0.000	0.003	0.143
article prepare	00:00:00.011	0.0%	50188	0.000	0.000	0.125
article read	00:00:05.322	0.0%	11704	0.000	0.455	16.160
backlog stats	00:00:00.179	0.0%	327683	0.000	0.001	0.026
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.852	0.0%	188153	0.000	0.010	1.000
data write	00:00:08.374	0.0%	161055	0.000	0.052	1.000
idle	23:58:35.565	100.0%	327683	0.000	263.412	17311.000
status file	00:00:02.012	0.0%	231	0.000	8.710	214.500
TOTAL: 23:58:59.901	23:58:53.474	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.266	0.0%	105	0.000	2.533	5.667
idle	13:17:33.107	99.9%	122080	0.000	391.982	450140.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.942	0.0%	246178	0.000	0.016	1.111
readart	00:00:01.019	0.0%	484	0.000	2.105	61.000
TOTAL: 13:18:01.832	13:17:38.334	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	149
name	2
newgroup	1
pause	2
paused	2
reload	2
reserve	2
TOTAL: 12	191

Newsgroups created:

Group	Mode
alt.binaries.politics	y
TOTAL	1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
presidentobola@mail.com	3	0	0	0	3	3
TOTAL	3	0	0	0	3	3

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	234	816870	813858	149	2863	99%	127:42:39
2	news.nask.pl	2	17888	2494	14962	432	13%	25:10:48
3	news.icm.edu.pl	43	292	35	239	18	11%	19:04:29
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		282	835052	816389	15350	3313	97%	171:57:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	196.4 GB	17.4 MB	89.3 MB	196.6 GB	99%	252.3 KB
2	news.nask.pl	9.8 MB	1.1 MB	1.1 MB	12.0 MB	81%	4.2 KB
3	news.icm.edu.pl	1.6 MB	29.4 KB	430.4 KB	2.1 MB	78%	40.0 KB
4	localhost	3.0 KB	0.0 KB	0.0 KB	3.0 KB	100%	1.5 KB
TOTAL: 4		196.5 GB	18.5 MB	90.9 MB	196.6 GB	99%	251.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 22 04:15:03 - 04:59:59	51180	6.3%	18.98	18.2 GB	9.3%	7068.55
Jan 22 05:00:00 - 05:59:59	68315	8.4%	18.98	24.5 GB	12.5%	7137.88
Jan 22 06:00:00 - 06:59:59	70579	8.7%	19.61	25.0 GB	12.7%	7270.62
Jan 22 07:00:00 - 07:59:59	80674	9.9%	22.41	26.9 GB	13.7%	7821.53
Jan 22 08:00:00 - 08:59:59	37436	4.6%	10.40	11.1 GB	5.7%	3239.93
Jan 22 09:00:00 - 09:59:59	11792	1.4%	3.28	2.5 GB	1.3%	729.66
Jan 22 10:00:00 - 10:59:59	9136	1.1%	2.54	1.7 GB	0.9%	491.38
Jan 22 11:00:00 - 11:59:59	9077	1.1%	2.52	1.8 GB	0.9%	538.05
Jan 22 12:00:00 - 12:59:59	43100	5.3%	11.97	6.0 GB	3.1%	1746.77
Jan 22 13:00:00 - 13:59:59	39540	4.8%	10.98	5.0 GB	2.5%	1455.09
Jan 22 14:00:00 - 14:59:59	36908	4.5%	10.25	4.8 GB	2.4%	1392.54
Jan 22 15:00:00 - 15:59:59	14052	1.7%	3.90	2.9 GB	1.5%	852.78
Jan 22 16:00:00 - 16:59:59	13340	1.6%	3.71	2.2 GB	1.1%	644.72
Jan 22 17:00:00 - 17:59:59	12599	1.5%	3.50	1.9 GB	1.0%	567.48
Jan 22 18:00:00 - 18:59:59	12609	1.5%	3.50	2.3 GB	1.2%	672.25
Jan 22 19:00:00 - 19:59:59	13172	1.6%	3.66	2.8 GB	1.4%	821.65
Jan 22 20:00:00 - 20:59:59	21755	2.7%	6.04	3.1 GB	1.6%	898.21
Jan 22 21:00:00 - 21:59:59	41483	5.1%	11.52	5.0 GB	2.6%	1464.24
Jan 22 22:00:00 - 22:59:59	39724	4.9%	11.03	5.0 GB	2.6%	1463.85
Jan 22 23:00:00 - 23:59:59	34999	4.3%	9.72	4.4 GB	2.2%	1270.67
Jan 23 00:00:00 - 00:59:59	53101	6.5%	14.75	12.3 GB	6.3%	3575.14
Jan 23 01:00:00 - 01:59:59	55656	6.8%	15.46	14.7 GB	7.5%	4285.30
Jan 23 02:00:00 - 02:59:59	26072	3.2%	7.24	6.8 GB	3.5%	1986.48
Jan 23 03:00:00 - 03:59:59	15947	2.0%	4.43	4.3 GB	2.2%	1251.29
Jan 23 04:00:00 - 04:15:02	3586	0.4%	3.98	945.6 MB	0.5%	1073.45
TOTAL: 23:59:59	815832	100.0%	9.44	196.2 GB	100.0%	2380.94

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	12273	293	1880	0	10100
2	news.nask.pl	433	8	403	1	21
3	news.icm.edu.pl	18	0	2	0	16
TOTAL: 3		12724	301	2285	1	10137

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	125
it.tlc.cellulari.android	63
uk.rec.cycling.moderated	22
de.rec.sf.startrek	20
nl.comp.os.linux.techniek	15
it.comp.os.win.windows7	13
comp.mobile.android	7
comp.mobile.ipad	6
comp.sys.raspberry-pi	5
hr.alt.cellular.gsm.android	5
it.discussioni.energia	5
it.comp.os.win.windows8	5
alt.sex.telephones	3
hr.ponuda.hardver.komponente	3
it.politica.m5s	2
uk.current-events.charlie-hebdo	1
hr.alt.cellular.gsm.iphone	1
TOTAL: 17	301

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

Groups	Count
pl.sci.historia	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	691
EMP (md5)	17
Too many newsgroups	1
Scoring filter (10)	1
TOTAL: 4	710

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	62363	4031	37825	5435	2	4	6%	24:02:58
2	icm	42890	1646	33818	224	0	753	3%	24:02:59
3	nask	26042	67	16880	1141	0	1064	0%	24:02:59
4	poznan	2968	10	2185	5	0	0	0%	24:02:49
5	okapi	0	0	0	0	0	2348	0%	24:00:52
TOTAL: 5		134263	5754	90708	6805	2	4169	4%	120:12:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	177.1 MB	28.4 MB	205.5 MB	2.4 KB/s	112.5 KB	24:02:59
2	panorama	14.5 MB	1.6 GB	1.6 GB	19.7 KB/s	180.1 KB	24:02:58
3	nask	291.4 KB	341.1 MB	341.4 MB	4.0 KB/s	289.4 KB	24:02:59
4	poznan	23.7 KB	8.3 KB	32.0 KB	0.0 KB/s	2.1 KB	24:02:49
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:52
TOTAL: 5		191.9 MB	2.0 GB	2.2 GB	5.2 KB/s	180.4 KB	120:12:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	312	538.8 KB	288	0	00:00:07
2	pc-212-51-218-225.p.lodz.pl	24	80	158.6 KB	14	0	03:55:51
3	lze200.lze.lodz.pl	8	48	81.0 KB	8	0	01:20:37
4	web.man.lodz.pl	288	44	54.5 KB	20	0	00:00:20
5	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 5		610	484	833.0 KB	330	2	13:18:01

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	312	538.8 KB	288	0	00:00:07
2	*.p.lodz.pl	24	80	158.6 KB	14	0	03:55:51
3	*.lze.lodz.pl	8	48	81.0 KB	8	0	01:20:37
4	*.man.lodz.pl	674	44	54.5 KB	20	2	00:00:26
5	*.elsnet.pl	6	0	0.0 KB	0	0	00:00:23
6	unresolved	9	0	0.0 KB	0	0	07:58:36
7	*.toya.net.pl	76	0	0.0 KB	0	0	00:01:59
TOTAL: 7		1085	484	833.0 KB	330	2	13:18:01

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.194.196	6.026	7.472	07:58:36
pc-212-51-218-225.p.lodz.pl	0.096	0.484	03:55:51
lze200.lze.lodz.pl	0.043	0.160	01:20:37
staticline41435.toya.net.pl	0.299	1.436	00:01:29
staticline-31-183-108-238.toya.net.pl	0.004	0.019	00:00:30
host227.elsnet.pl	0.021	0.109	00:00:23
web.man.lodz.pl	0.967	5.404	00:00:20
pc-skrzep2.cm.p.lodz.pl	0.982	5.481	00:00:07
mon.man.lodz.pl	0.978	5.465	00:00:04
david.man.lodz.pl	0.330	1.763	00:00:01
isvcs01.man.lodz.pl	0.008	0.047	00:00:00
?	0.009	0.029	00:00:00
TOTAL: 12	9.763	27.869	13:18:01

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	75
185.48.194.196	9
host227.elsnet.pl	6
staticline-31-183-108-238.toya.net.pl	1
TOTAL: 6	475

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	2
TOTAL: 1	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	4	0
lze200.lze.lodz.pl	2	0
185.48.194.196	1	0
TOTAL: 3	7	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	312	64.5%
2	pl	172	35.5%
TOTAL: 2		484	100.0%

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

Newsgroup		Count
1	lodman.info	312
2	pl.misc.elektronika	50
3	pl.comp.pecet	46
4	pl.misc.kolej	30
5	pl.comp.os.ms-windows.winnt	23
6	pl.rec.dom	15
7	pl.misc.telefonia.gsm	5
8	pl.news.admin	3
TOTAL: 8		484

Daily Usenet report

Jan 22 04:15:03 -- Jan 23 04:15:02