Daily Usenet report: Nov 16 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Nov 16 08:11:50 newsfeed nnrpd[13950]: SERVER perl filter not defined
Nov 16 12:17:10 newsfeed nnrpd[22497]: SERVER perl filter not defined
Nov 16 15:06:01 newsfeed nnrpd[28422]: SERVER perl filter not defined
Nov 16 16:51:49 newsfeed nnrpd[31960]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2309811	97.9%	263.2 MB	97.4%
innfeed	26038	1.1%	3.1 MB	1.2%
innd	19149	0.8%	3.3 MB	1.2%
nnrpd	5081	0.2%	531.9 KB	0.2%
TOTAL: 4	2360079	100.0%	270.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2303018	98.0%
Negative hits	30170	1.3%
Positive hits	17440	0.7%
Cache misses	200	0.0%
TOTAL: 4	2350828	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.052	0.0%	293	0.000	27.481	488.500
article cleanup	00:00:40.598	0.0%	2308875	0.006	0.018	0.032
article logging	00:01:09.851	0.1%	2309394	0.014	0.030	0.379
article parse	01:16:00.404	5.3%	259422914	0.007	0.018	0.089
article write	00:21:59.581	1.5%	2303884	0.312	0.573	3.450
artlog/artcncl	00:00:00.003	0.0%	274	0.000	0.011	0.182
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:04:31.321	0.3%	274967555	0.000	0.001	0.004
hisgrep/artcncl	00:00:02.119	0.0%	273	0.000	7.762	32.404
hishave/artcncl	00:00:00.264	0.0%	293	0.000	0.901	113.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:37:27.378	2.6%	2352254	0.020	0.955	21.048
history sync	00:00:00.017	0.0%	291	0.000	0.058	1.000
history write	00:53:52.475	3.7%	2304648	0.239	1.403	41.819
hiswrite/artcncl	00:00:00.124	0.0%	20	0.000	6.200	90.000
idle	13:11:16.314	54.9%	182812345	0.102	0.260	1.181
nntp read	01:22:14.564	5.7%	257642254	0.009	0.019	0.042
overview write	00:00:13.555	0.0%	2303884	0.001	0.006	0.015
perl filter	05:04:31.010	21.1%	2304648	5.116	7.928	12.210
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:30.617	0.3%	4649506	0.031	0.058	0.096
TOTAL: 24:00:10.137	22:58:38.247	95.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.221	0.0%	68215	0.000	0.003	0.083
article prepare	00:00:00.015	0.0%	48134	0.000	0.000	0.083
article read	00:00:51.455	0.1%	12038	0.000	4.274	2589.000
backlog stats	00:00:00.196	0.0%	237696	0.000	0.001	0.025
callbacks	00:00:00.000	0.0%	10	0.000	0.000	0.000
data read	00:00:01.597	0.0%	128309	0.000	0.012	0.093
data write	00:00:07.126	0.0%	91003	0.000	0.078	0.844
idle	23:58:12.736	99.9%	237696	24.175	363.038	3194.421
status file	00:00:07.382	0.0%	7935	0.000	0.930	187.167
TOTAL: 23:59:30.503	23:59:20.728	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:46:37.618	99.9%	9384	0.000	1449.022	450262.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.495	0.0%	20070	0.000	0.025	3.364
readart	00:00:03.905	0.0%	313	0.000	12.476	15.346
TOTAL: 03:46:55.478	03:46:42.018	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	986	2303983	2299246	554	4183	99%	293:01:53
2	news.nask.pl	2	17282	4343	12198	741	25%	23:38:20
3	news.icm.edu.pl	36	306	46	210	50	15%	17:47:32
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		1029	2321575	2303639	12962	4974	99%	334:27:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	742.2 GB	13.9 MB	49.0 MB	742.2 GB	99%	337.9 KB
2	news.nask.pl	15.6 MB	1.9 MB	2.0 MB	19.5 MB	80%	3.9 KB
3	news.icm.edu.pl	725.3 KB	175.0 KB	1.6 MB	2.5 MB	28%	26.2 KB
4	localhost	5.5 KB	0.0 KB	0.0 KB	5.5 KB	100%	1.4 KB
TOTAL: 4		742.2 GB	15.9 MB	52.6 MB	742.2 GB	99%	337.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 16 04:15:02 - 04:59:59	60870	2.6%	22.56	20.8 GB	2.8%	8083.73
Nov 16 05:00:00 - 05:59:59	82394	3.6%	22.89	26.3 GB	3.5%	7647.77
Nov 16 06:00:00 - 06:59:59	103753	4.5%	28.82	31.9 GB	4.3%	9304.28
Nov 16 07:00:00 - 07:59:59	86938	3.8%	24.15	26.6 GB	3.6%	7746.30
Nov 16 08:00:00 - 08:59:59	113309	4.9%	31.47	33.0 GB	4.4%	9606.54
Nov 16 09:00:00 - 09:59:59	99781	4.3%	27.72	31.2 GB	4.2%	9083.24
Nov 16 10:00:00 - 10:59:59	95483	4.1%	26.52	28.5 GB	3.8%	8314.75
Nov 16 11:00:00 - 11:59:59	106862	4.6%	29.68	34.8 GB	4.7%	10146.92
Nov 16 12:00:00 - 12:59:59	91809	4.0%	25.50	32.8 GB	4.4%	9555.36
Nov 16 13:00:00 - 13:59:59	90050	3.9%	25.01	32.6 GB	4.4%	9491.18
Nov 16 14:00:00 - 14:59:59	93552	4.1%	25.99	31.6 GB	4.3%	9213.37
Nov 16 15:00:00 - 15:59:59	92986	4.0%	25.83	31.0 GB	4.2%	9039.47
Nov 16 16:00:00 - 16:59:59	88794	3.9%	24.66	29.4 GB	4.0%	8565.13
Nov 16 17:00:00 - 17:59:59	88304	3.8%	24.53	30.1 GB	4.1%	8770.56
Nov 16 18:00:00 - 18:59:59	102360	4.4%	28.43	32.6 GB	4.4%	9483.55
Nov 16 19:00:00 - 19:59:59	103010	4.5%	28.61	31.2 GB	4.2%	9098.44
Nov 16 20:00:00 - 20:59:59	94813	4.1%	26.34	31.4 GB	4.2%	9133.88
Nov 16 21:00:00 - 21:59:59	116221	5.0%	32.28	34.0 GB	4.6%	9899.67
Nov 16 22:00:00 - 22:59:59	109796	4.8%	30.50	32.7 GB	4.4%	9538.64
Nov 16 23:00:00 - 23:59:59	104762	4.5%	29.10	33.0 GB	4.5%	9622.86
Nov 17 00:00:00 - 00:59:59	92223	4.0%	25.62	29.6 GB	4.0%	8624.13
Nov 17 01:00:00 - 01:59:59	96016	4.2%	26.67	33.6 GB	4.5%	9793.47
Nov 17 02:00:00 - 02:59:59	92051	4.0%	25.57	30.1 GB	4.1%	8762.57
Nov 17 03:00:00 - 03:59:59	79378	3.4%	22.05	26.3 GB	3.5%	7668.49
Nov 17 04:00:00 - 04:15:02	18513	0.8%	20.52	6.4 GB	0.9%	7453.02
TOTAL: 24:00:00	2304028	100.0%	26.67	741.7 GB	100.0%	9001.51

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4622	320	3504	1	797
2	news.nask.pl	834	39	714	5	76
3	news.icm.edu.pl	53	0	8	0	45
TOTAL: 3		5509	359	4226	6	918

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.ipad	142
uk.railway	76
it.comp.os.win.windows10	74
it.tlc.cellulari.android	23
nl.comp.sys.android	10
de.comp.lang.php	6
rec.arts.tv.x-factor	5
de.comp.office-pakete.ms-office.misc	5
hr.ponuda.hardver.komponente	4
hr.comp.os.linux.ubuntu	3
comp.mobile.android	3
it.comp.os.win.windows7	3
hr.alt.cellular.gsm.iphone	3
it.comp.os.linux.ubuntu	2
TOTAL: 14	359

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

Groups	Count
pl.praca.oferowana	4
bit.listserv.catholic	1
pl.sci.historia	1
TOTAL: 3	6

INND Perl filter [Top 20]:

Reason	Count
EMP (fsl)	179
Binary in non-binary group	175
EMP (md5)	39
Too many newsgroups	2
Attached HTML file	2
HTML post	1
Scoring filter (14)	1
TOTAL: 7	399

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	56765	6868	30158	3277	0	11	12%	23:55:26
2	panorama	26544	929	12115	414	23	54728	3%	23:59:48
3	poznan	6559	51	4300	33	0	0	0%	23:57:22
4	nask	0	0	0	0	0	17035	0%	24:00:00
5	okapi	0	0	0	0	0	2609	0%	24:00:00
TOTAL: 5		89868	7848	46573	3724	23	74383	8%	119:52:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	934.9 MB	764.2 MB	1.7 GB	20.2 KB/s	171.5 KB	23:55:26
2	panorama	3.8 MB	3.6 MB	7.5 MB	0.1 KB/s	5.7 KB	23:59:48
3	poznan	221.2 KB	51.0 KB	272.2 KB	0.0 KB/s	3.2 KB	23:57:22
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		938.9 MB	767.9 MB	1.7 GB	4.1 KB/s	151.0 KB	119:52:36

Backlog files shrunk by innfeed:

Server	Size
panorama	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-212-51-218-225.p.lodz.pl	14	264	561.9 KB	8	0	03:21:30
2	web.man.lodz.pl	288	40	46.0 KB	20	0	00:00:25
3	212.51.203.199	2	9	273.8 KB	1	0	00:04:33
4	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 4		308	313	881.7 KB	29	4	03:46:55

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.p.lodz.pl	14	264	561.9 KB	8	0	03:21:30
2	*.man.lodz.pl	676	40	46.0 KB	20	4	00:00:29
3	unresolved	6	9	273.8 KB	1	0	00:23:30
4	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:07
5	*.dynamic.chello.pl	1	0	0.0 KB	0	0	00:01:13
6	*.toya.net.pl	43	0	0.0 KB	0	0	00:00:03
TOTAL: 6		742	313	881.7 KB	29	4	03:46:55

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.044	0.300	03:21:30
185.48.194.11	0.329	0.422	00:18:57
212.51.203.199	0.006	0.023	00:04:33
89-72-94-100.dynamic.chello.pl	0.026	0.019	00:01:13
web.man.lodz.pl	1.002	4.633	00:00:25
host227.elsnet.pl	0.014	0.021	00:00:07
staticline41435.toya.net.pl	0.118	0.630	00:00:03
mon.man.lodz.pl	0.934	4.386	00:00:02
david.man.lodz.pl	0.299	1.378	00:00:00
isvcs01.man.lodz.pl	0.013	0.081	00:00:00
TOTAL: 10	2.785	11.893	03:46:55

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	43
185.48.194.11	4
host227.elsnet.pl	2
89-72-94-100.dynamic.chello.pl	1
TOTAL: 6	434

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	3	0
TOTAL: 1	3	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	313	100.0%
TOTAL: 1		313	100.0%

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

Newsgroup		Count
1	pl.misc.elektronika	194
2	pl.misc.kolej	70
3	pl.comp.os.ms-windows.winnt	22
4	pl.comp.pecet	18
5	pl.rec.radio.amatorskie	9
TOTAL: 5		313

Daily Usenet report

Nov 16 04:15:02 -- Nov 17 04:15:02