Daily Usenet report: Jul 5 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jul 5 14:17:49 newsfeed nnrpd[23327]: SERVER perl filter not defined
Jul 5 17:51:13 newsfeed nnrpd[30192]: SERVER perl filter not defined
Jul 5 21:43:03 newsfeed nnrpd[5139]: SERVER perl filter not defined
Jul 5 22:27:58 newsfeed nnrpd[6497]: SERVER perl filter not defined
Jul 5 22:35:22 newsfeed nnrpd[6803]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1703126	98.2%	192.5 MB	97.7%
innd	14804	0.9%	2.5 MB	1.3%
nnrpd	9032	0.5%	952.6 KB	0.5%
innfeed	7181	0.4%	1.1 MB	0.6%
controlchan	2	0.0%	0.4 KB	0.0%
TOTAL: 5	1734145	100.0%	196.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1696977	95.3%
Negative hits	44121	2.5%
Positive hits	38933	2.2%
Cache misses	1505	0.1%
TOTAL: 4	1781536	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:13.895	0.0%	559	0.000	24.857	511.000
article cleanup	00:00:21.973	0.0%	1703609	0.002	0.013	0.029
article logging	00:00:50.172	0.1%	1703791	0.003	0.029	0.952
article parse	00:51:34.545	3.6%	66923320	0.020	0.046	0.089
article write	00:18:04.826	1.3%	1697214	0.328	0.639	2.478
artlog/artcncl	00:00:00.003	0.0%	550	0.000	0.005	0.077
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:01:34.046	0.1%	76906124	0.000	0.001	0.004
hisgrep/artcncl	00:00:04.777	0.0%	475	0.000	10.057	289.000
hishave/artcncl	00:00:01.476	0.0%	559	0.000	2.640	86.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:56:22.688	12.2%	1783534	0.930	5.934	14.752
history sync	00:00:00.011	0.0%	292	0.000	0.038	1.000
history write	03:58:02.737	16.5%	1699266	0.320	8.405	27.850
hiswrite/artcncl	00:00:01.296	0.0%	84	0.000	15.429	327.000
idle	10:47:23.973	44.9%	46808873	0.149	0.830	2.306
nntp read	00:32:02.113	2.2%	65644204	0.017	0.029	0.042
overview write	00:00:10.419	0.0%	1697214	0.000	0.006	0.018
perl filter	04:04:47.877	17.0%	1699265	5.962	8.644	10.451
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:54.650	0.2%	3440193	0.027	0.051	0.084
TOTAL: 24:00:43.329	23:34:31.477	98.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.195	0.0%	46435	0.000	0.004	0.100
article prepare	00:00:00.025	0.0%	69754	0.000	0.000	0.042
article read	00:00:46.010	0.1%	17136	0.000	2.685	93.900
backlog stats	00:00:00.251	0.0%	362473	0.000	0.001	0.018
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:02.056	0.0%	206206	0.000	0.010	0.087
data write	00:00:07.369	0.0%	183779	0.000	0.040	0.180
idle	23:59:06.364	99.9%	362473	0.000	238.215	22164.000
status file	00:00:00.825	0.0%	254	0.000	3.248	80.667
TOTAL: 24:00:10.235	24:00:03.095	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:51.794	0.0%	237679	0.218	0.218	0.218
idle	54:56:46.074	99.9%	687893	0.000	287.554	600065.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:20.742	0.0%	1378127	0.000	0.015	0.667
readart	00:00:56.504	0.0%	238139	0.000	0.237	198.000
TOTAL: 54:59:56.130	54:58:55.114	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
control@grisbi.org	0	0	1	0	0	1
TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	545	1691727	1686965	672	4090	99%	288:25:14
2	news.task.gda.pl	16	29052	4844	22937	1271	16%	45:56:35
3	news.nask.pl	2	17450	4623	11802	1025	26%	23:50:29
4	news.icm.edu.pl	43	309	17	282	10	5%	18:39:32
5	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 5		612	1738543	1696454	35693	6396	97%	376:51:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	545.6 GB	20.2 MB	35.0 MB	545.7 GB	99%	338.4 KB
2	news.nask.pl	21.9 MB	2.8 MB	3.4 MB	28.1 MB	77%	5.1 KB
3	news.task.gda.pl	10.2 MB	49.0 KB	3.8 MB	14.0 MB	72%	2.3 KB
4	news.icm.edu.pl	1.5 MB	0.0 KB	383.7 KB	1.8 MB	79%	69.3 KB
5	localhost	6.9 KB	0.0 KB	0.0 KB	6.9 KB	100%	1.4 KB
TOTAL: 5		545.6 GB	23.1 MB	42.6 MB	545.7 GB	99%	336.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 5 04:15:03 - 04:59:59	68759	4.1%	25.49	21.9 GB	4.0%	8525.04
Jul 5 05:00:00 - 05:59:59	101707	6.0%	28.25	33.3 GB	6.1%	9699.51
Jul 5 06:00:00 - 06:59:59	120349	7.1%	33.43	35.3 GB	6.5%	10274.60
Jul 5 07:00:00 - 07:59:59	104401	6.2%	29.00	32.6 GB	6.0%	9503.16
Jul 5 08:00:00 - 08:59:59	87919	5.2%	24.42	32.4 GB	5.9%	9428.17
Jul 5 09:00:00 - 09:59:59	77743	4.6%	21.60	23.8 GB	4.4%	6926.33
Jul 5 10:00:00 - 10:59:59	61075	3.6%	16.97	17.8 GB	3.3%	5173.22
Jul 5 11:00:00 - 11:59:59	46920	2.8%	13.03	16.3 GB	3.0%	4744.39
Jul 5 12:00:00 - 12:59:59	51277	3.0%	14.24	18.3 GB	3.4%	5340.61
Jul 5 13:00:00 - 13:59:59	41862	2.5%	11.63	16.1 GB	3.0%	4702.72
Jul 5 14:00:00 - 14:59:59	49267	2.9%	13.69	17.7 GB	3.2%	5153.16
Jul 5 15:00:00 - 15:59:59	42372	2.5%	11.77	13.7 GB	2.5%	3977.81
Jul 5 16:00:00 - 16:59:59	48620	2.9%	13.51	15.4 GB	2.8%	4472.39
Jul 5 17:00:00 - 17:59:59	79568	4.7%	22.10	20.5 GB	3.8%	5975.22
Jul 5 18:00:00 - 18:59:59	53329	3.1%	14.81	17.1 GB	3.1%	4974.88
Jul 5 19:00:00 - 19:59:59	49446	2.9%	13.73	18.5 GB	3.4%	5392.61
Jul 5 20:00:00 - 20:59:59	44542	2.6%	12.37	16.4 GB	3.0%	4763.83
Jul 5 21:00:00 - 21:59:59	42865	2.5%	11.91	15.5 GB	2.8%	4518.47
Jul 5 22:00:00 - 22:59:59	42142	2.5%	11.71	14.8 GB	2.7%	4309.95
Jul 5 23:00:00 - 23:59:59	42477	2.5%	11.80	15.0 GB	2.7%	4359.02
Jul 6 00:00:00 - 00:59:59	88168	5.2%	24.49	26.8 GB	4.9%	7806.35
Jul 6 01:00:00 - 01:59:59	127444	7.5%	35.40	36.4 GB	6.7%	10593.43
Jul 6 02:00:00 - 02:59:59	109146	6.4%	30.32	34.0 GB	6.2%	9914.65
Jul 6 03:00:00 - 03:59:59	86007	5.1%	23.89	27.5 GB	5.0%	8003.25
Jul 6 04:00:00 - 04:15:03	28595	1.7%	31.67	8.7 GB	1.6%	10069.11
TOTAL: 24:00:00	1696000	100.0%	19.63	545.6 GB	100.0%	6621.67

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4226	179	3401	4	642
2	news.task.gda.pl	1270	1057	28	1	184
3	news.nask.pl	1070	102	913	5	50
4	news.icm.edu.pl	10	0	0	0	10
TOTAL: 4		6576	1338	4342	10	886

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.freebsd.cvs-all	104
mailing.freebsd.svn-src-all	103
mailing.freebsd.ports-bugs	102
alt.sex.telephones	88
uk.railway	69
mailing.freebsd.svn-ports-all	65
mailing.freebsd.svn-ports-head	64
mailing.freebsd.svn-src-head	56
mailing.openbsd.misc	54
gmane.linux.alsa.devel	51
mailing.openbsd.source-changes	44
mailing.gcc.gcc-cvs	42
mailing.openbsd.ports-changes	40
mailing.database.pgsql-general	30
mailing.freebsd.perl	28
it.comp.os.win.windows8	25
alt.politics.scorched-earth	24
mailing.postfix.users	23
it.tlc.cellulari.android	23
uk.rec.cycling.moderated	22
TOTAL: 86	1338

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

Groups	Count
pl.sci.historia	9
christnet.theology	1
TOTAL: 2	10

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	459
EMP (fsl)	165
Attached HTML file	50
HTML post	15
EMP (md5)	11
Scoring filter (9)	2
Scoring filter (12)	1
TOTAL: 7	703

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	50100	2615	42396	1021	0	0	5%	24:03:23
2	icm	66054	2061	30909	11442	1	706	3%	23:57:49
3	task	2477	130	1243	10	0	0	5%	21:17:43
4	poznan	11147	32	9319	11	0	0	0%	24:00:22
5	nask	21048	19	13781	0	0	0	0%	23:56:58
6	okapi	0	0	0	0	0	2584	0%	24:00:01
TOTAL: 6		150826	4857	97648	12484	1	3290	3%	141:16:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	23.1 MB	2.4 GB	2.4 GB	29.5 KB/s	188.8 KB	23:57:49
2	panorama	9.1 MB	15.2 MB	24.3 MB	0.3 KB/s	6.8 KB	24:03:23
3	task	273.4 KB	20.3 KB	293.6 KB	0.0 KB/s	2.1 KB	21:17:43
4	poznan	108.7 KB	24.9 KB	133.6 KB	0.0 KB/s	3.1 KB	24:00:22
5	nask	35.7 KB	0.0 KB	35.7 KB	0.0 KB/s	1.9 KB	23:56:58
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 6		32.7 MB	2.4 GB	2.5 GB	5.1 KB/s	148.5 KB	141:16:16

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	348	503.2 KB	288	0	00:00:09
2	212.191.78.190	194	129	226.7 KB	21	0	30:26:46
3	web.man.lodz.pl	288	46	58.5 KB	23	0	00:00:20
4	212.191.196.1	2	43	97.9 KB	3	0	01:10:05
5	router2.cbmm.lodz.pl	2	4	7.6 KB	1	0	00:14:45
6	kujawiak.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 6		779	570	893.9 KB	336	5	54:59:55

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	348	503.2 KB	288	0	00:00:09
2	unresolved	196	172	324.6 KB	24	0	31:36:51
3	*.man.lodz.pl	676	46	58.5 KB	23	5	00:00:30
4	*.cbmm.lodz.pl	2	4	7.6 KB	1	0	00:14:45
5	*.191.14.62.static.jazztel.es	3	0	0.0 KB	0	0	23:07:12
6	*.lsanca.dsl-w.verizon.net	4	0	0.0 KB	0	0	00:00:04
7	*.internetdsl.tpnet.pl	4	0	0.0 KB	0	0	00:00:00
8	*.toya.net.pl	51	0	0.0 KB	0	0	00:00:21
TOTAL: 8		1224	570	893.9 KB	336	5	54:59:55

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.564	3.176	30:26:46
171.191.14.62.static.jazztel.es	40.415	105.902	23:07:12
212.191.196.1	0.012	0.048	01:10:05
router2.cbmm.lodz.pl	0.004	0.044	00:14:45
staticline41435.toya.net.pl	0.128	0.904	00:00:21
web.man.lodz.pl	0.708	4.844	00:00:20
vegas.cm.p.lodz.pl	0.752	5.032	00:00:09
f-oper-v100.man.lodz.pl	0.648	5.352	00:00:07
pool-71-105-105-145.lsanca.dsl-w.verizon.net	0.064	0.080	00:00:04
david.man.lodz.pl	0.248	1.532	00:00:01
gcq193.internetdsl.tpnet.pl	0.016	0.068	00:00:00
kujawiak.man.lodz.pl	0.032	0.096	00:00:00
TOTAL: 12	43.591	127.078	54:59:55

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	95
staticline41435.toya.net.pl	51
pool-71-105-105-145.lsanca.dsl-w.verizon.net	4
gcq193.internetdsl.tpnet.pl	4
171.191.14.62.static.jazztel.es	3
TOTAL: 6	445

NNRP client timeouts [Top 20]:

System	Conn	Peer
171.191.14.62.static.jazztel.es	1	1
212.191.196.1	1	0
TOTAL: 2	2	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	348	61.1%
2	pl	222	38.9%
TOTAL: 2		570	100.0%

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

Newsgroup		Count
1	lodman.info	348
2	pl.rec.rowery	45
3	pl.misc.kolej	34
4	pl.misc.paranauki	34
5	pl.comp.pecet	24
6	pl.comp.os.ms-windows.winnt	22
7	pl.regionalne.lodz	18
8	pl.soc.prawo	17
9	pl.regionalne.warszawa	16
10	pl.comp.os.linux	5
11	pl.rec.gory	4
12	pl.listserv.chomor-l	2
13	pl.praca.dyskusje	1
TOTAL: 13		570

Daily Usenet report

Jul 5 04:15:03 -- Jul 6 04:15:03