Daily Usenet report: Feb 22 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Feb 22 11:44:58 newsfeed nnrpd[22820]: SERVER perl filter not defined
Feb 22 11:52:56 newsfeed nnrpd[23129]: SERVER perl filter not defined
Feb 22 13:39:48 newsfeed nnrpd[26496]: SERVER perl filter not defined
Feb 22 18:02:50 newsfeed nnrpd[2832]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1639862	98.1%	189.0 MB	97.7%
innd	14501	0.9%	2.4 MB	1.3%
nnrpd	9642	0.6%	1.0 MB	0.5%
innfeed	6946	0.4%	1.0 MB	0.5%
TOTAL: 4	1670951	100.0%	193.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1634691	96.0%
Positive hits	36201	2.1%
Negative hits	31235	1.8%
Cache misses	289	0.0%
TOTAL: 4	1702416	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.174	0.0%	498	0.000	16.414	523.000
article cleanup	00:00:25.481	0.0%	1640145	0.002	0.016	0.030
article logging	00:00:51.284	0.1%	1640324	0.012	0.031	0.498
article parse	00:55:32.906	3.9%	149644200	0.010	0.022	0.085
article write	00:14:08.890	1.0%	1634637	0.287	0.519	2.804
artlog/artcncl	00:00:00.010	0.0%	479	0.000	0.021	1.000
artlog/artparse	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:03:19.563	0.2%	159837459	0.001	0.001	0.011
hisgrep/artcncl	00:00:00.835	0.0%	345	0.000	2.420	31.667
hishave/artcncl	00:00:01.710	0.0%	498	0.000	3.434	305.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:15:25.272	9.4%	1703756	0.014	4.769	13.336
history sync	00:00:00.014	0.0%	291	0.000	0.048	2.000
history write	03:11:59.843	13.3%	1636255	0.176	7.040	53.601
hiswrite/artcncl	00:00:00.653	0.0%	153	0.000	4.268	104.000
idle	12:00:41.652	50.0%	115345528	0.177	0.375	1.355
nntp read	00:59:58.956	4.2%	148539185	0.013	0.024	0.041
overview write	00:00:10.541	0.0%	1634637	0.000	0.006	0.024
perl filter	03:39:14.160	15.2%	1636251	5.593	8.039	9.988
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:25.960	0.2%	3308696	0.030	0.062	0.099
TOTAL: 24:00:34.049	23:25:25.904	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.146	0.0%	39397	0.000	0.004	0.167
article prepare	00:00:00.022	0.0%	56106	0.000	0.000	0.042
article read	00:00:01.638	0.0%	13800	0.000	0.119	5.091
backlog stats	00:00:00.250	0.0%	301147	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:02.010	0.0%	175572	0.000	0.011	1.000
data write	00:00:07.866	0.0%	152200	0.000	0.052	1.000
idle	23:59:08.602	100.0%	301147	0.000	286.732	10192.000
status file	00:00:01.271	0.0%	223	0.000	5.700	257.000
TOTAL: 23:59:28.436	23:59:21.805	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:08.840	0.0%	2491	3.549	3.549	3.549
idle	25:43:48.464	99.9%	116877	0.000	792.529	103911.833
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.211	0.0%	235976	0.000	0.018	0.667
readart	00:00:00.068	0.0%	434	0.000	0.157	2.846
TOTAL: 25:44:38.368	25:44:01.583	100.0%	-	-	-	-

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	545	1627511	1624102	52	3357	99%	245:45:43
2	news.task.gda.pl	14	27713	6753	20032	928	24%	46:10:13
3	news.nask.pl	2	16920	3209	12478	1233	18%	24:42:32
4	news.icm.edu.pl	36	248	12	227	9	4%	16:43:24
5	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 5		602	1672396	1634080	32789	5527	97%	333:21:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	465.6 GB	64.1 MB	117.3 MB	465.8 GB	99%	300.1 KB
2	news.task.gda.pl	13.0 MB	40.2 KB	2.6 MB	15.6 MB	83%	2.1 KB
3	news.nask.pl	11.8 MB	3.1 MB	3.2 MB	18.1 MB	65%	4.2 KB
4	news.icm.edu.pl	610.1 KB	28.0 KB	335.8 KB	973.9 KB	62%	46.4 KB
5	localhost	6.4 KB	0.0 KB	0.0 KB	6.4 KB	100%	1.6 KB
TOTAL: 5		465.6 GB	67.3 MB	123.4 MB	465.8 GB	99%	297.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 22 04:15:02 - 04:59:59	78295	4.8%	29.02	22.5 GB	4.8%	8726.31
Feb 22 05:00:00 - 05:59:59	100212	6.1%	27.84	30.1 GB	6.5%	8776.78
Feb 22 06:00:00 - 06:59:59	92557	5.7%	25.71	30.8 GB	6.6%	8970.81
Feb 22 07:00:00 - 07:59:59	94883	5.8%	26.36	31.5 GB	6.8%	9173.63
Feb 22 08:00:00 - 08:59:59	53854	3.3%	14.96	17.4 GB	3.7%	5069.30
Feb 22 09:00:00 - 09:59:59	48083	2.9%	13.36	13.6 GB	2.9%	3967.77
Feb 22 10:00:00 - 10:59:59	49910	3.1%	13.86	13.6 GB	2.9%	3969.51
Feb 22 11:00:00 - 11:59:59	50202	3.1%	13.95	14.0 GB	3.0%	4090.83
Feb 22 12:00:00 - 12:59:59	51497	3.2%	14.30	14.2 GB	3.1%	4141.88
Feb 22 13:00:00 - 13:59:59	56968	3.5%	15.82	16.2 GB	3.5%	4727.01
Feb 22 14:00:00 - 14:59:59	62729	3.8%	17.42	15.7 GB	3.4%	4568.91
Feb 22 15:00:00 - 15:59:59	52393	3.2%	14.55	14.4 GB	3.1%	4181.37
Feb 22 16:00:00 - 16:59:59	56369	3.5%	15.66	16.1 GB	3.5%	4694.01
Feb 22 17:00:00 - 17:59:59	56509	3.5%	15.70	15.7 GB	3.4%	4573.74
Feb 22 18:00:00 - 18:59:59	54828	3.4%	15.23	15.3 GB	3.3%	4461.54
Feb 22 19:00:00 - 19:59:59	58705	3.6%	16.31	16.2 GB	3.5%	4705.11
Feb 22 20:00:00 - 20:59:59	66784	4.1%	18.55	16.9 GB	3.6%	4919.73
Feb 22 21:00:00 - 21:59:59	68951	4.2%	19.15	17.2 GB	3.7%	5009.42
Feb 22 22:00:00 - 22:59:59	65780	4.0%	18.27	16.6 GB	3.6%	4826.47
Feb 22 23:00:00 - 23:59:59	63619	3.9%	17.67	16.4 GB	3.5%	4786.63
Feb 23 00:00:00 - 00:59:59	81900	5.0%	22.75	23.1 GB	5.0%	6732.28
Feb 23 01:00:00 - 01:59:59	99570	6.1%	27.66	29.4 GB	6.3%	8571.18
Feb 23 02:00:00 - 02:59:59	93999	5.8%	26.11	27.6 GB	5.9%	8042.19
Feb 23 03:00:00 - 03:59:59	60144	3.7%	16.71	16.3 GB	3.5%	4740.53
Feb 23 04:00:00 - 04:15:03	14957	0.9%	16.56	4.6 GB	1.0%	5396.90
TOTAL: 24:00:01	1633698	100.0%	18.91	465.5 GB	100.0%	5649.70

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.pionier.net.pl	3516	188	2657	671
2	news.nask.pl	1229	5	1204	20
3	news.task.gda.pl	933	658	26	249
4	news.icm.edu.pl	7	0	1	6
TOTAL: 4		5685	851	3888	946

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	129
mailing.freebsd.svn-ports-head	129
uk.railway	74
mailing.freebsd.ports-bugs	38
comp.mobile.ipad	34
mailing.freebsd.svn-src-all	31
gmane.linux.alsa.devel	29
fa.freebsd.cvs-all	29
mailing.freebsd.svn-src-head	29
mozilla.dev.tree-management	27
mailing.freebsd.ports	22
fr.usenet.abus.nocem	19
mozilla.dev.platform	18
mailing.openbsd.source-changes	16
alt.windows7.general	16
comp.mobile.android	15
24hoursupport.helpdesk	11
it.comp.os.win.windows8	10
alt.politics.scorched-earth	10
gnu.hurd.bug	9
TOTAL: 61	851

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	431
EMP (fsl)	235
Attached HTML file	84
EMP (md5)	10
HTML post	2
Scoring filter (9)	1
TOTAL: 6	763

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	55258	10551	26765	1725	17	0	19%	23:55:30
2	panorama	41063	1176	37891	275	0	0	2%	23:58:49
3	task	2005	138	1007	20	0	0	6%	22:20:58
4	nask	22369	35	13892	1	0	0	0%	23:56:31
5	poznan	10590	31	9493	9	0	0	0%	24:01:33
6	okapi	0	0	0	0	0	2137	0%	24:00:01
TOTAL: 6		131285	11931	89048	2030	17	2137	9%	142:13:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	1.2 GB	81.3 MB	1.2 GB	15.1 KB/s	106.1 KB	23:55:30
2	panorama	3.8 MB	2.3 MB	6.1 MB	0.1 KB/s	4.3 KB	23:58:49
3	task	276.6 KB	48.7 KB	325.3 KB	0.0 KB/s	2.1 KB	22:20:58
4	nask	96.3 KB	407.0 KB	503.3 KB	0.0 KB/s	14.0 KB	23:56:31
5	poznan	72.5 KB	22.9 KB	95.4 KB	0.0 KB/s	2.4 KB	24:01:33
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 6		1.2 GB	84.1 MB	1.2 GB	2.6 KB/s	93.8 KB	142:13:22

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	336	524.7 KB	288	0	00:00:08
2	web.man.lodz.pl	288	98	95.9 KB	45	0	00:00:22
3	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 3		580	434	620.6 KB	333	4	25:44:37

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	336	524.7 KB	288	0	00:00:08
2	*.man.lodz.pl	676	98	95.9 KB	45	4	00:00:30
3	*.pa.nsw.optusnet.com.au	378	0	0.0 KB	0	0	00:11:30
4	*.191.14.62.static.jazztel.es	6	0	0.0 KB	0	0	04:45:02
5	*.wroclaw.mm.pl	2	0	0.0 KB	0	0	00:01:27
6	unresolved	126	0	0.0 KB	0	0	20:45:56
TOTAL: 6		1476	434	620.6 KB	333	4	25:44:37

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.368	1.160	20:45:56
154.191.14.62.static.jazztel.es	5.852	8.256	04:45:02
pa49-181-247-66.pa.nsw.optusnet.com.au	1.048	3.424	00:11:30
host-89-231-50-15.wroclaw.mm.pl	0.004	0.020	00:01:27
web.man.lodz.pl	0.728	2.664	00:00:22
vegas.cm.p.lodz.pl	0.664	2.700	00:00:08
mon.man.lodz.pl	0.640	2.920	00:00:06
david.man.lodz.pl	0.208	0.928	00:00:01
isvcs01.man.lodz.pl	0.032	0.044	00:00:00
TOTAL: 9	9.544	22.116	25:44:37

Curious NNRP server explorers [Top 20]:

System	Conn
pa49-181-247-66.pa.nsw.optusnet.com.au	378
mon.man.lodz.pl	288
212.191.78.190	126
david.man.lodz.pl	96
154.191.14.62.static.jazztel.es	6
host-89-231-50-15.wroclaw.mm.pl	2
TOTAL: 6	896

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	336	77.4%
2	pl	98	22.6%
TOTAL: 2		434	100.0%

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

Newsgroup		Count
1	lodman.info	336
2	pl.comp.pecet	60
3	pl.comp.os.ms-windows.winnt	38
TOTAL: 3		434

Daily Usenet report

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