Daily Usenet report: Aug 31 04:15:03

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 31 10:17:29 newsfeed nnrpd[23741]: SERVER perl filter not defined
Aug 31 13:28:33 newsfeed nnrpd[30185]: SERVER perl filter not defined
Aug 31 16:47:48 newsfeed nnrpd[4231]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2092648	98.2%	239.5 MB	97.8%
innd	23711	1.1%	3.7 MB	1.5%
nnrpd	6936	0.3%	738.6 KB	0.3%
innfeed	6742	0.3%	1.0 MB	0.4%
TOTAL: 4	2130037	100.0%	244.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2078966	94.6%
Negative hits	93503	4.3%
Positive hits	24817	1.1%
Cache misses	164	0.0%
TOTAL: 4	2197450	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:12.227	0.0%	380	0.000	32.176	850.000
article cleanup	00:00:30.648	0.0%	2092984	0.006	0.015	0.030
article logging	00:01:06.166	0.1%	2093077	0.014	0.032	0.344
article parse	00:59:47.657	4.2%	197831420	0.010	0.018	0.049
article write	00:18:02.814	1.3%	2072933	0.326	0.522	1.111
artlog/artcncl	00:00:00.008	0.0%	306	0.000	0.026	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:59.773	0.2%	211192863	0.000	0.001	0.002
hisgrep/artcncl	00:00:01.575	0.0%	338	0.000	4.660	139.500
hishave/artcncl	00:00:00.766	0.0%	380	0.000	2.016	74.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:51:50.911	7.8%	2199276	0.007	3.051	8.140
history sync	00:00:00.012	0.0%	292	0.000	0.041	1.000
history write	04:47:50.001	20.0%	2080705	3.314	8.300	27.959
hiswrite/artcncl	00:00:00.328	0.0%	42	0.000	7.810	147.000
idle	10:19:46.541	43.0%	110527570	0.177	0.336	1.481
nntp read	00:55:31.649	3.9%	196110941	0.011	0.017	0.036
overview write	00:00:12.237	0.0%	2072933	0.000	0.006	0.015
perl filter	04:04:22.530	17.0%	2080703	5.117	7.047	11.207
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:27.689	0.3%	4179761	0.007	0.064	0.090
TOTAL: 24:00:31.527	23:26:43.532	97.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.102	0.0%	33885	0.000	0.003	0.111
article prepare	00:00:00.010	0.0%	31362	0.000	0.000	0.083
article read	00:00:00.822	0.0%	7697	0.000	0.107	2.000
backlog stats	00:00:00.100	0.0%	214564	0.000	0.000	0.018
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.483	0.0%	140091	0.000	0.011	1.000
data write	00:00:07.041	0.0%	111042	0.000	0.063	7.000
idle	23:58:31.758	100.0%	214564	0.000	402.266	17611.000
status file	00:00:00.477	0.0%	174	0.000	2.741	73.000
TOTAL: 23:58:47.100	23:58:41.793	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:54:03.477	99.6%	47793	0.000	218.515	450675.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.564	0.0%	97242	0.000	0.016	1.333
readart	00:00:00.893	0.0%	364	0.000	2.453	35.154
TOTAL: 02:54:41.843	02:54:05.934	99.7%	-	-	-	-

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	615	2088883	2066686	3238	18959	98%	431:31:24
2	news.nask.pl	2	16281	6104	9268	909	37%	24:42:18
3	news.icm.edu.pl	39	436	69	187	180	15%	18:36:06
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		660	2105603	2072862	12693	20048	98%	474:49:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	688.7 GB	2.3 GB	3.3 GB	694.2 GB	99%	349.0 KB
2	news.nask.pl	26.7 MB	2.3 MB	2.8 MB	31.8 MB	83%	4.6 KB
3	news.icm.edu.pl	2.6 MB	169.5 KB	10.7 MB	13.5 MB	19%	55.4 KB
4	localhost	3.9 KB	0.0 KB	0.0 KB	3.9 KB	100%	1.3 KB
TOTAL: 4		688.7 GB	2.3 GB	3.3 GB	694.3 GB	99%	347.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 31 04:15:03 - 04:59:59	51823	2.5%	19.22	21.2 GB	3.1%	8261.85
Aug 31 05:00:00 - 05:59:59	71381	3.4%	19.83	30.2 GB	4.4%	8793.05
Aug 31 06:00:00 - 06:59:59	68057	3.3%	18.90	30.0 GB	4.4%	8740.64
Aug 31 07:00:00 - 07:59:59	83070	4.0%	23.07	32.1 GB	4.7%	9348.97
Aug 31 08:00:00 - 08:59:59	85282	4.1%	23.69	31.6 GB	4.6%	9198.39
Aug 31 09:00:00 - 09:59:59	86302	4.2%	23.97	31.6 GB	4.6%	9215.29
Aug 31 10:00:00 - 10:59:59	87111	4.2%	24.20	30.5 GB	4.4%	8882.32
Aug 31 11:00:00 - 11:59:59	82746	4.0%	22.98	27.3 GB	4.0%	7946.68
Aug 31 12:00:00 - 12:59:59	94801	4.6%	26.33	29.4 GB	4.3%	8575.94
Aug 31 13:00:00 - 13:59:59	95536	4.6%	26.54	30.6 GB	4.4%	8910.87
Aug 31 14:00:00 - 14:59:59	96957	4.7%	26.93	30.0 GB	4.3%	8726.39
Aug 31 15:00:00 - 15:59:59	98946	4.8%	27.48	31.2 GB	4.5%	9094.07
Aug 31 16:00:00 - 16:59:59	103431	5.0%	28.73	30.8 GB	4.5%	8979.45
Aug 31 17:00:00 - 17:59:59	96091	4.6%	26.69	30.7 GB	4.5%	8928.04
Aug 31 18:00:00 - 18:59:59	105202	5.1%	29.22	30.8 GB	4.5%	8969.16
Aug 31 19:00:00 - 19:59:59	105622	5.1%	29.34	30.7 GB	4.5%	8928.20
Aug 31 20:00:00 - 20:59:59	103330	5.0%	28.70	29.5 GB	4.3%	8578.90
Aug 31 21:00:00 - 21:59:59	84093	4.1%	23.36	25.2 GB	3.7%	7329.28
Aug 31 22:00:00 - 22:59:59	82959	4.0%	23.04	27.1 GB	3.9%	7889.48
Aug 31 23:00:00 - 23:59:59	88888	4.3%	24.69	27.1 GB	3.9%	7906.48
Sep 1 00:00:00 - 00:59:59	60984	2.9%	16.94	20.7 GB	3.0%	6037.30
Sep 1 01:00:00 - 01:59:59	74183	3.6%	20.61	24.5 GB	3.6%	7121.89
Sep 1 02:00:00 - 02:59:59	68024	3.3%	18.90	23.2 GB	3.4%	6767.96
Sep 1 03:00:00 - 03:59:59	76764	3.7%	21.32	25.8 GB	3.7%	7514.75
Sep 1 04:00:00 - 04:15:03	20611	1.0%	22.83	7.0 GB	1.0%	8108.43
TOTAL: 24:00:00	2072194	100.0%	23.98	688.7 GB	100.0%	8358.62

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	19034	168	11463	7	7396
2	news.nask.pl	922	72	813	20	17
3	news.icm.edu.pl	192	0	5	0	187
TOTAL: 3		20148	240	12281	27	7600

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	84
alt.sex.telephones	46
it.tlc.cellulari.android	15
de.comm.provider.telefonie	14
comp.mobile.ipad	13
de.rec.sf.startrek	10
hr.alt.cellular.gsm.android	10
nl.comp.os.linux.techniek	10
comp.mobile.android	10
uk.rec.cycling.moderated	7
de.comp.office-pakete.ms-office.excel	6
de.comp.os.os2	5
it.comp.os.linux.ubuntu	2
it.comp.os.win.windows7	2
hr.ponuda.hardver.komponente	2
comp.sys.raspberry-pi	1
hr.ponuda.hardver.periferije	1
de.comp.lang.perl	1
hr.ponuda.hardver.konfiguracije	1
TOTAL: 19	240

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

Groups	Count
pl.sci.historia	19
pl.sci.matematyka	8
TOTAL: 2	27

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	7320
EMP (md5)	184
Scoring filter (8)	1
TOTAL: 3	7505

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	34863	1804	31659	380	1	0	5%	23:57:49
2	icm	35620	902	28116	4027	0	11	2%	23:58:40
3	nask	22079	148	14113	471	0	0	0%	24:01:14
4	poznan	7523	66	5578	26	0	0	0%	23:54:23
5	okapi	0	0	0	0	0	1886	0%	24:00:02
TOTAL: 5		100085	2920	79466	4904	1	1897	2%	119:52:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	121.1 MB	809.6 MB	930.8 MB	11.0 KB/s	193.4 KB	23:58:40
2	nask	13.9 MB	109.0 MB	122.9 MB	1.5 KB/s	203.3 KB	24:01:14
3	panorama	8.6 MB	1.1 MB	9.7 MB	0.1 KB/s	4.5 KB	23:57:49
4	poznan	160.8 KB	62.8 KB	223.6 KB	0.0 KB/s	2.4 KB	23:54:23
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		143.8 MB	919.8 MB	1.0 GB	2.5 KB/s	139.2 KB	119:52:08

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	324	443.5 KB	288	0	00:00:15
2	web.man.lodz.pl	288	40	32.7 KB	19	0	00:00:29
3	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 3		579	364	476.2 KB	307	3	02:54:41

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	324	443.5 KB	288	0	00:00:15
2	*.man.lodz.pl	673	40	32.7 KB	19	3	00:00:38
3	*.191.14.62.static.jazztel.es	2	0	0.0 KB	0	0	02:19:29
4	*.bstnma.fios.verizon.net	1	0	0.0 KB	0	0	00:00:00
5	*.105.135.22.tvsat364.lodz.pl	1	0	0.0 KB	0	0	00:30:02
6	unresolved	1	0	0.0 KB	0	0	00:04:09
7	*.toya.net.pl	34	0	0.0 KB	0	0	00:00:05
TOTAL: 7		1000	364	476.2 KB	307	3	02:54:41

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
42.191.14.62.static.jazztel.es	2.465	2.666	02:19:29
ip-176.105.135.22.tvsat364.lodz.pl	0.006	0.019	00:30:02
194.33.77.50	0.005	0.015	00:04:09
web.man.lodz.pl	1.297	4.413	00:00:29
pc-skrzep2.cm.p.lodz.pl	1.271	4.168	00:00:15
staticline41435.toya.net.pl	0.145	0.486	00:00:05
mon.man.lodz.pl	1.090	3.860	00:00:04
david.man.lodz.pl	0.432	1.457	00:00:03
isvcs01.man.lodz.pl	0.025	0.053	00:00:00
pool-100-0-90-32.bstnma.fios.verizon.net	0.016	0.017	00:00:00
TOTAL: 10	6.752	17.154	02:54:41

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	286
david.man.lodz.pl	96
staticline41435.toya.net.pl	34
42.191.14.62.static.jazztel.es	2
pool-100-0-90-32.bstnma.fios.verizon.net	1
ip-176.105.135.22.tvsat364.lodz.pl	1
194.33.77.50	1
TOTAL: 7	421

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	324	89.0%
2	pl	40	11.0%
TOTAL: 2		364	100.0%

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

Newsgroup		Count
1	lodman.info	324
2	pl.comp.os.ms-windows.winnt	28
3	pl.comp.pecet	12
TOTAL: 3		364

Daily Usenet report

Aug 31 04:15:03 -- Sep 1 04:15:03