Daily Usenet report: Jul 20 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jul 20 09:02:41 newsfeed nnrpd[2727]: SERVER perl filter not defined
Jul 20 18:50:52 newsfeed nnrpd[22210]: SERVER perl filter not defined
Jul 20 18:52:34 newsfeed nnrpd[22219]: SERVER perl filter not defined
Jul 21 00:05:07 newsfeed nnrpd[32655]: SERVER perl filter not defined
Jul 21 01:04:10 newsfeed innfeed[2229]: nask:0 connect: Network is unreachable
Jul 21 01:04:10 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1913502	98.4%	216.4 MB	97.9%
innd	16806	0.9%	2.8 MB	1.3%
nnrpd	8002	0.4%	872.2 KB	0.4%
innfeed	6660	0.3%	1.0 MB	0.5%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	1944971	100.0%	221.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1907352	96.7%
Negative hits	51091	2.6%
Positive hits	14413	0.7%
Cache misses	152	0.0%
TOTAL: 4	1973008	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.324	0.0%	282	0.000	36.610	551.000
article cleanup	00:00:31.879	0.0%	1913510	0.000	0.017	0.037
article logging	00:00:58.425	0.1%	1913595	0.014	0.031	0.378
article parse	01:19:09.832	5.5%	122706250	0.008	0.039	0.071
article write	00:20:06.487	1.4%	1908621	0.359	0.632	2.052
artlog/artcncl	00:00:00.005	0.0%	269	0.000	0.019	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:24.193	0.2%	134427937	0.001	0.002	0.004
hisgrep/artcncl	00:00:01.930	0.0%	233	0.000	8.283	70.000
hishave/artcncl	00:00:00.464	0.0%	282	0.000	1.645	18.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:34:08.103	10.7%	1975156	0.009	4.682	13.511
history sync	00:00:00.016	0.0%	291	0.000	0.055	1.000
history write	03:59:40.432	16.6%	1909253	0.568	7.532	25.297
hiswrite/artcncl	00:00:00.403	0.0%	49	0.000	8.224	60.500
idle	09:16:44.324	38.7%	67119911	0.273	0.498	19.917
nntp read	01:05:13.023	4.5%	121049129	0.009	0.032	0.043
overview write	00:00:13.021	0.0%	1908621	0.000	0.007	0.018
perl filter	04:42:09.671	19.6%	1909253	4.857	8.867	10.669
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:10.106	0.3%	3852491	0.015	0.065	0.085
TOTAL: 23:59:33.622	23:26:42.638	97.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.115	0.0%	35311	0.000	0.003	0.143
article prepare	00:00:00.004	0.0%	23826	0.000	0.000	0.125
article read	00:00:01.046	0.0%	5255	0.000	0.199	2.000
backlog stats	00:00:00.193	0.0%	268933	0.000	0.001	0.020
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.033	0.0%	149469	0.000	0.014	1.000
data write	00:00:07.821	0.0%	133960	0.000	0.058	2.000
idle	23:59:27.873	100.0%	268933	0.000	321.150	18958.000
status file	00:00:00.280	0.0%	219	0.000	1.279	79.000
TOTAL: 23:59:45.907	23:59:39.365	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:29:18.729	98.4%	5115	0.000	343.838	230929.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.266	0.0%	12159	0.000	0.022	0.667
readart	00:00:00.596	0.0%	366	0.000	1.628	48.000
TOTAL: 00:29:47.802	00:29:19.591	98.4%	-	-	-	-

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	904	1907232	1903281	922	3029	99%	395:29:39
2	news.nask.pl	3	15083	4434	8939	1710	29%	24:01:36
3	news.icm.edu.pl	40	355	12	190	153	3%	17:40:14
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		952	1922674	1907731	10051	4892	99%	437:11:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	642.9 GB	8.7 MB	32.5 MB	643.0 GB	99%	353.7 KB
2	news.nask.pl	13.9 MB	4.2 MB	4.2 MB	22.3 MB	62%	3.7 KB
3	news.icm.edu.pl	611.5 KB	0.0 KB	9.9 MB	10.5 MB	5%	65.0 KB
4	localhost	5.7 KB	0.0 KB	0.0 KB	5.7 KB	100%	1.4 KB
TOTAL: 4		643.0 GB	12.9 MB	46.6 MB	643.0 GB	99%	352.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 20 04:15:02 - 04:59:59	59345	3.1%	22.00	20.8 GB	3.2%	8102.55
Jul 20 05:00:00 - 05:59:59	83502	4.4%	23.20	28.7 GB	4.5%	8353.32
Jul 20 06:00:00 - 06:59:59	81837	4.3%	22.73	28.8 GB	4.5%	8390.95
Jul 20 07:00:00 - 07:59:59	75486	4.0%	20.97	25.5 GB	4.0%	7428.27
Jul 20 08:00:00 - 08:59:59	81775	4.3%	22.72	26.6 GB	4.1%	7740.38
Jul 20 09:00:00 - 09:59:59	85669	4.5%	23.80	27.5 GB	4.3%	8020.17
Jul 20 10:00:00 - 10:59:59	92074	4.8%	25.58	29.2 GB	4.5%	8517.79
Jul 20 11:00:00 - 11:59:59	96343	5.0%	26.76	30.2 GB	4.7%	8788.75
Jul 20 12:00:00 - 12:59:59	89020	4.7%	24.73	29.4 GB	4.6%	8574.49
Jul 20 13:00:00 - 13:59:59	85241	4.5%	23.68	29.4 GB	4.6%	8565.20
Jul 20 14:00:00 - 14:59:59	83485	4.4%	23.19	30.2 GB	4.7%	8788.00
Jul 20 15:00:00 - 15:59:59	92522	4.8%	25.70	31.5 GB	4.9%	9182.56
Jul 20 16:00:00 - 16:59:59	91504	4.8%	25.42	29.4 GB	4.6%	8553.79
Jul 20 17:00:00 - 17:59:59	82804	4.3%	23.00	23.7 GB	3.7%	6908.67
Jul 20 18:00:00 - 18:59:59	66348	3.5%	18.43	21.2 GB	3.3%	6172.74
Jul 20 19:00:00 - 19:59:59	54383	2.8%	15.11	18.4 GB	2.9%	5373.64
Jul 20 20:00:00 - 20:59:59	79784	4.2%	22.16	25.7 GB	4.0%	7486.52
Jul 20 21:00:00 - 21:59:59	83566	4.4%	23.21	27.2 GB	4.2%	7931.79
Jul 20 22:00:00 - 22:59:59	77243	4.0%	21.46	28.0 GB	4.4%	8149.77
Jul 20 23:00:00 - 23:59:59	69338	3.6%	19.26	24.2 GB	3.8%	7039.25
Jul 21 00:00:00 - 00:59:59	73087	3.8%	20.30	25.9 GB	4.0%	7530.24
Jul 21 01:00:00 - 01:59:59	62540	3.3%	17.37	23.5 GB	3.6%	6835.79
Jul 21 02:00:00 - 02:59:59	66813	3.5%	18.56	24.7 GB	3.8%	7199.62
Jul 21 03:00:00 - 03:59:59	74241	3.9%	20.62	26.3 GB	4.1%	7658.90
Jul 21 04:00:00 - 04:15:03	20311	1.1%	22.49	7.0 GB	1.1%	8101.86
TOTAL: 24:00:01	1908261	100.0%	22.09	643.0 GB	100.0%	7803.88

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.pionier.net.pl	3105	243	2555	307
2	news.nask.pl	1725	8	1704	13
3	news.icm.edu.pl	143	0	0	143
TOTAL: 3		4973	251	4259	463

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	139
it.tlc.cellulari.android	43
comp.mobile.android	15
hr.ponuda.hardver.komponente	9
de.comp.lang.vbclassic	8
it.comp.os.win.windows8	8
hr.alt.cellular.gsm.android	4
comp.sys.mac.vintage	4
comp.mobile.ipad	4
it.comp.os.win.windows7	4
misc.phone.mobile.android	3
hr.ponuda.hardver.konfiguracije	3
it.discussioni.energia	2
hr.alt.cellular.gsm.iphone	2
alt.sex.telephones	1
hr.ponuda.hardver.ostalo	1
uk.rec.cycling.moderated	1
TOTAL: 17	251

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	232
EMP (md5)	145
HTML post	1
TOTAL: 3	378

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	50815	1278	26228	1716	1	43	2%	23:55:15
2	panorama	36375	877	34111	197	0	0	2%	24:00:09
3	poznan	5263	31	4050	12	0	0	0%	23:48:08
4	nask	24743	12	14605	1819	0	16	0%	23:56:06
5	okapi	0	0	0	0	0	1813	0%	23:40:01
TOTAL: 5		117196	2198	78994	3744	1	1872	1%	119:19:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	152.3 MB	613.8 MB	766.1 MB	9.1 KB/s	262.0 KB	23:55:15
2	panorama	3.1 MB	834.1 KB	3.9 MB	0.0 KB/s	3.7 KB	24:00:09
3	poznan	256.9 KB	17.9 KB	274.7 KB	0.0 KB/s	6.4 KB	23:48:08
4	nask	31.8 KB	445.2 MB	445.2 MB	5.3 KB/s	249.0 KB	23:56:06
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:40:01
TOTAL: 5		155.6 MB	1.0 GB	1.2 GB	2.9 KB/s	209.5 KB	119:19:39

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	336	450.6 KB	288	0	00:00:08
2	web.man.lodz.pl	288	30	23.6 KB	13	0	00:00:26
3	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 3		580	366	474.2 KB	301	4	00:29:47

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	336	450.6 KB	288	0	00:00:08
2	*.man.lodz.pl	676	30	23.6 KB	13	4	00:00:33
3	*.pa.nsw.optusnet.com.au	255	0	0.0 KB	0	0	00:16:13
4	unresolved	3	0	0.0 KB	0	0	00:12:45
5	*.toya.net.pl	46	0	0.0 KB	0	0	00:00:06
TOTAL: 5		1268	366	474.2 KB	301	4	00:29:47

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pa49-181-246-227.pa.nsw.optusnet.com.au	1.287	3.261	00:16:13
194.33.77.50	0.015	0.036	00:12:45
web.man.lodz.pl	1.402	3.593	00:00:26
pc-skrzep2.cm.p.lodz.pl	1.474	3.547	00:00:08
staticline41435.toya.net.pl	0.237	0.494	00:00:06
mon.man.lodz.pl	1.389	3.229	00:00:04
david.man.lodz.pl	0.485	1.123	00:00:01
isvcs01.man.lodz.pl	0.034	0.057	00:00:00
TOTAL: 8	6.323	15.340	00:29:47

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
pa49-181-246-227.pa.nsw.optusnet.com.au	255
david.man.lodz.pl	96
staticline41435.toya.net.pl	46
194.33.77.50	3
TOTAL: 5	688

NNRP client timeouts [Top 20]:

System	Conn	Peer
pa49-181-246-227.pa.nsw.optusnet.com.au	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	336	91.8%
2	pl	30	8.2%
TOTAL: 2		366	100.0%

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

Newsgroup		Count
1	lodman.info	336
2	pl.comp.pecet	24
3	pl.comp.os.ms-windows.winnt	6
TOTAL: 3		366

Daily Usenet report

Jul 20 04:15:02 -- Jul 21 04:15:03