Daily Usenet report: Jan 13 04:15:03

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jan 13 16:58:39 newsfeed nnrpd[26859]: SERVER perl filter not defined
Jan 13 16:59:27 newsfeed nnrpd[26861]: SERVER perl filter not defined
Jan 13 17:01:34 newsfeed nnrpd[26953]: SERVER perl filter not defined
Jan 13 17:02:58 newsfeed nnrpd[26971]: SERVER perl filter not defined
Jan 13 17:12:30 newsfeed nnrpd[27278]: SERVER perl filter not defined
Jan 14 00:19:54 newsfeed nnrpd[8955]: SERVER perl filter not defined
Jan 14 00:20:25 newsfeed nnrpd[9013]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1766165	98.4%	207.6 MB	98.0%
innd	13676	0.8%	2.4 MB	1.1%
nnrpd	8146	0.5%	871.5 KB	0.4%
innfeed	7377	0.4%	1.1 MB	0.5%
TOTAL: 4	1795364	100.0%	211.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1758744	94.8%
Negative hits	54381	2.9%
Positive hits	41194	2.2%
Cache misses	381	0.0%
TOTAL: 4	1854700	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:16.453	0.0%	509	0.000	32.324	551.000
article cleanup	00:00:25.491	0.0%	1764731	0.002	0.014	0.035
article logging	00:00:54.631	0.1%	1764883	0.009	0.031	0.805
article parse	00:58:06.006	4.0%	140787126	0.007	0.025	0.076
article write	00:14:10.478	1.0%	1757524	0.268	0.484	2.048
artlog/artcncl	00:00:00.006	0.0%	484	0.000	0.012	1.000
artlog/artparse	00:00:00.000	0.0%	7	0.000	0.000	0.000
data move	00:03:24.985	0.2%	151340731	0.000	0.001	0.038
hisgrep/artcncl	00:00:01.722	0.0%	400	0.000	4.305	212.000
hishave/artcncl	00:00:00.793	0.0%	509	0.000	1.558	292.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:22:07.254	5.7%	1855062	0.169	2.656	7.098
history sync	00:00:00.014	0.0%	290	0.000	0.048	2.000
history write	03:39:10.712	15.2%	1759378	3.960	7.475	42.419
hiswrite/artcncl	00:00:00.742	0.0%	109	0.000	6.807	17.000
idle	12:00:18.594	50.0%	105380047	0.177	0.410	1.617
nntp read	00:54:07.526	3.8%	139378669	0.009	0.023	0.046
overview write	00:00:11.493	0.0%	1757524	0.000	0.007	0.018
perl filter	04:01:45.736	16.8%	1759371	4.686	8.245	12.143
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:54.487	0.3%	3555714	0.021	0.066	0.237
TOTAL: 23:59:30.488	23:18:57.123	97.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.148	0.0%	40677	0.000	0.004	0.143
article prepare	00:00:00.015	0.0%	36124	0.000	0.000	0.050
article read	00:00:02.488	0.0%	8853	0.000	0.281	83.000
backlog stats	00:00:00.242	0.0%	313352	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.067	0.0%	184367	0.000	0.011	0.108
data write	00:00:04.817	0.0%	155534	0.000	0.031	1.000
idle	23:59:05.859	100.0%	313352	0.000	275.555	22928.000
status file	00:00:01.725	0.0%	225	0.000	7.667	229.500
TOTAL: 23:59:24.540	23:59:17.361	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:08.677	0.0%	4349	0.686	1.995	2.218
idle	34:21:47.459	99.9%	146616	0.000	843.751	600052.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:05.669	0.0%	295542	0.000	0.019	23.889
readart	00:00:08.133	0.0%	3037	0.000	2.678	98.250
TOTAL: 34:22:54.023	34:22:09.938	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	168	1750984	1743835	1965	5184	99%	186:58:11
2	news.task.gda.pl	11	32745	7824	23687	1234	23%	47:16:13
3	news.nask.pl	2	18483	6911	10751	821	37%	24:03:58
4	localhost	8	7	7	0	0	100%	00:00:02
5	news.icm.edu.pl	50	291	3	282	6	1%	20:07:14
TOTAL: 5		239	1802510	1758580	36685	7245	97%	278:25:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	502.6 GB	106.0 MB	119.5 MB	502.8 GB	99%	301.4 KB
2	news.nask.pl	30.2 MB	2.0 MB	2.1 MB	34.3 MB	88%	4.5 KB
3	news.task.gda.pl	16.3 MB	57.9 KB	3.4 MB	19.8 MB	82%	2.2 KB
4	news.icm.edu.pl	115.1 KB	0.0 KB	982.5 KB	1.1 MB	10%	121.9 KB
5	localhost	12.7 KB	0.0 KB	0.0 KB	12.7 KB	100%	1.8 KB
TOTAL: 5		502.6 GB	108.1 MB	126.0 MB	502.8 GB	99%	298.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 13 04:15:03 - 04:59:59	79148	4.5%	29.35	21.8 GB	4.3%	8489.05
Jan 13 05:00:00 - 05:59:59	108034	6.1%	30.01	29.1 GB	5.8%	8482.52
Jan 13 06:00:00 - 06:59:59	109465	6.2%	30.41	28.8 GB	5.7%	8397.77
Jan 13 07:00:00 - 07:59:59	109205	6.2%	30.33	30.0 GB	6.0%	8751.71
Jan 13 08:00:00 - 08:59:59	110660	6.3%	30.74	32.1 GB	6.4%	9358.39
Jan 13 09:00:00 - 09:59:59	119668	6.8%	33.24	33.4 GB	6.6%	9725.82
Jan 13 10:00:00 - 10:59:59	117797	6.7%	32.72	32.9 GB	6.6%	9595.52
Jan 13 11:00:00 - 11:59:59	116501	6.6%	32.36	32.1 GB	6.4%	9344.94
Jan 13 12:00:00 - 12:59:59	114675	6.5%	31.85	31.8 GB	6.3%	9250.46
Jan 13 13:00:00 - 13:59:59	75558	4.3%	20.99	20.7 GB	4.1%	6016.90
Jan 13 14:00:00 - 14:59:59	67438	3.8%	18.73	17.9 GB	3.6%	5224.58
Jan 13 15:00:00 - 15:59:59	67532	3.8%	18.76	18.1 GB	3.6%	5274.71
Jan 13 16:00:00 - 16:59:59	54017	3.1%	15.00	17.3 GB	3.4%	5041.94
Jan 13 17:00:00 - 17:59:59	31723	1.8%	8.81	10.9 GB	2.2%	3160.42
Jan 13 18:00:00 - 18:59:59	32386	1.8%	9.00	11.0 GB	2.2%	3205.29
Jan 13 19:00:00 - 19:59:59	33070	1.9%	9.19	10.9 GB	2.2%	3183.73
Jan 13 20:00:00 - 20:59:59	34327	2.0%	9.54	10.9 GB	2.2%	3170.19
Jan 13 21:00:00 - 21:59:59	36665	2.1%	10.18	10.9 GB	2.2%	3165.24
Jan 13 22:00:00 - 22:59:59	34785	2.0%	9.66	10.9 GB	2.2%	3179.80
Jan 13 23:00:00 - 23:59:59	35905	2.0%	9.97	10.9 GB	2.2%	3179.80
Jan 14 00:00:00 - 00:59:59	47142	2.7%	13.10	15.6 GB	3.1%	4544.65
Jan 14 01:00:00 - 01:59:59	63550	3.6%	17.65	21.1 GB	4.2%	6143.72
Jan 14 02:00:00 - 02:59:59	67625	3.8%	18.78	19.8 GB	3.9%	5777.56
Jan 14 03:00:00 - 03:59:59	74694	4.2%	20.75	19.4 GB	3.9%	5641.21
Jan 14 04:00:00 - 04:15:03	16746	1.0%	18.54	4.4 GB	0.9%	5058.79
TOTAL: 24:00:00	1758316	100.0%	20.35	502.8 GB	100.0%	6101.90

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	5307	155	4546	1	605
2	news.task.gda.pl	1206	974	35	0	197
3	news.nask.pl	846	10	778	0	58
4	news.icm.edu.pl	6	0	0	0	6
TOTAL: 4		7365	1139	5359	1	866

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	113
mailing.freebsd.svn-ports-head	110
uk.railway	79
mailing.freebsd.ports-bugs	55
fr.usenet.abus.nocem	46
mailing.freebsd.svn-src-all	40
fa.freebsd.cvs-all	40
24hoursupport.helpdesk	36
gmane.linux.alsa.devel	32
mailing.openbsd.ports-changes	30
mailing.postfix.users	30
mailing.unix.samba	29
alt.windows7.general	25
mailing.freebsd.svn-src-head	24
mozilla.dev.tree-management	24
mozilla.dev.gaia	23
mailing.openbsd.source-changes	22
mailing.gcc.gcc-cvs	21
mailing.database.pgsql-general	21
mailing.freebsd.ports	20
TOTAL: 82	1139

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	453
EMP (fsl)	173
EMP (md5)	38
Attached HTML file	36
HTML post	6
Scoring filter (12)	1
TOTAL: 6	707

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	42874	3659	36387	653	0	8%	24:01:29
2	icm	65527	2504	35851	2026	6	3%	23:52:27
3	poznan	17702	107	14463	49	1	0%	24:05:02
4	task	2550	11	1324	3	6	0%	21:51:45
5	nask	19447	11	12431	0	0	0%	24:00:26
6	okapi	0	0	0	0	3261	0%	24:00:00
TOTAL: 6		148100	6292	100456	2731	3274	4%	141:51:09

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	346.9 MB	110.0 MB	456.9 MB	5.4 KB/s	103.3 KB	23:52:27
2	panorama	14.2 MB	4.4 MB	18.5 MB	0.2 KB/s	4.4 KB	24:01:29
3	poznan	378.1 KB	82.2 KB	460.3 KB	0.0 KB/s	3.0 KB	24:05:02
4	task	27.4 KB	5.2 KB	32.7 KB	0.0 KB/s	2.3 KB	21:51:45
5	nask	25.6 KB	0.0 KB	25.6 KB	0.0 KB/s	2.3 KB	24:00:26
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		361.5 MB	114.4 MB	475.9 MB	1.0 KB/s	54.0 KB	141:51:09

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	352	678.3 KB	288	0	00:00:13
2	web.man.lodz.pl	288	156	180.2 KB	63	0	00:00:28
3	pc225.geo.uni.lodz.pl	1	69	129.9 KB	1	0	00:37:14
4	ip-176.105.135.22.tvsat364.lodz.pl	10	8	24.3 KB	5	0	02:28:29
5	router2.cbmm.lodz.pl	1	1	2.1 KB	1	0	00:00:55
6	kujawiak.man.lodz.pl	7	0	0.0 KB	0	7	00:00:01
TOTAL: 6		595	586	1014.8 KB	358	7	34:22:52

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	352	678.3 KB	288	0	00:00:13
2	*.man.lodz.pl	679	156	180.2 KB	63	7	00:00:36
3	*.geo.uni.lodz.pl	1	69	129.9 KB	1	0	00:37:14
4	*.105.135.22.tvsat364.lodz.pl	10	8	24.3 KB	5	0	02:28:29
5	*.cbmm.lodz.pl	1	1	2.1 KB	1	0	00:00:55
6	*.pa.nsw.optusnet.com.au	134	0	0.0 KB	0	0	00:04:07
7	*.wroclaw.mm.pl	52	0	0.0 KB	0	0	08:34:10
8	*.191.14.62.static.jazztel.es	12	0	0.0 KB	0	0	22:36:35
9	*.toya.net.pl	80	0	0.0 KB	0	0	00:00:28
TOTAL: 9		1257	586	1014.8 KB	358	7	34:22:52

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
202.191.14.62.static.jazztel.es	7.904	10.304	22:36:35
host-89-231-50-15.wroclaw.mm.pl	0.100	0.540	08:34:10
ip-176.105.135.22.tvsat364.lodz.pl	0.028	0.112	02:28:29
pc225.geo.uni.lodz.pl	0.040	0.088	00:37:14
pa49-181-246-188.pa.nsw.optusnet.com.au	0.280	1.332	00:04:07
router2.cbmm.lodz.pl	0.000	0.016	00:00:55
web.man.lodz.pl	0.604	3.304	00:00:28
staticline41435.toya.net.pl	0.180	0.848	00:00:28
vegas.cm.p.lodz.pl	0.604	3.432	00:00:13
mon.man.lodz.pl	0.584	3.372	00:00:05
david.man.lodz.pl	0.212	1.044	00:00:01
kujawiak.man.lodz.pl	0.040	0.080	00:00:01
TOTAL: 12	10.576	24.472	34:22:52

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
pa49-181-246-188.pa.nsw.optusnet.com.au	134
david.man.lodz.pl	96
staticline41435.toya.net.pl	80
host-89-231-50-15.wroclaw.mm.pl	52
202.191.14.62.static.jazztel.es	12
TOTAL: 6	662

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip-176.105.135.22.tvsat364.lodz.pl	3	0
pc225.geo.uni.lodz.pl	1	0
TOTAL: 2	4	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	352	60.1%
2	pl	234	39.9%
TOTAL: 2		586	100.0%

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

Newsgroup		Count
1	lodman.info	352
2	pl.comp.pecet	96
3	pl.rec.fantastyka.sf-f	69
4	pl.comp.os.ms-windows.winnt	60
5	pl.soc.prawo	6
6	pl.soc.dzieci	1
7	pl.sci.chemia	1
8	pl.regionalne.lodz	1
TOTAL: 8		586

Daily Usenet report

Jan 13 04:15:03 -- Jan 14 04:15:03