Daily Usenet report: Nov 3 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Nov 3 16:21:05 newsfeed nnrpd[14547]: SERVER perl filter not defined
Nov 3 16:27:28 newsfeed nnrpd[14784]: SERVER perl filter not defined
Nov 3 17:44:24 newsfeed nnrpd[17157]: SERVER perl filter not defined
Nov 3 18:24:18 newsfeed overchan[2136]: input line too long, skipping
Nov 4 00:14:38 newsfeed nnrpd[29902]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1816503	98.3%	204.5 MB	97.8%
innd	17492	0.9%	2.9 MB	1.4%
nnrpd	7126	0.4%	740.3 KB	0.3%
innfeed	6966	0.4%	1.0 MB	0.5%
overchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	1848088	100.0%	209.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1811156	94.6%
Negative hits	67719	3.5%
Positive hits	35487	1.9%
Cache misses	208	0.0%
TOTAL: 4	1914570	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:11.925	0.0%	369	0.000	32.317	598.000
article cleanup	00:00:23.437	0.0%	1815761	0.003	0.013	0.026
article logging	00:00:53.613	0.1%	1815933	0.005	0.030	0.501
article parse	00:56:02.024	3.9%	62529023	0.011	0.054	0.097
article write	00:17:05.551	1.2%	1810321	0.257	0.567	1.544
artlog/artcncl	00:00:00.002	0.0%	366	0.000	0.005	1.000
artlog/artparse	00:00:00.001	0.0%	11	0.000	0.091	0.500
data move	00:02:07.750	0.1%	73672943	0.000	0.002	0.052
hisgrep/artcncl	00:00:02.034	0.0%	222	0.000	9.162	248.000
hishave/artcncl	00:00:01.563	0.0%	369	0.000	4.236	190.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	04:01:21.697	16.8%	1915524	0.542	7.560	54.637
history sync	00:00:00.014	0.0%	291	0.000	0.048	1.000
history write	04:55:31.239	20.5%	1812090	3.316	9.785	62.405
hiswrite/artcncl	00:00:01.351	0.0%	147	0.000	9.190	271.000
idle	08:17:26.446	34.5%	33268942	0.200	0.897	4.253
nntp read	00:29:15.802	2.0%	61064639	0.010	0.029	0.061
overview write	00:00:10.769	0.0%	1810321	0.000	0.006	0.014
perl filter	04:38:18.543	19.3%	1812079	4.263	9.215	14.323
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:29.629	0.2%	3657645	0.025	0.057	0.236
TOTAL: 24:00:05.950	23:42:23.390	98.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.137	0.0%	37010	0.000	0.004	1.000
article prepare	00:00:00.006	0.0%	29836	0.000	0.000	0.083
article read	00:00:01.495	0.0%	7264	0.000	0.206	7.200
backlog stats	00:00:00.222	0.0%	290078	0.000	0.001	0.015
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.851	0.0%	165192	0.000	0.011	0.094
data write	00:00:06.919	0.0%	153479	0.000	0.045	1.833
idle	23:59:50.138	100.0%	290078	0.000	297.817	15291.000
status file	00:00:21.173	0.0%	231	0.000	91.658	4126.750
TOTAL: 24:00:28.307	24:00:21.941	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	29:44:04.765	99.9%	637881	0.000	167.813	600063.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:19.984	0.0%	1277526	0.000	0.016	2.222
readart	00:00:00.488	0.0%	417	0.000	1.170	29.923
TOTAL: 29:45:26.034	29:44:25.237	99.9%	-	-	-	-

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	1142	1804089	1799897	543	3649	99%	409:00:41
2	news.task.gda.pl	14	28252	6722	20366	1164	23%	45:40:34
3	news.nask.pl	2	15407	3892	10899	616	25%	23:20:44
4	news.icm.edu.pl	38	251	23	223	5	9%	16:50:54
5	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 5		1201	1848003	1810538	32031	5434	97%	494:52:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	702.3 GB	20.2 MB	57.5 MB	702.4 GB	99%	408.4 KB
2	news.nask.pl	18.6 MB	1.5 MB	1.6 MB	21.7 MB	85%	4.9 KB
3	news.task.gda.pl	12.9 MB	94.4 KB	3.1 MB	16.1 MB	80%	2.1 KB
4	news.icm.edu.pl	1.2 MB	11.0 KB	95.6 KB	1.3 MB	91%	46.9 KB
5	localhost	10.5 KB	0.0 KB	0.0 KB	10.5 KB	100%	2.6 KB
TOTAL: 5		702.4 GB	21.8 MB	62.3 MB	702.4 GB	99%	405.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 3 04:15:03 - 04:59:59	48732	2.7%	18.07	21.6 GB	3.1%	8380.87
Nov 3 05:00:00 - 05:59:59	61791	3.4%	17.16	28.0 GB	4.0%	8166.85
Nov 3 06:00:00 - 06:59:59	65359	3.6%	18.16	29.4 GB	4.2%	8550.69
Nov 3 07:00:00 - 07:59:59	69438	3.8%	19.29	29.7 GB	4.2%	8662.18
Nov 3 08:00:00 - 08:59:59	68823	3.8%	19.12	28.2 GB	4.0%	8201.71
Nov 3 09:00:00 - 09:59:59	67674	3.7%	18.80	27.8 GB	4.0%	8103.41
Nov 3 10:00:00 - 10:59:59	86931	4.8%	24.15	31.9 GB	4.5%	9290.53
Nov 3 11:00:00 - 11:59:59	91739	5.1%	25.48	32.2 GB	4.6%	9382.52
Nov 3 12:00:00 - 12:59:59	84717	4.7%	23.53	30.3 GB	4.3%	8814.49
Nov 3 13:00:00 - 13:59:59	81885	4.5%	22.75	28.6 GB	4.1%	8331.93
Nov 3 14:00:00 - 14:59:59	97163	5.4%	26.99	32.9 GB	4.7%	9589.16
Nov 3 15:00:00 - 15:59:59	93116	5.1%	25.87	33.5 GB	4.8%	9746.77
Nov 3 16:00:00 - 16:59:59	92933	5.1%	25.81	32.4 GB	4.6%	9424.66
Nov 3 17:00:00 - 17:59:59	87728	4.8%	24.37	30.9 GB	4.4%	8995.96
Nov 3 18:00:00 - 18:59:59	64671	3.6%	17.96	23.7 GB	3.4%	6912.03
Nov 3 19:00:00 - 19:59:59	64011	3.5%	17.78	25.4 GB	3.6%	7393.45
Nov 3 20:00:00 - 20:59:59	70720	3.9%	19.64	27.5 GB	3.9%	8008.31
Nov 3 21:00:00 - 21:59:59	69395	3.8%	19.28	26.8 GB	3.8%	7796.88
Nov 3 22:00:00 - 22:59:59	69359	3.8%	19.27	28.4 GB	4.0%	8265.76
Nov 3 23:00:00 - 23:59:59	64914	3.6%	18.03	27.5 GB	3.9%	8012.47
Nov 4 00:00:00 - 00:59:59	64552	3.6%	17.93	26.0 GB	3.7%	7569.81
Nov 4 01:00:00 - 01:59:59	67128	3.7%	18.65	28.4 GB	4.0%	8271.99
Nov 4 02:00:00 - 02:59:59	82642	4.6%	22.96	33.0 GB	4.7%	9602.48
Nov 4 03:00:00 - 03:59:59	74878	4.1%	20.80	30.0 GB	4.3%	8739.18
Nov 4 04:00:00 - 04:15:03	20216	1.1%	22.39	8.0 GB	1.1%	9341.35
TOTAL: 24:00:00	1810515	100.0%	20.96	701.9 GB	100.0%	8518.96

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3798	277	3038	1	482
2	news.task.gda.pl	1171	825	48	2	296
3	news.nask.pl	647	25	593	0	29
4	news.icm.edu.pl	7	0	2	0	5
TOTAL: 4		5623	1127	3681	3	812

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	115
mailing.freebsd.svn-ports-head	115
uk.railway	103
comp.mobile.ipad	60
mailing.freebsd.ports-bugs	58
uk.rec.cycling.moderated	43
alt.politics.scorched-earth	36
mailing.openbsd.source-changes	34
mailing.freebsd.ports	33
mozilla.dev.tree-management	33
mailing.openbsd.ports-changes	31
mailing.freebsd.svn-src-all	30
fa.freebsd.cvs-all	30
alt.windows7.general	27
fr.usenet.abus.nocem	26
24hoursupport.helpdesk	23
mailing.freebsd.current	21
mailing.gcc.gcc-cvs	19
mailing.freebsd.kde	17
mailing.unix.samba	15
TOTAL: 76	1127

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

Groups	Count
fr.comp.lang.php	2
pl.sci.historia	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	319
EMP (fsl)	189
EMP (phl)	86
EMP (md5)	16
Attached HTML file	13
HTML post	3
Scoring filter (8)	2
Scoring filter (12)	1
TOTAL: 8	629

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	38564	2460	33947	614	0	6%	24:03:51
2	icm	54659	817	31879	3205	0	1%	23:57:31
3	task	2176	166	1049	10	0	7%	21:27:33
4	poznan	12061	64	10502	40	0	0%	24:01:48
5	nask	18646	17	13512	68	0	0%	24:06:44
6	okapi	0	0	0	0	2094	0%	24:00:00
TOTAL: 6		126106	3524	90889	3937	2094	2%	141:37:27

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	52.9 MB	1.8 GB	1.8 GB	22.3 KB/s	479.2 KB	23:57:31
2	panorama	8.8 MB	2.2 MB	11.0 MB	0.1 KB/s	3.7 KB	24:03:51
3	task	334.4 KB	29.5 KB	364.0 KB	0.0 KB/s	2.1 KB	21:27:33
4	poznan	201.9 KB	65.0 KB	266.9 KB	0.0 KB/s	2.6 KB	24:01:48
5	nask	38.5 KB	19.7 MB	19.7 MB	0.2 KB/s	237.6 KB	24:06:44
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		62.3 MB	1.8 GB	1.9 GB	3.8 KB/s	262.6 KB	141:37:27

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	vegas.cm.p.lodz.pl	288	300	366.6 KB	288	0	0	00:00:10
2	web.man.lodz.pl	291	109	84.1 KB	53	3	0	00:00:20
3	dxb33.neoplus.adsl.tpnet.pl	7	4	7.3 KB	3	0	4	00:14:52
4	ip-176.105.135.22.tvsat364.lodz.pl	9	4	10.8 KB	3	0	0	02:37:13
5	kujawiak.man.lodz.pl	1	0	0.0 KB	0	1	0	00:00:00
TOTAL: 5		596	417	468.8 KB	347	4	4	29:45:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	300	366.6 KB	288	0	0	00:00:10
2	*.man.lodz.pl	677	109	84.1 KB	53	4	0	00:00:30
3	*.neoplus.adsl.tpnet.pl	7	4	7.3 KB	3	0	4	00:14:52
4	*.105.135.22.tvsat364.lodz.pl	9	4	10.8 KB	3	0	0	02:37:13
5	*.191.14.62.static.jazztel.es	2	0	0.0 KB	0	0	0	26:52:33
6	*.toya.net.pl	38	0	0.0 KB	0	0	0	00:00:04
TOTAL: 6		1021	417	468.8 KB	347	4	4	29:45:25

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
16.191.14.62.static.jazztel.es	35.240	53.716	26:52:33
ip-176.105.135.22.tvsat364.lodz.pl	0.016	0.136	02:37:13
dxb33.neoplus.adsl.tpnet.pl	0.044	0.120	00:14:52
web.man.lodz.pl	0.592	4.300	00:00:20
vegas.cm.p.lodz.pl	0.600	4.312	00:00:10
f-oper-v100.man.lodz.pl	0.564	4.500	00:00:07
staticline41435.toya.net.pl	0.080	0.556	00:00:04
david.man.lodz.pl	0.172	1.492	00:00:01
kujawiak.man.lodz.pl	0.004	0.020	00:00:00
TOTAL: 9	37.312	69.152	29:45:25

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	289
david.man.lodz.pl	96
staticline41435.toya.net.pl	38
16.191.14.62.static.jazztel.es	2
TOTAL: 4	425

NNRP client timeouts [Top 20]:

System	Conn	Peer
16.191.14.62.static.jazztel.es	3	2
ip-176.105.135.22.tvsat364.lodz.pl	2	0
TOTAL: 2	5	2

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	302	72.4%
2	pl	112	26.9%
3	alt	1	0.2%
4	lodz	1	0.2%
5	lodzman	1	0.2%
TOTAL: 5		417	100.0%

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

Newsgroup		Count
1	lodman.info	300
2	pl.comp.pecet	82
3	pl.comp.os.ms-windows.winnt	24
4	pl.rec.mineraly	3
5	pl.soc.dzieci	2
6	lodman.test	2
7	lodzman.test	1
8	alt.pl.misc.samochody.skoda	1
9	lodz.test	1
10	pl.regionalne.lodz	1
TOTAL: 10		417

Daily Usenet report

Nov 3 04:15:03 -- Nov 4 04:15:03