Daily Usenet report: Jul 12 04:15:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 12 14:59:53 newsfeed nnrpd[13834]: SERVER perl filter not defined
Jul 12 16:05:21 newsfeed nnrpd[16014]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2120973	98.5%	239.0 MB	98.0%
innd	18133	0.8%	3.0 MB	1.2%
innfeed	7414	0.3%	1.1 MB	0.4%
nnrpd	7170	0.3%	755.3 KB	0.3%
TOTAL: 4	2153690	100.0%	243.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2113533	94.9%
Negative hits	71645	3.2%
Positive hits	40914	1.8%
Cache misses	1668	0.1%
TOTAL: 4	2227760	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:01:15.670	0.1%	4915	0.000	15.396	554.000
article cleanup	00:00:28.358	0.0%	2115151	0.005	0.013	0.024
article logging	00:01:02.687	0.1%	2115297	0.013	0.030	0.647
article parse	01:17:07.929	5.4%	97744815	0.024	0.047	0.094
article write	00:24:47.640	1.7%	2109572	0.447	0.705	1.608
artlog/artcncl	00:00:00.077	0.0%	4891	0.000	0.016	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:08.409	0.1%	111257208	0.001	0.001	0.006
hisgrep/artcncl	00:00:15.652	0.0%	1693	0.000	9.245	240.000
hishave/artcncl	00:00:14.025	0.0%	4915	0.000	2.854	22.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:30:21.443	10.4%	2224740	0.526	4.055	12.984
history sync	00:00:00.010	0.0%	290	0.000	0.034	1.000
history write	03:44:22.872	15.6%	2111772	2.648	6.375	22.237
hiswrite/artcncl	00:00:17.529	0.0%	3222	0.000	5.440	275.000
idle	08:56:52.940	37.3%	63738405	0.251	0.505	1.383
nntp read	00:47:05.585	3.3%	96063465	0.016	0.029	0.044
overview write	00:00:12.533	0.0%	2109572	0.000	0.006	0.015
perl filter	05:39:51.977	23.6%	2111771	6.805	9.656	11.585
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:31.169	0.2%	4266775	0.014	0.049	0.075
TOTAL: 23:59:38.306	23:29:56.505	97.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.185	0.0%	51534	0.000	0.004	0.111
article prepare	00:00:00.015	0.0%	54928	0.000	0.000	0.062
article read	00:00:09.168	0.0%	12893	0.000	0.711	74.758
backlog stats	00:00:00.257	0.0%	360719	0.000	0.001	0.014
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.233	0.0%	210479	0.000	0.011	1.000
data write	00:00:06.295	0.0%	178683	0.000	0.035	1.000
idle	23:59:33.586	100.0%	360719	0.000	239.448	19095.000
status file	00:00:01.511	0.0%	242	0.000	6.244	257.500
TOTAL: 24:00:01.436	23:59:53.250	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	21:08:49.675	99.9%	225298	0.000	337.907	600038.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:09.895	0.0%	480772	0.000	0.021	0.667
readart	00:00:03.792	0.0%	769	0.000	4.931	27.053
TOTAL: 21:09:48.296	21:09:03.362	99.9%	-	-	-	-

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	860	2105731	2099577	2730	3424	99%	344:40:14
2	news.nask.pl	2	18420	6166	11484	770	33%	24:27:47
3	news.task.gda.pl	14	28522	4740	22451	1331	16%	44:49:39
4	news.icm.edu.pl	38	344	17	263	64	4%	20:12:52
5	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 5		917	2153019	2110502	36928	5589	98%	434:10:32

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	792.6 GB	16.1 MB	43.3 MB	792.6 GB	99%	395.2 KB
2	news.nask.pl	21.2 MB	1.8 MB	2.3 MB	25.3 MB	83%	3.7 KB
3	news.task.gda.pl	9.9 MB	30.3 KB	4.2 MB	14.2 MB	69%	2.4 KB
4	news.icm.edu.pl	548.1 KB	224.3 KB	3.9 MB	4.7 MB	11%	59.5 KB
5	localhost	3.0 KB	0.0 KB	0.0 KB	3.0 KB	100%	1.5 KB
TOTAL: 5		792.6 GB	18.2 MB	53.8 MB	792.7 GB	99%	392.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 12 04:15:02 - 04:59:59	65320	3.1%	24.21	24.2 GB	3.1%	9413.85
Jul 12 05:00:00 - 05:59:59	75949	3.6%	21.10	28.4 GB	3.6%	8267.76
Jul 12 06:00:00 - 06:59:59	62152	2.9%	17.26	24.6 GB	3.1%	7173.30
Jul 12 07:00:00 - 07:59:59	99378	4.7%	27.61	37.1 GB	4.7%	10804.79
Jul 12 08:00:00 - 08:59:59	82054	3.9%	22.79	31.0 GB	3.9%	9043.49
Jul 12 09:00:00 - 09:59:59	85617	4.1%	23.78	32.0 GB	4.0%	9311.73
Jul 12 10:00:00 - 10:59:59	79832	3.8%	22.18	31.7 GB	4.0%	9226.16
Jul 12 11:00:00 - 11:59:59	68424	3.2%	19.01	29.1 GB	3.7%	8471.83
Jul 12 12:00:00 - 12:59:59	62266	3.0%	17.30	25.0 GB	3.2%	7271.94
Jul 12 13:00:00 - 13:59:59	65321	3.1%	18.14	24.4 GB	3.1%	7109.02
Jul 12 14:00:00 - 14:59:59	95784	4.5%	26.61	34.2 GB	4.3%	9971.30
Jul 12 15:00:00 - 15:59:59	96760	4.6%	26.88	34.3 GB	4.3%	9992.93
Jul 12 16:00:00 - 16:59:59	81937	3.9%	22.76	31.0 GB	3.9%	9031.04
Jul 12 17:00:00 - 17:59:59	83197	3.9%	23.11	31.4 GB	4.0%	9148.92
Jul 12 18:00:00 - 18:59:59	83024	3.9%	23.06	33.5 GB	4.2%	9745.71
Jul 12 19:00:00 - 19:59:59	97099	4.6%	26.97	36.9 GB	4.7%	10741.17
Jul 12 20:00:00 - 20:59:59	93177	4.4%	25.88	36.2 GB	4.6%	10546.91
Jul 12 21:00:00 - 21:59:59	92685	4.4%	25.75	37.8 GB	4.8%	11017.37
Jul 12 22:00:00 - 22:59:59	89760	4.3%	24.93	36.0 GB	4.5%	10488.28
Jul 12 23:00:00 - 23:59:59	102021	4.8%	28.34	36.9 GB	4.7%	10756.15
Jul 13 00:00:00 - 00:59:59	87497	4.1%	24.30	31.4 GB	4.0%	9159.23
Jul 13 01:00:00 - 01:59:59	109445	5.2%	30.40	38.8 GB	4.9%	11315.13
Jul 13 02:00:00 - 02:59:59	114816	5.4%	31.89	39.3 GB	5.0%	11451.67
Jul 13 03:00:00 - 03:59:59	108992	5.2%	30.28	37.4 GB	4.7%	10902.78
Jul 13 04:00:00 - 04:15:02	27848	1.3%	30.87	9.5 GB	1.2%	11013.46
TOTAL: 24:00:00	2110355	100.0%	24.43	792.3 GB	100.0%	9615.14

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3528	185	2649	3	691
2	news.task.gda.pl	1327	1133	15	0	179
3	news.nask.pl	807	32	712	10	53
4	news.icm.edu.pl	64	0	4	0	60
TOTAL: 4		5726	1350	3380	13	983

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.ports-bugs	87
mailing.freebsd.svn-ports-all	76
uk.railway	76
mailing.freebsd.svn-ports-head	76
mailing.freebsd.svn-src-all	73
fa.freebsd.cvs-all	73
mailing.freebsd.current	58
alt.windows7.general	47
mozilla.dev.tree-management	46
mailing.freebsd.svn-src-head	45
mailing.openbsd.misc	43
mailing.freebsd.tinderbox	35
mailing.database.pgsql-general	34
gmane.linux.alsa.devel	31
it.comp.os.win.windows8	30
mailing.unix.samba-technical	29
alt.sex.telephones	29
mailing.openbsd.ports-changes	27
mozilla.dev.identity	24
mailing.unix.spamassassin-talk	23
TOTAL: 80	1350

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

Groups	Count
pl.sci.historia	11
pl.praca.oferowana	1
pl.sci.matematyka	1
TOTAL: 3	13

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	603
EMP (fsl)	140
EMP (md5)	57
Attached HTML file	18
HTML post	17
Scoring filter (12)	1
TOTAL: 6	836

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	53125	3676	43133	991	0	6%	24:01:23
2	icm	67454	1513	36579	7275	3884	2%	23:59:54
3	task	2757	71	1406	12	0	2%	22:16:32
4	poznan	13205	70	10622	43	0	0%	23:57:46
5	nask	21429	14	14987	1	0	0%	23:51:50
6	okapi	0	0	0	0	2810	0%	24:00:00
TOTAL: 6		157970	5344	106727	8322	6694	3%	142:07:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	25.9 MB	1.5 GB	1.6 GB	18.9 KB/s	185.5 KB	23:59:54
2	panorama	10.5 MB	9.6 MB	20.1 MB	0.2 KB/s	4.4 KB	24:01:23
3	poznan	278.5 KB	106.0 KB	384.5 KB	0.0 KB/s	3.4 KB	23:57:46
4	task	244.5 KB	22.1 KB	266.6 KB	0.0 KB/s	3.2 KB	22:16:32
5	nask	97.8 KB	2.0 KB	99.8 KB	0.0 KB/s	6.7 KB	23:51:50
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		37.1 MB	1.5 GB	1.6 GB	3.2 KB/s	120.8 KB	142:07:25

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	312	535.5 KB	288	0	00:00:08
2	edp69.internetdsl.tpnet.pl	3	190	183.4 KB	3	0	01:01:00
3	web.man.lodz.pl	288	114	114.8 KB	51	0	00:00:21
4	212.191.80.165	2	61	115.9 KB	3	0	01:15:46
5	lze200.lze.lodz.pl	11	41	76.4 KB	8	0	00:52:36
6	staticline-31-183-31-252.toya.net.pl	2	19	16.9 KB	2	0	00:32:39
7	212.191.196.1	2	18	43.7 KB	4	0	01:09:32
8	ebw2.neoplus.adsl.tpnet.pl	3	11	16.8 KB	2	0	00:00:37
9	ip-176.105.135.22.tvsat364.lodz.pl	1	2	3.2 KB	1	0	00:08:27
10	212.51.203.199	2	1	3.4 KB	1	0	00:01:25
11	kujawiak.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 11		604	769	1.1 MB	363	2	21:09:47

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	312	535.5 KB	288	0	00:00:08
2	*.internetdsl.tpnet.pl	8	190	183.4 KB	3	0	01:01:01
3	*.man.lodz.pl	674	114	114.8 KB	51	2	00:00:32
4	unresolved	6	80	163.0 KB	8	0	02:26:45
5	*.lze.lodz.pl	11	41	76.4 KB	8	0	00:52:36
6	*.toya.net.pl	5	19	16.9 KB	2	0	00:32:40
7	*.neoplus.adsl.tpnet.pl	3	11	16.8 KB	2	0	00:00:37
8	*.105.135.22.tvsat364.lodz.pl	1	2	3.2 KB	1	0	00:08:27
9	*.207.15.62.static.jazztel.es	1	0	0.0 KB	0	0	16:06:58
TOTAL: 9		997	769	1.1 MB	363	2	21:09:47

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
252.207.15.62.static.jazztel.es	11.325	15.245	16:06:58
212.191.80.165	3.656	2.320	01:15:46
212.191.196.1	0.004	0.036	01:09:32
edp69.internetdsl.tpnet.pl	0.052	0.060	01:01:00
lze200.lze.lodz.pl	0.048	0.152	00:52:36
staticline-31-183-31-252.toya.net.pl	0.004	0.036	00:32:39
ip-176.105.135.22.tvsat364.lodz.pl	0.004	0.012	00:08:27
212.51.203.199	0.004	0.024	00:01:25
ebw2.neoplus.adsl.tpnet.pl	0.004	0.036	00:00:37
web.man.lodz.pl	0.748	3.708	00:00:21
vegas.cm.p.lodz.pl	0.636	3.660	00:00:08
f-oper-v100.man.lodz.pl	0.668	4.020	00:00:08
david.man.lodz.pl	0.200	1.084	00:00:01
gcq193.internetdsl.tpnet.pl	0.008	0.072	00:00:00
kujawiak.man.lodz.pl	0.012	0.028	00:00:00
staticline41435.toya.net.pl	0.012	0.044	00:00:00
?	0.004	0.008	00:00:00
TOTAL: 17	17.389	30.545	21:09:47

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
gcq193.internetdsl.tpnet.pl	5
staticline41435.toya.net.pl	3
252.207.15.62.static.jazztel.es	1
TOTAL: 5	393

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
212.191.80.165	2	0
edp69.internetdsl.tpnet.pl	2	0
staticline-31-183-31-252.toya.net.pl	1	0
lze200.lze.lodz.pl	1	0
212.191.196.1	1	0
TOTAL: 5	7	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	323	42.0%
2	pl	237	30.8%
3	lodz	209	27.2%
TOTAL: 3		769	100.0%

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

Newsgroup		Count
1	lodman.info	323
2	lodz.test	207
3	pl.comp.os.ms-windows.winnt	94
4	pl.comp.pecet	58
5	pl.rec.rowery	34
6	pl.pregierz	26
7	pl.misc.paranauki	7
8	pl.regionalne.lodz	7
9	pl.sci.filozofia	3
10	pl.comp.bazy-danych	3
11	lodz.ogloszenia	2
12	pl.comp.os.linux	2
13	pl.sci.matematyka	1
14	pl.rec.radio.amatorskie	1
15	pl.rec.kuchnia	1
TOTAL: 15		769

Daily Usenet report

Jul 12 04:15:02 -- Jul 13 04:15:02