Daily Usenet report: Jan 26 04:15:04

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 26 14:09:56 newsfeed nnrpd[20710]: SERVER perl filter not defined
Jan 26 14:49:34 newsfeed nnrpd[22016]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	622803	96.4%	71.5 MB	95.7%
innd	9803	1.5%	1.6 MB	2.1%
nnrpd	7033	1.1%	709.0 KB	0.9%
innfeed	6548	1.0%	921.6 KB	1.2%
TOTAL: 4	646187	100.0%	74.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	607768	94.2%
Negative hits	20041	3.1%
Positive hits	17132	2.7%
Cache misses	130	0.0%
TOTAL: 4	645071	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.736	0.0%	321	0.000	11.639	265.000
article cleanup	00:00:08.759	0.0%	612067	0.000	0.014	0.047
article logging	00:00:18.144	0.0%	622981	0.000	0.029	0.112
article parse	00:18:28.470	1.3%	44191735	0.006	0.025	0.067
article write	00:04:56.932	0.3%	608589	0.124	0.488	2.407
artlog/artcncl	00:00:00.009	0.0%	309	0.000	0.029	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:53.828	0.1%	47625390	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.860	0.0%	304	0.000	2.829	31.333
hishave/artcncl	00:00:00.757	0.0%	321	0.000	2.358	18.611
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:02:31.746	4.3%	646934	0.014	5.799	22.298
history sync	00:00:00.034	0.0%	514	0.000	0.066	1.000
history write	01:13:51.145	5.1%	609584	0.072	7.269	25.004
hiswrite/artcncl	00:00:00.054	0.0%	17	0.000	3.176	15.000
idle	19:31:06.014	81.3%	34284447	0.332	2.050	9.870
nntp read	00:17:31.839	1.2%	43799583	0.009	0.024	0.041
overview write	00:00:04.049	0.0%	608589	0.000	0.007	0.036
perl filter	01:16:25.139	5.3%	609584	3.779	7.522	10.797
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:17.368	0.1%	1248034	0.030	0.062	0.133
TOTAL: 24:00:06.129	23:47:38.883	99.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.107	0.0%	30918	0.000	0.003	1.000
article prepare	00:00:00.003	0.0%	9236	0.000	0.000	0.250
article read	00:00:00.228	0.0%	2281	0.000	0.100	6.250
backlog stats	00:00:00.094	0.0%	186865	0.000	0.001	0.026
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.218	0.0%	124501	0.000	0.010	1.000
data write	00:00:03.424	0.0%	94050	0.000	0.036	6.000
idle	23:58:35.424	100.0%	186865	0.000	461.913	30101.000
status file	00:00:00.229	0.0%	196	0.000	1.168	11.333
TOTAL: 23:58:45.691	23:58:40.727	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.335	0.0%	69	4.300	4.855	6.000
idle	10:04:51.022	99.9%	180684	0.000	200.854	450080.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:05.375	0.0%	363580	0.000	0.015	4.889
readart	00:00:02.288	0.0%	630	0.000	3.632	13.956
TOTAL: 10:05:23.338	10:04:59.020	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	423	608149	605154	180	2815	99%	173:01:21
2	news.nask.pl	1	16386	2121	13673	592	12%	22:58:45
3	news.icm.edu.pl	40	260	32	203	25	12%	16:42:41
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		467	624797	607309	14056	3432	97%	212:42:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	151.1 GB	42.0 MB	119.7 MB	151.3 GB	99%	260.9 KB
2	news.nask.pl	7.4 MB	1.8 MB	1.8 MB	11.0 MB	67%	4.1 KB
3	news.icm.edu.pl	819.7 KB	88.9 KB	899.5 KB	1.8 MB	45%	31.7 KB
4	localhost	3.8 KB	0.0 KB	0.0 KB	3.8 KB	100%	1.9 KB
TOTAL: 4		151.1 GB	43.8 MB	122.4 MB	151.3 GB	99%	259.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 26 04:15:04 - 04:59:59	39596	6.5%	14.69	11.5 GB	7.6%	4483.87
Jan 26 05:00:00 - 05:59:59	12520	2.1%	3.48	3.0 GB	2.0%	880.13
Jan 26 06:00:00 - 06:59:59	12503	2.1%	3.47	2.5 GB	1.7%	730.03
Jan 26 07:00:00 - 07:59:59	11233	1.8%	3.12	2.4 GB	1.6%	687.10
Jan 26 08:00:00 - 08:59:59	11366	1.9%	3.16	2.2 GB	1.5%	652.47
Jan 26 09:00:00 - 09:59:59	14361	2.4%	3.99	2.2 GB	1.4%	629.27
Jan 26 10:00:00 - 10:59:59	8755	1.4%	2.43	1.5 GB	1.0%	438.35
Jan 26 11:00:00 - 11:59:59	10928	1.8%	3.04	1.8 GB	1.2%	512.75
Jan 26 12:00:00 - 12:59:59	10986	1.8%	3.05	1.7 GB	1.1%	488.88
Jan 26 13:00:00 - 13:59:59	12588	2.1%	3.50	2.3 GB	1.5%	661.73
Jan 26 14:00:00 - 14:59:59	11820	1.9%	3.28	2.1 GB	1.4%	619.53
Jan 26 15:00:00 - 15:59:59	11524	1.9%	3.20	2.4 GB	1.6%	697.32
Jan 26 16:00:00 - 16:59:59	11505	1.9%	3.20	2.0 GB	1.3%	573.31
Jan 26 17:00:00 - 17:59:59	11449	1.9%	3.18	1.8 GB	1.2%	512.26
Jan 26 18:00:00 - 18:59:59	12080	2.0%	3.36	2.0 GB	1.3%	575.45
Jan 26 19:00:00 - 19:59:59	13568	2.2%	3.77	2.2 GB	1.4%	627.25
Jan 26 20:00:00 - 20:59:59	14516	2.4%	4.03	2.1 GB	1.4%	609.08
Jan 26 21:00:00 - 21:59:59	13645	2.2%	3.79	1.8 GB	1.2%	510.29
Jan 26 22:00:00 - 22:59:59	14958	2.5%	4.16	2.6 GB	1.7%	755.13
Jan 26 23:00:00 - 23:59:59	13864	2.3%	3.85	1.9 GB	1.3%	567.03
Jan 27 00:00:00 - 00:59:59	64474	10.6%	17.91	18.8 GB	12.4%	5486.22
Jan 27 01:00:00 - 01:59:59	92640	15.2%	25.73	27.6 GB	18.2%	8046.26
Jan 27 02:00:00 - 02:59:59	96523	15.9%	26.81	30.1 GB	19.9%	8758.60
Jan 27 03:00:00 - 03:59:59	65426	10.8%	18.17	19.0 GB	12.6%	5537.69
Jan 27 04:00:00 - 04:15:02	15182	2.5%	16.83	4.1 GB	2.7%	4712.03
TOTAL: 23:59:58	608010	100.0%	7.04	151.4 GB	100.0%	1837.32

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	13812	226	1867	1	11718
2	news.nask.pl	629	8	611	1	9
3	news.icm.edu.pl	43	0	3	0	40
TOTAL: 3		14484	234	2481	2	11767

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	104
it.tlc.cellulari.android	28
comp.mobile.android	15
de.rec.sf.startrek	14
it.comp.os.win.windows7	13
it.discussioni.energia	12
comp.mobile.ipad	9
uk.rec.cycling.moderated	7
it.comp.os.win.windows8	5
comp.sys.mac.vintage	3
hr.ponuda.hardver.komponente	3
comp.sys.raspberry-pi	2
alt.sex.telephones	2
hr.alt.cellular.gsm.android	2
hr.rec.sport.rukomet	2
de.comp.lang.vbclassic	2
it.comp.os.linux.ubuntu	2
de.comp.lang.perl	2
hr.ponuda.hardver.konfiguracije	2
de.comp.office-pakete.ms-office.word	1
TOTAL: 24	234

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

Groups	Count
pl.sci.historia	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	714
EMP (md5)	39
HTML post	5
EMP (fsl)	1
Scoring filter (12)	1
TOTAL: 5	760

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	31375	764	29945	120	0	2%	23:57:08
2	icm	36890	338	28520	1025	22	0%	23:52:44
3	nask	21742	41	15412	4	58	0%	23:52:56
4	poznan	2639	9	1946	5	0	0%	23:57:26
5	okapi	0	0	0	0	2469	0%	24:00:03
TOTAL: 5		92646	1152	75823	1154	2549	1%	119:40:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	3.3 MB	180.6 MB	183.9 MB	2.2 KB/s	138.2 KB	23:52:44
2	panorama	2.7 MB	356.2 KB	3.0 MB	0.0 KB/s	3.5 KB	23:57:08
3	nask	173.6 KB	21.2 KB	194.8 KB	0.0 KB/s	4.3 KB	23:52:56
4	poznan	28.3 KB	51.8 KB	80.1 KB	0.0 KB/s	5.7 KB	23:57:26
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		6.2 MB	181.0 MB	187.2 MB	0.4 KB/s	83.1 KB	119:40:17

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	287	311	642.5 KB	287	0	0	00:00:07
2	pc-212-51-218-225.p.lodz.pl	8	269	513.9 KB	10	0	0	03:10:41
3	web.man.lodz.pl	288	48	45.9 KB	23	0	0	00:00:23
4	bqf55.neoplus.adsl.tpnet.pl	3	2	2.1 KB	1	0	3	00:04:18
5	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	0	00:00:00
TOTAL: 5		588	630	1.2 MB	321	2	3	10:05:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	287	311	642.5 KB	287	0	0	00:00:07
2	*.p.lodz.pl	8	269	513.9 KB	10	0	0	03:10:41
3	*.man.lodz.pl	674	48	45.9 KB	23	2	0	00:00:29
4	*.neoplus.adsl.tpnet.pl	3	2	2.1 KB	1	0	3	00:04:18
5	*.elsnet.pl	2	0	0.0 KB	0	0	0	00:00:09
6	unresolved	6	0	0.0 KB	0	0	0	06:48:49
7	*.toya.net.pl	34	0	0.0 KB	0	0	0	00:00:48
TOTAL: 7		1014	630	1.2 MB	321	2	3	10:05:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.194.196	7.367	10.455	06:48:49
pc-212-51-218-225.p.lodz.pl	0.064	0.136	03:10:41
bqf55.neoplus.adsl.tpnet.pl	0.045	0.028	00:04:18
staticline41435.toya.net.pl	0.104	0.355	00:00:48
web.man.lodz.pl	0.990	3.015	00:00:23
host227.elsnet.pl	0.007	0.019	00:00:09
pc-skrzep2.cm.p.lodz.pl	0.916	2.627	00:00:07
mon.man.lodz.pl	0.932	2.824	00:00:04
david.man.lodz.pl	0.346	0.916	00:00:01
isvcs01.man.lodz.pl	0.016	0.022	00:00:00
TOTAL: 10	10.787	20.397	10:05:23

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	34
185.48.194.196	6
host227.elsnet.pl	2
TOTAL: 5	426

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	4	0
185.48.194.196	1	1
TOTAL: 2	5	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	317	50.3%
2	lodman	311	49.4%
3	lodz	2	0.3%
TOTAL: 3		630	100.0%

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

Newsgroup		Count
1	lodman.info	311
2	pl.misc.elektronika	164
3	pl.misc.kolej	105
4	pl.comp.pecet	40
5	pl.comp.os.ms-windows.winnt	8
6	lodz.test	2
TOTAL: 6		630

Daily Usenet report

Jan 26 04:15:04 -- Jan 27 04:15:02