Daily Usenet report: Dec 14 04:15:03

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Dec 14 08:17:59 newsfeed nnrpd[7806]: SERVER perl filter not defined
Dec 14 14:36:35 newsfeed nnrpd[20276]: SERVER perl filter not defined
Dec 14 15:00:50 newsfeed nnrpd[21019]: SERVER perl filter not defined
Dec 14 16:22:16 newsfeed nnrpd[23833]: SERVER perl filter not defined
Dec 14 16:32:47 newsfeed nnrpd[24016]: SERVER perl filter not defined
Dec 14 16:34:22 newsfeed nnrpd[24201]: SERVER perl filter not defined
Dec 14 16:35:51 newsfeed nnrpd[24297]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1140751	96.2%	129.8 MB	95.6%
innd	31007	2.6%	4.3 MB	3.2%
innfeed	7281	0.6%	1.0 MB	0.7%
nnrpd	7237	0.6%	750.4 KB	0.5%
TOTAL: 4	1186276	100.0%	135.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1136013	91.1%
Negative hits	96024	7.7%
Positive hits	14505	1.2%
Cache misses	135	0.0%
TOTAL: 4	1246677	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.026	0.0%	322	0.000	31.137	836.000
article cleanup	00:00:19.514	0.0%	1141017	0.000	0.017	0.039
article logging	00:00:33.478	0.0%	1141134	0.005	0.029	0.354
article parse	00:39:39.843	2.8%	81190806	0.010	0.029	0.070
article write	00:14:02.275	1.0%	1117983	0.203	0.753	6.032
artlog/artcncl	00:00:00.006	0.0%	259	0.000	0.023	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:01:42.247	0.1%	87842266	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.742	0.0%	309	0.000	2.401	30.000
hishave/artcncl	00:00:00.465	0.0%	322	0.000	1.444	15.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:57:26.487	4.0%	1248654	0.008	2.760	8.949
history sync	00:00:00.029	0.0%	317	0.000	0.091	2.000
history write	02:14:23.071	9.3%	1138057	0.054	7.085	15.950
hiswrite/artcncl	00:00:00.108	0.0%	13	0.000	8.308	43.000
idle	16:20:58.743	68.1%	56723597	0.310	1.038	5.932
nntp read	00:35:03.389	2.4%	80387216	0.014	0.026	0.040
overview write	00:00:07.195	0.0%	1117983	0.000	0.006	0.026
perl filter	02:27:52.388	10.3%	1138056	3.369	7.796	11.608
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:22.146	0.2%	2339195	0.021	0.061	0.121
TOTAL: 24:00:18.524	23:34:42.152	98.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.323	0.0%	103614	0.000	0.003	1.000
article prepare	00:00:00.011	0.0%	48120	0.000	0.000	0.042
article read	00:00:01.667	0.0%	11868	0.000	0.140	1.160
backlog stats	00:00:00.291	0.0%	564504	0.000	0.001	0.017
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:04.019	0.0%	364405	0.000	0.011	0.077
data write	00:00:14.132	0.0%	278764	0.000	0.051	22.000
idle	23:59:41.302	100.0%	564504	0.000	153.022	22331.000
status file	00:00:01.105	0.0%	217	0.000	5.092	204.500
TOTAL: 24:00:13.957	24:00:02.850	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	14:35:05.163	99.8%	331029	0.000	158.612	110134.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:46.946	0.1%	1208179	0.000	0.039	2.059
readart	00:00:00.326	0.0%	461	0.000	0.707	14.000
TOTAL: 14:36:30.628	14:35:52.435	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	190

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	485	1137896	1115375	337	22184	98%	242:57:22
2	news.nask.pl	3	14423	2923	10734	766	20%	23:40:33
3	news.icm.edu.pl	47	251	30	149	72	11%	14:36:02
4	localhost	11	10	10	0	0	100%	00:00:01
TOTAL: 4		546	1152580	1118338	11220	23022	97%	281:13:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	316.0 GB	15.0 MB	2.7 GB	318.8 GB	99%	293.8 KB
2	news.nask.pl	11.5 MB	1.9 MB	2.0 MB	15.4 MB	74%	4.3 KB
3	news.icm.edu.pl	1.5 MB	634.4 KB	4.3 MB	6.4 MB	23%	64.4 KB
4	localhost	7.9 KB	0.0 KB	0.0 KB	7.9 KB	100%	0.8 KB
TOTAL: 4		316.1 GB	17.6 MB	2.7 GB	318.8 GB	99%	292.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 14 04:15:03 - 04:59:59	66170	5.9%	24.53	22.4 GB	7.1%	8701.89
Dec 14 05:00:00 - 05:59:59	57368	5.1%	15.94	19.9 GB	6.3%	5798.21
Dec 14 06:00:00 - 06:59:59	58018	5.2%	16.12	18.2 GB	5.7%	5287.41
Dec 14 07:00:00 - 07:59:59	70817	6.3%	19.67	23.3 GB	7.4%	6790.09
Dec 14 08:00:00 - 08:59:59	68236	6.1%	18.95	26.0 GB	8.2%	7571.70
Dec 14 09:00:00 - 09:59:59	17154	1.5%	4.76	3.1 GB	1.0%	911.23
Dec 14 10:00:00 - 10:59:59	15923	1.4%	4.42	3.0 GB	0.9%	871.63
Dec 14 11:00:00 - 11:59:59	23948	2.1%	6.65	4.4 GB	1.4%	1270.35
Dec 14 12:00:00 - 12:59:59	20511	1.8%	5.70	2.8 GB	0.9%	821.36
Dec 14 13:00:00 - 13:59:59	18772	1.7%	5.21	2.6 GB	0.8%	746.69
Dec 14 14:00:00 - 14:59:59	21569	1.9%	5.99	2.5 GB	0.8%	734.23
Dec 14 15:00:00 - 15:59:59	17868	1.6%	4.96	2.2 GB	0.7%	643.96
Dec 14 16:00:00 - 16:59:59	18609	1.7%	5.17	2.4 GB	0.8%	713.50
Dec 14 17:00:00 - 17:59:59	18188	1.6%	5.05	2.4 GB	0.8%	712.44
Dec 14 18:00:00 - 18:59:59	21836	2.0%	6.07	2.9 GB	0.9%	847.98
Dec 14 19:00:00 - 19:59:59	22782	2.0%	6.33	4.0 GB	1.3%	1174.01
Dec 14 20:00:00 - 20:59:59	52046	4.7%	14.46	13.0 GB	4.1%	3777.39
Dec 14 21:00:00 - 21:59:59	50368	4.5%	13.99	14.9 GB	4.7%	4338.04
Dec 14 22:00:00 - 22:59:59	67053	6.0%	18.63	20.2 GB	6.4%	5873.79
Dec 14 23:00:00 - 23:59:59	87933	7.9%	24.43	27.3 GB	8.7%	7962.24
Dec 15 00:00:00 - 00:59:59	78915	7.1%	21.92	22.3 GB	7.1%	6497.68
Dec 15 01:00:00 - 01:59:59	102286	9.2%	28.41	30.7 GB	9.7%	8942.67
Dec 15 02:00:00 - 02:59:59	70277	6.3%	19.52	22.8 GB	7.2%	6653.44
Dec 15 03:00:00 - 03:59:59	52502	4.7%	14.58	16.8 GB	5.3%	4881.19
Dec 15 04:00:00 - 04:15:03	18203	1.6%	20.16	5.6 GB	1.8%	6512.06
TOTAL: 24:00:00	1117352	100.0%	12.93	315.8 GB	100.0%	3832.24

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	22282	151	2195	4	19932
2	news.nask.pl	786	11	756	4	15
3	news.icm.edu.pl	72	0	7	0	65
TOTAL: 3		23140	162	2958	8	20012

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	89
comp.mobile.android	14
it.comp.os.win.windows7	10
it.tlc.cellulari.android	8
comp.sys.raspberry-pi	7
de.comp.office-pakete.ms-office.excel	6
it.comp.os.linux.ubuntu	5
it.comp.os.win.windows8	4
de.comp.lang.php	3
nl.comp.os.linux.techniek	3
hr.ponuda.hardver.komponente	3
rec.arts.tv.x-factor	2
nl.comp.sys.android	2
de.comm.software.mailreader	2
alt.sex.telephones	1
hr.alt.cellular.gsm.android	1
uk.rec.cycling.moderated	1
hr.alt.cellular.gsm.iphone	1
TOTAL: 18	162

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

Groups	Count
pl.sci.historia	6
pl.sci.matematyka	2
TOTAL: 2	8

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	19811
EMP (md5)	80
Scoring filter (8)	1
Attached HTML file	1
Too many newsgroups	1
TOTAL: 5	19894

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	124242	2247	89854	6511	185	1%	23:51:44
2	panorama	103904	1249	101490	240	184	1%	24:03:49
3	nask	22598	841	12764	870	0	3%	24:01:13
4	poznan	3844	22	2744	5	0	0%	23:57:12
5	okapi	0	0	0	0	1948	0%	24:00:00
TOTAL: 5		254588	4359	206852	7626	2317	1%	119:53:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	555.4 MB	662.8 MB	1.2 GB	14.5 KB/s	142.4 KB	23:51:44
2	nask	107.3 MB	313.0 MB	420.3 MB	5.0 KB/s	251.5 KB	24:01:13
3	panorama	5.5 MB	17.7 MB	23.2 MB	0.3 KB/s	15.9 KB	24:03:49
4	poznan	84.2 KB	179.8 KB	264.0 KB	0.0 KB/s	9.8 KB	23:57:12
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		668.2 MB	993.7 MB	1.6 GB	3.9 KB/s	142.0 KB	119:53:58

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	300	494.3 KB	288	0	0	00:00:07
2	web.man.lodz.pl	288	122	141.6 KB	50	0	0	00:00:25
3	pc26.zsk.p.lodz.pl	11	29	114.7 KB	8	4	8	00:50:04
4	pc24.zsk.p.lodz.pl	5	10	7.3 KB	6	5	0	00:28:06
5	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	0	00:00:00
TOTAL: 5		593	461	757.9 KB	352	10	8	14:36:30

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	300	494.3 KB	288	0	0	00:00:07
2	*.man.lodz.pl	673	122	141.6 KB	50	1	0	00:00:31
3	*.zsk.p.lodz.pl	16	39	122.0 KB	14	9	8	01:18:11
4	*.elsnet.pl	4	0	0.0 KB	0	0	0	00:00:44
5	unresolved	5	0	0.0 KB	0	0	0	00:01:08
6	*.206.15.62.static.jazztel.es	4	0	0.0 KB	0	0	0	13:15:42
7	*.toya.net.pl	51	0	0.0 KB	0	0	0	00:00:03
TOTAL: 7		1041	461	757.9 KB	352	10	8	14:36:30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
218.206.15.62.static.jazztel.es	14.684	20.930	13:15:42
pc26.zsk.p.lodz.pl	2.247	0.790	00:50:04
pc24.zsk.p.lodz.pl	0.590	0.313	00:28:06
91.238.254.25	0.076	0.041	00:00:55
host227.elsnet.pl	0.010	0.049	00:00:44
web.man.lodz.pl	1.037	3.450	00:00:25
176.111.232.32	0.060	0.011	00:00:12
pc-skrzep2.cm.p.lodz.pl	1.113	3.157	00:00:07
mon.man.lodz.pl	1.001	3.038	00:00:04
staticline41435.toya.net.pl	0.159	0.627	00:00:03
david.man.lodz.pl	0.353	0.997	00:00:01
isvcs01.man.lodz.pl	0.010	0.010	00:00:00
TOTAL: 12	21.340	33.413	14:36:30

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	51
host227.elsnet.pl	4
218.206.15.62.static.jazztel.es	4
91.238.254.25	4
176.111.232.32	1
TOTAL: 7	448

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	300	65.1%
2	pl	161	34.9%
TOTAL: 2		461	100.0%

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

Newsgroup		Count
1	lodman.info	300
2	pl.comp.pecet	64
3	pl.comp.os.ms-windows.winnt	50
4	pl.test	39
5	pl.internet.polip	8
TOTAL: 5		461

Daily Usenet report

Dec 14 04:15:03 -- Dec 15 04:15:03