Daily Usenet report: Jun 14 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jun 14 08:27:07 newsfeed nnrpd[12891]: SERVER perl filter not defined
Jun 14 09:10:37 newsfeed nnrpd[14331]: SERVER perl filter not defined
Jun 14 11:25:59 newsfeed nnrpd[18915]: SERVER perl filter not defined
Jun 14 15:53:35 newsfeed nnrpd[27840]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1644329	98.1%	194.4 MB	97.7%
innd	14869	0.9%	2.5 MB	1.2%
nnrpd	9518	0.6%	1.0 MB	0.5%
innfeed	7297	0.4%	1.1 MB	0.5%
TOTAL: 4	1676013	100.0%	199.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1638615	95.8%
Negative hits	35671	2.1%
Positive hits	35379	2.1%
Cache misses	300	0.0%
TOTAL: 4	1709965	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:06.179	0.0%	411	0.000	15.034	347.000
article cleanup	00:00:17.937	0.0%	1642863	0.000	0.011	0.026
article logging	00:00:42.635	0.0%	1642998	0.011	0.026	0.364
article parse	00:35:39.836	2.5%	240150937	0.004	0.009	0.030
article write	00:09:51.099	0.7%	1638001	0.188	0.361	1.252
artlog/artcncl	00:00:00.005	0.0%	306	0.000	0.016	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:02:40.090	0.2%	251415375	0.000	0.001	0.043
hisgrep/artcncl	00:00:00.814	0.0%	296	0.000	2.750	17.167
hishave/artcncl	00:00:00.486	0.0%	411	0.000	1.182	21.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:41:21.924	7.0%	1710980	0.006	3.555	11.301
history sync	00:00:00.011	0.0%	292	0.000	0.038	1.000
history write	03:16:47.298	13.7%	1639394	0.533	7.202	32.283
hiswrite/artcncl	00:00:00.776	0.0%	115	0.000	6.748	75.000
idle	14:10:30.439	59.1%	199544961	0.126	0.256	1.150
nntp read	00:41:32.069	2.9%	239001208	0.006	0.010	0.020
overview write	00:00:07.856	0.0%	1638001	0.000	0.005	0.014
perl filter	02:33:58.669	10.7%	1639391	3.646	5.635	10.153
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:48.215	0.2%	3306426	0.031	0.051	0.108
TOTAL: 23:59:28.246	23:16:26.338	97.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.077	0.0%	30444	0.000	0.003	0.167
article prepare	00:00:00.005	0.0%	22224	0.000	0.000	0.250
article read	00:00:02.826	0.0%	5242	0.000	0.539	81.517
backlog stats	00:00:00.172	0.0%	276907	0.000	0.001	0.029
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.192	0.0%	150429	0.000	0.008	1.000
data write	00:00:03.224	0.0%	139225	0.000	0.023	0.333
idle	23:59:33.331	100.0%	276907	0.000	311.922	16080.000
status file	00:00:00.996	0.0%	236	0.000	4.220	141.000
TOTAL: 23:59:46.684	23:59:41.823	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:58:38.970	99.2%	6687	0.000	526.240	360818.200
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.284	0.0%	15660	0.000	0.018	0.789
readart	00:00:00.674	0.0%	381	0.000	1.769	34.538
TOTAL: 00:59:07.736	00:58:39.928	99.2%	-	-	-	-

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	651	1634105	1630428	320	3357	99%	222:42:53
2	news.task.gda.pl	24	24837	4471	19383	983	18%	46:03:16
3	news.nask.pl	2	16975	3901	12524	550	22%	23:54:20
4	localhost	5	4	4	0	0	100%	00:00:00
5	news.icm.edu.pl	48	199	3	174	22	1%	15:42:06
TOTAL: 5		730	1676120	1638807	32401	4912	97%	308:22:35

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	475.3 GB	11.0 MB	14.9 MB	475.3 GB	99%	305.0 KB
2	news.nask.pl	13.6 MB	1.3 MB	1.5 MB	16.4 MB	83%	3.8 KB
3	news.task.gda.pl	8.9 MB	42.9 KB	2.4 MB	11.3 MB	78%	2.1 KB
4	news.icm.edu.pl	46.5 KB	9.5 KB	1.3 MB	1.4 MB	3%	56.1 KB
5	localhost	6.6 KB	0.0 KB	0.0 KB	6.6 KB	100%	1.7 KB
TOTAL: 5		475.3 GB	12.4 MB	20.1 MB	475.3 GB	99%	303.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 14 04:15:02 - 04:59:59	52167	3.2%	19.34	20.1 GB	4.2%	7821.99
Jun 14 05:00:00 - 05:59:59	69696	4.3%	19.36	27.0 GB	5.7%	7856.46
Jun 14 06:00:00 - 06:59:59	56857	3.5%	15.79	21.9 GB	4.6%	6371.11
Jun 14 07:00:00 - 07:59:59	70277	4.3%	19.52	27.6 GB	5.8%	8049.60
Jun 14 08:00:00 - 08:59:59	41126	2.5%	11.42	16.6 GB	3.5%	4826.05
Jun 14 09:00:00 - 09:59:59	36266	2.2%	10.07	14.1 GB	3.0%	4098.61
Jun 14 10:00:00 - 10:59:59	39397	2.4%	10.94	15.3 GB	3.2%	4452.72
Jun 14 11:00:00 - 11:59:59	49361	3.0%	13.71	15.8 GB	3.3%	4611.13
Jun 14 12:00:00 - 12:59:59	73214	4.5%	20.34	19.0 GB	4.0%	5531.90
Jun 14 13:00:00 - 13:59:59	46833	2.9%	13.01	16.3 GB	3.4%	4734.18
Jun 14 14:00:00 - 14:59:59	58352	3.6%	16.21	17.4 GB	3.7%	5071.85
Jun 14 15:00:00 - 15:59:59	84349	5.1%	23.43	21.2 GB	4.4%	6160.81
Jun 14 16:00:00 - 16:59:59	82056	5.0%	22.79	20.1 GB	4.2%	5842.30
Jun 14 17:00:00 - 17:59:59	83139	5.1%	23.09	19.9 GB	4.2%	5802.47
Jun 14 18:00:00 - 18:59:59	79824	4.9%	22.17	17.5 GB	3.7%	5108.20
Jun 14 19:00:00 - 19:59:59	67135	4.1%	18.65	15.4 GB	3.2%	4489.54
Jun 14 20:00:00 - 20:59:59	89782	5.5%	24.94	23.1 GB	4.9%	6736.83
Jun 14 21:00:00 - 21:59:59	68977	4.2%	19.16	13.9 GB	2.9%	4050.47
Jun 14 22:00:00 - 22:59:59	67729	4.1%	18.81	14.5 GB	3.0%	4229.86
Jun 14 23:00:00 - 23:59:59	53301	3.3%	14.81	17.6 GB	3.7%	5114.49
Jun 15 00:00:00 - 00:59:59	58842	3.6%	16.34	18.8 GB	3.9%	5477.47
Jun 15 01:00:00 - 01:59:59	74527	4.5%	20.70	23.3 GB	4.9%	6786.13
Jun 15 02:00:00 - 02:59:59	110672	6.8%	30.74	28.5 GB	6.0%	8286.91
Jun 15 03:00:00 - 03:59:59	97992	6.0%	27.22	24.7 GB	5.2%	7193.55
Jun 15 04:00:00 - 04:15:01	27150	1.7%	30.13	6.8 GB	1.4%	7946.57
TOTAL: 23:59:59	1639021	100.0%	18.97	476.3 GB	100.0%	5780.63

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.pionier.net.pl	3473	160	3034	279
2	news.task.gda.pl	946	584	30	332
3	news.nask.pl	561	9	409	143
4	news.icm.edu.pl	22	0	1	21
TOTAL: 4		5002	753	3474	775

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	85
mailing.freebsd.svn-ports-head	84
uk.railway	69
alt.windows7.general	44
mailing.freebsd.ports-bugs	41
it.tlc.cellulari.android	38
mailing.openbsd.misc	23
mailing.freebsd.current	21
fr.usenet.abus.nocem	20
alt.politics.scorched-earth	16
mailing.freebsd.svn-src-all	16
fa.freebsd.cvs-all	16
mailing.gcc.gcc-cvs	14
mailing.freebsd.ports	14
mailing.openbsd.source-changes	14
mailing.openbsd.ports-changes	13
mailing.postfix.users	13
24hoursupport.helpdesk	13
mailing.freebsd.svn-src-head	12
comp.sys.raspberry-pi	12
TOTAL: 70	753

INND Perl filter [Top 20]:

Reason	Count
EMP (fsl)	437
Binary in non-binary group	135
EMP (md5)	33
Attached HTML file	24
EMP (phl)	7
HTML post	1
TOTAL: 6	637

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	37262	1908	28247	289	0	0	5%	24:00:40
2	icm	52682	1444	27618	1150	4	11	2%	23:59:59
3	nask	22942	253	13543	332	0	0	1%	23:53:18
4	task	1597	112	766	10	0	1	7%	21:34:35
5	poznan	10254	30	8338	14	0	0	0%	24:06:05
6	okapi	0	0	0	0	0	1669	0%	24:00:01
TOTAL: 6		124737	3747	78512	1795	4	1681	3%	141:34:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	122.0 MB	87.1 MB	209.1 MB	2.5 KB/s	82.5 KB	23:59:59
2	panorama	8.0 MB	902.5 KB	8.9 MB	0.1 KB/s	4.1 KB	24:00:40
3	nask	1014.2 KB	187.5 MB	188.5 MB	2.2 KB/s	329.9 KB	23:53:18
4	task	296.7 KB	12.7 KB	309.5 KB	0.0 KB/s	2.5 KB	21:34:35
5	poznan	100.1 KB	51.7 KB	151.8 KB	0.0 KB/s	3.4 KB	24:06:05
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 6		131.4 MB	275.5 MB	406.9 MB	0.8 KB/s	75.2 KB	141:34:38

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	336	591.7 KB	288	0	00:00:09
2	web.man.lodz.pl	288	38	30.9 KB	19	0	00:00:18
3	194.33.77.50	2	6	9.1 KB	1	0	00:01:19
4	pc-vicki.man.lodz.pl	1	1	2.5 KB	1	0	00:30:04
5	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:01
TOTAL: 5		583	381	634.2 KB	309	4	00:59:05

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	336	591.7 KB	288	0	00:00:09
2	*.man.lodz.pl	677	39	33.4 KB	20	4	00:30:28
3	unresolved	2	6	9.1 KB	1	0	00:01:19
4	*.pa.nsw.optusnet.com.au	677	0	0.0 KB	0	0	00:27:08
TOTAL: 4		1644	381	634.2 KB	309	4	00:59:05

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-vicki.man.lodz.pl	0.004	0.012	00:30:04
pa49-181-246-63.pa.nsw.optusnet.com.au	0.872	3.960	00:27:08
194.33.77.50	0.004	0.008	00:01:19
web.man.lodz.pl	0.516	2.644	00:00:18
pc-skrzep2.cm.p.lodz.pl	0.348	2.316	00:00:09
mon.man.lodz.pl	0.384	2.080	00:00:03
isvcs01.man.lodz.pl	0.012	0.056	00:00:01
david.man.lodz.pl	0.164	0.640	00:00:01
TOTAL: 8	2.304	11.716	00:59:05

Curious NNRP server explorers [Top 20]:

System	Conn
pa49-181-246-63.pa.nsw.optusnet.com.au	677
mon.man.lodz.pl	288
david.man.lodz.pl	96
TOTAL: 3	1061

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-vicki.man.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	342	89.8%
2	pl	39	10.2%
TOTAL: 2		381	100.0%

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

Newsgroup		Count
1	lodman.info	342
2	pl.comp.pecet	20
3	pl.comp.os.ms-windows.winnt	18
4	pl.sci.medycyna	1
TOTAL: 4		381

Daily Usenet report

Jun 14 04:15:02 -- Jun 15 04:15:01