Daily Usenet report: Jan 12 04:15:05

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jan 12 09:01:40 newsfeed nnrpd[28181]: SERVER perl filter not defined
Jan 12 11:23:44 newsfeed nnrpd[32757]: SERVER perl filter not defined
Jan 12 11:25:37 newsfeed nnrpd[503]: SERVER perl filter not defined
Jan 12 12:21:49 newsfeed nnrpd[2276]: SERVER perl filter not defined
Jan 12 14:48:53 newsfeed nnrpd[7073]: SERVER perl filter not defined
Jan 12 18:19:09 newsfeed nnrpd[13954]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2162251	98.5%	257.7 MB	98.1%
innd	17479	0.8%	2.9 MB	1.1%
nnrpd	8924	0.4%	935.2 KB	0.3%
innfeed	7082	0.3%	1.0 MB	0.4%
TOTAL: 4	2195736	100.0%	262.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2146707	93.8%
Negative hits	93338	4.1%
Positive hits	36178	1.6%
Cache misses	12465	0.5%
TOTAL: 4	2288688	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.869	0.0%	309	0.000	31.939	1202.000
article cleanup	00:00:30.963	0.0%	2161740	0.003	0.014	0.025
article logging	00:01:04.139	0.1%	2161886	0.014	0.030	0.323
article parse	01:04:25.827	4.5%	121046942	0.010	0.032	0.083
article write	00:16:11.241	1.1%	2146199	0.230	0.453	1.324
artlog/artcncl	00:00:00.007	0.0%	295	0.000	0.024	1.000
artlog/artparse	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:03:44.369	0.3%	133210246	0.000	0.002	0.034
hisgrep/artcncl	00:00:01.448	0.0%	293	0.000	4.942	251.000
hishave/artcncl	00:00:00.639	0.0%	309	0.000	2.068	37.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:46:49.395	11.6%	2289729	0.016	4.371	29.004
history sync	00:00:00.007	0.0%	292	0.000	0.024	1.000
history write	04:46:35.166	19.9%	2147730	0.127	8.006	31.938
hiswrite/artcncl	00:00:00.182	0.0%	16	0.000	11.375	28.000
idle	08:47:37.565	36.6%	77938230	0.193	0.406	5.315
nntp read	00:51:48.656	3.6%	119343391	0.010	0.026	0.047
overview write	00:00:14.284	0.0%	2146199	0.000	0.007	0.188
perl filter	04:36:34.463	19.2%	2147726	4.920	7.727	9.858
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:50.669	0.3%	4331104	0.006	0.067	0.187
TOTAL: 23:59:57.756	23:20:38.889	97.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.133	0.0%	38708	0.000	0.003	0.200
article prepare	00:00:00.011	0.0%	33822	0.000	0.000	0.050
article read	00:00:03.957	0.0%	8289	0.000	0.477	99.500
backlog stats	00:00:00.213	0.0%	287343	0.000	0.001	0.021
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.949	0.0%	168309	0.000	0.012	0.095
data write	00:00:05.353	0.0%	145352	0.000	0.037	1.000
idle	23:59:39.062	100.0%	287343	0.000	300.613	30100.000
status file	00:00:01.276	0.0%	232	0.000	5.500	147.500
TOTAL: 23:59:59.483	23:59:51.954	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.963	0.0%	6791	0.129	0.142	2.220
idle	61:10:58.144	99.9%	55800	0.000	3947.279	601277.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.289	0.0%	113548	0.000	0.020	7.111
readart	00:00:04.167	0.0%	7067	0.000	0.590	24.000
TOTAL: 61:13:15.756	61:11:05.563	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	655	2151305	2132626	5446	13233	99%	370:41:04
2	news.task.gda.pl	15	28280	7888	19506	886	27%	45:11:03
3	news.nask.pl	2	15617	5726	8557	1334	36%	23:44:09
4	localhost	7	6	6	0	0	100%	00:00:00
5	news.icm.edu.pl	42	323	2	247	74	0%	17:27:42
TOTAL: 5		721	2195531	2146248	33756	15527	97%	457:03:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	552.6 GB	1.2 GB	1.3 GB	555.1 GB	99%	271.2 KB
2	news.nask.pl	20.4 MB	3.4 MB	3.4 MB	27.2 MB	74%	3.9 KB
3	news.task.gda.pl	14.8 MB	59.1 KB	2.3 MB	17.1 MB	86%	2.0 KB
4	news.icm.edu.pl	25.1 KB	0.0 KB	2.9 MB	2.9 MB	0%	38.9 KB
5	localhost	12.7 KB	0.0 KB	0.0 KB	12.7 KB	100%	2.1 KB
TOTAL: 5		552.6 GB	1.2 GB	1.3 GB	555.1 GB	99%	269.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 12 04:15:05 - 04:59:59	74499	3.5%	27.64	18.9 GB	3.4%	7347.44
Jan 12 05:00:00 - 05:59:59	109589	5.1%	30.44	27.8 GB	5.0%	8111.54
Jan 12 06:00:00 - 06:59:59	107508	5.0%	29.86	28.1 GB	5.1%	8187.75
Jan 12 07:00:00 - 07:59:59	97611	4.5%	27.11	26.5 GB	4.8%	7717.96
Jan 12 08:00:00 - 08:59:59	92043	4.3%	25.57	23.3 GB	4.2%	6780.90
Jan 12 09:00:00 - 09:59:59	97847	4.6%	27.18	25.3 GB	4.6%	7357.33
Jan 12 10:00:00 - 10:59:59	90520	4.2%	25.14	23.1 GB	4.2%	6730.00
Jan 12 11:00:00 - 11:59:59	72217	3.4%	20.06	16.5 GB	3.0%	4817.62
Jan 12 12:00:00 - 12:59:59	63909	3.0%	17.75	13.8 GB	2.5%	4016.21
Jan 12 13:00:00 - 13:59:59	70242	3.3%	19.51	15.9 GB	2.9%	4620.21
Jan 12 14:00:00 - 14:59:59	71772	3.3%	19.94	16.4 GB	3.0%	4789.03
Jan 12 15:00:00 - 15:59:59	71185	3.3%	19.77	16.7 GB	3.0%	4866.71
Jan 12 16:00:00 - 16:59:59	74813	3.5%	20.78	18.3 GB	3.3%	5326.24
Jan 12 17:00:00 - 17:59:59	71093	3.3%	19.75	19.1 GB	3.5%	5573.09
Jan 12 18:00:00 - 18:59:59	77723	3.6%	21.59	21.4 GB	3.9%	6225.35
Jan 12 19:00:00 - 19:59:59	80599	3.8%	22.39	19.9 GB	3.6%	5798.03
Jan 12 20:00:00 - 20:59:59	102561	4.8%	28.49	27.4 GB	5.0%	7981.27
Jan 12 21:00:00 - 21:59:59	96786	4.5%	26.89	25.4 GB	4.6%	7389.10
Jan 12 22:00:00 - 22:59:59	103445	4.8%	28.73	28.0 GB	5.1%	8149.47
Jan 12 23:00:00 - 23:59:59	76795	3.6%	21.33	19.7 GB	3.6%	5734.25
Jan 13 00:00:00 - 00:59:59	93159	4.3%	25.88	24.8 GB	4.5%	7231.15
Jan 13 01:00:00 - 01:59:59	93512	4.4%	25.98	27.0 GB	4.9%	7853.64
Jan 13 02:00:00 - 02:59:59	126326	5.9%	35.09	34.5 GB	6.3%	10059.44
Jan 13 03:00:00 - 03:59:59	103658	4.8%	28.79	27.4 GB	5.0%	7978.50
Jan 13 04:00:00 - 04:15:03	26852	1.3%	29.74	7.4 GB	1.3%	8548.60
TOTAL: 23:59:58	2146264	100.0%	24.84	552.5 GB	100.0%	6705.96

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	13340	157	12660	1	522
2	news.nask.pl	1370	9	1323	2	36
3	news.task.gda.pl	907	648	32	1	226
4	news.icm.edu.pl	75	0	0	0	75
TOTAL: 4		15692	814	14015	4	859

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	93
mailing.freebsd.svn-ports-head	93
uk.railway	76
mailing.freebsd.ports-bugs	68
mailing.openbsd.source-changes	33
alt.windows7.general	23
24hoursupport.helpdesk	23
mailing.freebsd.svn-src-all	22
fa.freebsd.cvs-all	22
gnu.hurd.bug	20
alt.politics.scorched-earth	20
it.tlc.cellulari.android	18
mailing.openbsd.ports-changes	15
gmane.comp.gis.openstreetmap	14
it.comp.os.win.windows8	14
mailing.freebsd.ports	12
mailing.freebsd.svn-src-head	12
comp.sys.raspberry-pi	12
mailing.unix.samba-technical	11
fr.usenet.abus.nocem	11
TOTAL: 71	814

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

Groups	Count
pl.sci.historia	3
fr.comp.securite	1
TOTAL: 2	4

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	281
EMP (fsl)	207
Attached HTML file	143
EMP (md5)	73
Scoring filter (8)	4
HTML post	1
TOTAL: 6	709

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	57914	4209	32231	1413	1	0	7%	23:58:25
2	panorama	40314	2227	35931	445	0	0	5%	23:51:29
3	poznan	15904	81	13466	38	0	0	0%	23:52:33
4	task	2290	5	1254	3	0	1	0%	21:54:56
5	nask	15798	3	10875	1	0	0	0%	24:00:27
6	okapi	0	0	0	0	0	2180	0%	24:00:03
TOTAL: 6		132220	6525	93757	1900	1	2181	4%	141:37:53

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	648.7 MB	159.8 MB	808.5 MB	9.6 KB/s	147.3 KB	23:58:25
2	panorama	7.7 MB	1.5 MB	9.1 MB	0.1 KB/s	3.5 KB	23:51:29
3	poznan	224.6 KB	54.7 KB	279.4 KB	0.0 KB/s	2.3 KB	23:52:33
4	task	11.7 KB	4.3 KB	16.0 KB	0.0 KB/s	2.0 KB	21:54:56
5	nask	11.2 KB	1.0 KB	12.2 KB	0.0 KB/s	3.0 KB	24:00:27
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 6		656.6 MB	161.3 MB	817.9 MB	1.6 KB/s	99.4 KB	141:37:53

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	360	729.2 KB	288	0	00:00:39
2	web.man.lodz.pl	288	78	75.2 KB	36	0	00:00:39
3	212.191.78.190	126	5	8.5 KB	5	0	20:19:05
4	ip-176.105.135.22.tvsat364.lodz.pl	9	2	2.7 KB	2	0	01:57:41
5	kujawiak.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 5		717	445	815.7 KB	331	6	61:13:13

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	360	729.2 KB	288	0	00:00:39
2	*.man.lodz.pl	678	78	75.2 KB	36	6	00:00:47
3	unresolved	173	5	8.5 KB	5	0	32:08:56
4	*.105.135.22.tvsat364.lodz.pl	9	2	2.7 KB	2	0	01:57:41
5	*.wroclaw.mm.pl	38	0	0.0 KB	0	0	05:20:45
6	*.191.14.62.static.jazztel.es	6	0	0.0 KB	0	0	00:06:38
7	*.181.14.62.static.jazztel.es	18	0	0.0 KB	0	0	21:37:31
8	*.toya.net.pl	48	0	0.0 KB	0	0	00:00:14
TOTAL: 8		1258	445	815.7 KB	331	6	61:13:13

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
117.181.14.62.static.jazztel.es	2.960	6.268	21:37:31
212.191.78.190	0.316	1.376	20:19:05
37.190.189.79	0.096	0.452	11:19:50
host-89-231-50-15.wroclaw.mm.pl	0.104	0.368	05:20:45
ip-176.105.135.22.tvsat364.lodz.pl	0.028	0.084	01:57:41
83.238.117.139	0.000	0.012	00:30:00
202.191.14.62.static.jazztel.es	0.060	0.120	00:06:38
web.man.lodz.pl	0.744	3.012	00:00:39
vegas.cm.p.lodz.pl	0.540	3.448	00:00:39
staticline41435.toya.net.pl	0.088	0.536	00:00:14
mon.man.lodz.pl	0.568	3.136	00:00:05
david.man.lodz.pl	0.212	1.052	00:00:01
kujawiak.man.lodz.pl	0.040	0.060	00:00:00
TOTAL: 13	5.756	19.924	61:13:13

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	48
37.190.189.79	46
host-89-231-50-15.wroclaw.mm.pl	38
117.181.14.62.static.jazztel.es	18
202.191.14.62.static.jazztel.es	6
83.238.117.139	1
TOTAL: 8	541

NNRP client timeouts [Top 20]:

System	Conn	Peer
37.190.189.79	12	0
117.181.14.62.static.jazztel.es	2	1
83.238.117.139	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 4	16	4

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	360	80.9%
2	pl	85	19.1%
TOTAL: 2		445	100.0%

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

Newsgroup		Count
1	lodman.info	360
2	pl.comp.os.ms-windows.winnt	60
3	pl.comp.pecet	18
4	pl.comp.os.linux	4
5	pl.soc.dzieci	1
6	pl.soc.prawo	1
7	pl.rec.rowery	1
TOTAL: 7		445

Daily Usenet report

Jan 12 04:15:05 -- Jan 13 04:15:03