Daily Usenet report: Oct 8 04:15:03

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Oct 8 11:04:09 newsfeed nnrpd[6038]: SERVER perl filter not defined
Oct 8 11:43:52 newsfeed nnrpd[7341]: SERVER perl filter not defined
Oct 8 11:44:08 newsfeed nnrpd[7347]: SERVER perl filter not defined
Oct 8 13:34:10 newsfeed nnrpd[10999]: SERVER perl filter not defined
Oct 8 13:34:23 newsfeed nnrpd[11000]: SERVER perl filter not defined
Oct 8 20:01:17 newsfeed nnrpd[24030]: SERVER perl filter not defined
Oct 8 20:48:02 newsfeed nnrpd[25445]: SERVER perl filter not defined
Oct 8 21:23:45 newsfeed overchan[30149]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1607712	98.0%	183.4 MB	97.5%
innd	18795	1.1%	2.9 MB	1.5%
nnrpd	7140	0.4%	752.3 KB	0.4%
innfeed	6527	0.4%	992.0 KB	0.5%
controlchan	27	0.0%	4.0 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 6	1640203	100.0%	188.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1602283	95.7%
Negative hits	52676	3.1%
Positive hits	19078	1.1%
Cache misses	191	0.0%
TOTAL: 4	1674228	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.892	0.0%	306	0.000	32.327	506.000
article cleanup	00:00:24.989	0.0%	1607573	0.000	0.016	0.036
article logging	00:00:40.521	0.0%	1607745	0.004	0.025	0.263
article parse	00:56:43.489	3.9%	123071918	0.013	0.028	0.053
article write	00:13:59.614	1.0%	1597597	0.288	0.526	1.655
artlog/artcncl	00:00:00.006	0.0%	293	0.000	0.020	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:09.146	0.1%	132723898	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.637	0.0%	276	0.000	2.308	73.000
hishave/artcncl	00:00:00.936	0.0%	306	0.000	3.059	88.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:58:53.333	8.3%	1675882	0.014	4.256	17.051
history sync	00:00:00.019	0.0%	292	0.000	0.065	3.000
history write	02:40:09.073	11.1%	1603870	0.068	5.991	17.959
hiswrite/artcncl	00:00:00.181	0.0%	30	0.000	6.033	114.000
idle	13:16:18.984	55.3%	82532692	0.251	0.579	5.163
nntp read	00:48:02.678	3.3%	121727543	0.012	0.024	0.041
overview write	00:00:10.267	0.0%	1597597	0.000	0.006	0.018
perl filter	03:32:43.051	14.8%	1603869	5.246	7.958	10.884
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:01.377	0.2%	3231726	0.018	0.056	0.083
TOTAL: 24:00:28.843	23:33:28.193	98.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.126	0.0%	36508	0.000	0.003	0.091
article prepare	00:00:00.008	0.0%	22432	0.000	0.000	0.125
article read	00:00:00.542	0.0%	5509	0.000	0.098	1.000
backlog stats	00:00:00.158	0.0%	247043	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.467	0.0%	155782	0.000	0.009	1.000
data write	00:00:04.738	0.0%	125979	0.000	0.038	6.000
idle	23:59:16.283	100.0%	247043	0.000	349.560	17003.000
status file	00:00:01.613	0.0%	214	0.000	7.537	220.500
TOTAL: 23:59:30.051	23:59:24.935	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:31:15.903	99.5%	18574	0.000	294.815	600076.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.646	0.0%	38942	0.000	0.017	3.000
readart	00:00:00.480	0.0%	412	0.000	1.165	22.000
TOTAL: 01:31:42.285	01:31:17.029	99.5%	-	-	-	-

Control commands to INND:

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

Newsgroups created:

Group	Mode
free.christian.radio	y
TOTAL	1

Control Channel:

Sender	newgroup	DoIt	OK
911insidejoke@gmail.com	6	0	6
god@heaven.com	20	1	20
TOTAL	26	1	26

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	360	1602893	1592356	1318	9219	99%	257:52:22
2	news.nask.pl	2	19376	4897	13754	725	25%	24:01:51
3	news.icm.edu.pl	36	327	38	257	32	11%	19:22:15
4	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 4		406	1622603	1597298	15329	9976	98%	301:16:28

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	477.8 GB	17.5 MB	934.9 MB	478.8 GB	99%	313.4 KB
2	news.nask.pl	25.0 MB	2.1 MB	2.3 MB	29.3 MB	85%	5.3 KB
3	news.icm.edu.pl	1.1 MB	151.3 KB	440.6 KB	1.7 MB	66%	25.1 KB
4	localhost	11.3 KB	0.0 KB	0.0 KB	11.3 KB	100%	1.6 KB
TOTAL: 4		477.9 GB	19.7 MB	937.7 MB	478.8 GB	99%	312.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 8 04:15:03 - 04:59:59	37694	2.4%	13.98	13.9 GB	2.9%	5390.52
Oct 8 05:00:00 - 05:59:59	52778	3.3%	14.66	18.4 GB	3.9%	5373.61
Oct 8 06:00:00 - 06:59:59	69316	4.3%	19.25	19.6 GB	4.1%	5718.88
Oct 8 07:00:00 - 07:59:59	54679	3.4%	15.19	12.8 GB	2.7%	3733.39
Oct 8 08:00:00 - 08:59:59	88223	5.5%	24.51	21.8 GB	4.6%	6353.03
Oct 8 09:00:00 - 09:59:59	51688	3.2%	14.36	13.3 GB	2.8%	3885.33
Oct 8 10:00:00 - 10:59:59	84374	5.3%	23.44	23.2 GB	4.9%	6756.17
Oct 8 11:00:00 - 11:59:59	86236	5.4%	23.95	23.9 GB	5.0%	6965.65
Oct 8 12:00:00 - 12:59:59	83842	5.2%	23.29	23.6 GB	4.9%	6883.37
Oct 8 13:00:00 - 13:59:59	71527	4.5%	19.87	23.4 GB	4.9%	6825.43
Oct 8 14:00:00 - 14:59:59	75896	4.8%	21.08	22.4 GB	4.7%	6526.17
Oct 8 15:00:00 - 15:59:59	85023	5.3%	23.62	22.4 GB	4.7%	6518.24
Oct 8 16:00:00 - 16:59:59	87266	5.5%	24.24	23.0 GB	4.8%	6694.98
Oct 8 17:00:00 - 17:59:59	79731	5.0%	22.15	22.9 GB	4.8%	6659.25
Oct 8 18:00:00 - 18:59:59	72247	4.5%	20.07	22.7 GB	4.7%	6602.41
Oct 8 19:00:00 - 19:59:59	72040	4.5%	20.01	21.9 GB	4.6%	6386.25
Oct 8 20:00:00 - 20:59:59	63855	4.0%	17.74	20.4 GB	4.3%	5954.01
Oct 8 21:00:00 - 21:59:59	33073	2.1%	9.19	10.1 GB	2.1%	2937.03
Oct 8 22:00:00 - 22:59:59	46262	2.9%	12.85	15.7 GB	3.3%	4558.91
Oct 8 23:00:00 - 23:59:59	64196	4.0%	17.83	22.2 GB	4.7%	6473.91
Oct 9 00:00:00 - 00:59:59	49797	3.1%	13.83	14.8 GB	3.1%	4304.50
Oct 9 01:00:00 - 01:59:59	56097	3.5%	15.58	19.0 GB	4.0%	5538.98
Oct 9 02:00:00 - 02:59:59	52221	3.3%	14.51	18.3 GB	3.8%	5338.46
Oct 9 03:00:00 - 03:59:59	63655	4.0%	17.68	22.7 GB	4.7%	6601.32
Oct 9 04:00:00 - 04:15:02	15554	1.0%	17.24	5.4 GB	1.1%	6262.22
TOTAL: 23:59:59	1597270	100.0%	18.49	477.9 GB	100.0%	5799.93

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	9366	253	3034	0	6079
2	news.nask.pl	751	54	663	1	33
3	news.icm.edu.pl	32	0	8	0	24
TOTAL: 3		10149	307	3705	1	6136

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	138
alt.sex.telephones	42
it.tlc.cellulari.android	34
it.comp.os.win.windows7	20
comp.sys.raspberry-pi	17
comp.mobile.android	11
it.comp.os.win.windows8	9
uk.rec.cycling.moderated	6
comp.mobile.ipad	5
it.discussioni.energia	5
rec.arts.tv.x-factor	4
de.comp.office-pakete.ms-office.excel	4
hr.alt.cellular.gsm.iphone	3
hr.alt.cellular.gsm.android	2
de.comm.provider.telefonie	2
hr.ponuda.hardver.komponente	2
de.comp.lang.vbclassic	1
it.comp.os.linux.ubuntu	1
de.comm.software.mailreader	1
TOTAL: 19	307

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	5903
EMP (md5)	36
HTML post	20
Attached HTML file	2
Scoring filter (8)	1
Scoring filter (12)	1
TOTAL: 6	5963

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	37421	2100	34173	259	0	5%	23:59:01
2	icm	41271	1096	32082	1146	10	2%	23:59:01
3	nask	31111	411	18655	603	0	1%	23:59:01
4	poznan	6875	9	4623	9	0	0%	23:58:58
5	okapi	0	0	0	0	2580	0%	23:54:03
TOTAL: 5		116678	3616	89533	2017	2590	3%	119:50:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	151.8 MB	185.8 MB	337.6 MB	4.0 KB/s	154.2 KB	23:59:01
2	nask	63.3 MB	133.3 MB	196.5 MB	2.3 KB/s	198.5 KB	23:59:01
3	panorama	11.9 MB	933.3 KB	12.8 MB	0.2 KB/s	5.6 KB	23:59:01
4	poznan	25.2 KB	65.4 KB	90.6 KB	0.0 KB/s	5.0 KB	23:58:58
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:54:03
TOTAL: 5		227.0 MB	320.1 MB	547.1 MB	1.3 KB/s	99.4 KB	119:50:04

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	352	583.4 KB	288	0	00:00:08
2	web.man.lodz.pl	288	60	65.5 KB	28	0	00:00:24
3	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	00:00:01
TOTAL: 3		583	412	648.9 KB	316	7	01:31:41

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	352	583.4 KB	288	0	00:00:08
2	*.man.lodz.pl	679	60	65.5 KB	28	7	00:00:35
3	*.rector.com.pl	2	0	0.0 KB	0	0	00:30:34
4	*.206.15.62.static.jazztel.es	2	0	0.0 KB	0	0	00:32:46
5	*.105.135.22.tvsat364.lodz.pl	3	0	0.0 KB	0	0	00:25:26
6	unresolved	1	0	0.0 KB	0	0	00:02:05
7	*.toya.net.pl	68	0	0.0 KB	0	0	00:00:04
TOTAL: 7		1043	412	648.9 KB	316	7	01:31:41

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
141.206.15.62.static.jazztel.es	0.494	0.834	00:32:46
moon2.rector.com.pl	0.007	0.027	00:30:34
ip-176.105.135.22.tvsat364.lodz.pl	0.007	0.044	00:25:26
78.30.114.103	0.032	0.014	00:02:05
web.man.lodz.pl	0.855	4.147	00:00:24
mon.man.lodz.pl	1.002	3.820	00:00:08
pc-skrzep2.cm.p.lodz.pl	1.019	3.963	00:00:08
staticline41435.toya.net.pl	0.219	0.928	00:00:04
david.man.lodz.pl	0.341	1.288	00:00:01
isvcs01.man.lodz.pl	0.040	0.121	00:00:01
TOTAL: 10	4.016	15.186	01:31:41

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	68
ip-176.105.135.22.tvsat364.lodz.pl	3
141.206.15.62.static.jazztel.es	2
moon2.rector.com.pl	2
78.30.114.103	1
TOTAL: 7	460

NNRP client timeouts [Top 20]:

System	Conn	Peer
moon2.rector.com.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	352	85.4%
2	pl	60	14.6%
TOTAL: 2		412	100.0%

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

Newsgroup		Count
1	lodman.info	352
2	pl.comp.pecet	36
3	pl.comp.os.ms-windows.winnt	24
TOTAL: 3		412

Daily Usenet report

Oct 8 04:15:03 -- Oct 9 04:15:02