Daily Usenet report: Oct 28 04:15:03

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Oct 28 05:05:10 newsfeed overchan[14511]: input line too long, skipping
Oct 28 10:20:30 newsfeed nnrpd[28872]: SERVER perl filter not defined
Oct 28 11:15:00 newsfeed nnrpd[30763]: SERVER perl filter not defined
Oct 28 23:36:47 newsfeed overchan[14511]: input line too long, skipping
Oct 29 01:19:16 newsfeed overchan[14511]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2842515	96.6%	324.9 MB	96.2%
innd	48973	1.7%	6.8 MB	2.0%
innfeed	45690	1.6%	5.4 MB	1.6%
nnrpd	4960	0.2%	517.3 KB	0.1%
overchan	4	0.0%	0.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2942143	100.0%	337.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2793681	94.6%
Negative hits	133697	4.5%
Cache misses	15730	0.5%
Positive hits	10644	0.4%
TOTAL: 4	2953752	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.207	0.0%	88	0.000	13.716	170.000
article cleanup	00:00:36.521	0.0%	2809613	0.000	0.013	0.019
article logging	00:01:38.493	0.1%	2810078	0.000	0.035	0.102
article parse	00:48:33.662	3.2%	117876618	0.000	0.025	0.041
article write	00:16:03.580	1.1%	2774578	0.158	0.347	1.000
artlog/artcncl	00:00:00.001	0.0%	87	0.000	0.011	0.048
artlog/artparse	00:00:00.001	0.0%	1	1.000	1.000	1.000
data move	00:01:57.152	0.1%	132201329	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.467	0.0%	85	0.000	5.494	19.000
hishave/artcncl	00:00:00.213	0.0%	88	0.000	2.420	8.810
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:11:09.802	4.7%	2965786	0.000	1.440	7.741
history sync	00:00:00.016	0.0%	307	0.000	0.052	0.500
history write	02:53:26.811	11.6%	2803810	0.403	3.712	14.570
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
idle	13:35:15.276	54.3%	93983661	0.279	0.520	46161.538
nntp read	00:50:45.803	3.4%	115633261	0.000	0.026	0.035
overview write	00:00:13.286	0.0%	2774578	0.003	0.005	2.000
perl filter	04:40:41.222	18.7%	2803809	4.650	6.007	778.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:00.389	0.3%	5562486	0.000	0.043	0.066
TOTAL: 25:00:07.200	24:24:23.902	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.141	0.0%	59744	0.000	0.002	0.012
article prepare	00:00:00.002	0.0%	12534	0.000	0.000	0.028
article read	00:02:00.954	0.1%	3119	0.000	38.780	397.400
backlog stats	00:00:00.114	0.0%	133933	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	17	0.000	0.000	0.000
data read	00:00:01.161	0.0%	70241	0.000	0.017	0.045
data write	00:00:02.462	0.0%	57400	0.009	0.043	0.136
idle	24:52:48.515	99.8%	133933	200.990	668.756	1899.703
status file	00:00:14.778	0.0%	16568	0.453	0.892	4.736
TOTAL: 24:55:21.167	24:55:08.127	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:36.306	72.6%	3159	0.000	11.493	9300.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.197	0.4%	6995	0.000	0.028	0.500
readart	00:00:00.004	0.0%	40	0.000	0.100	1.500
TOTAL: 00:00:50.002	00:00:36.507	73.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	28
flushlogs	2
go	2
logmode	2
mode	154
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	199

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	979	2826758	2797647	3855	25256	98%	352:38:32
2	news.nask.pl	21	35737	9393	16544	9800	26%	18:52:28
3	news.icm.edu.pl	63	209	22	174	13	10%	12:13:52
4	localhost	3	2	2	0	0	100%	00:00:01
TOTAL: 4		1066	2862706	2807064	20573	35069	98%	383:44:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	638.4 GB	762.0 MB	4.1 GB	643.3 GB	99%	239.0 KB
2	news.nask.pl	76.6 MB	9.8 MB	1.0 GB	1.1 GB	6%	59.9 KB
3	news.icm.edu.pl	766.9 KB	59.6 KB	825.3 KB	1.6 MB	46%	47.2 KB
4	localhost	3.6 KB	0.0 KB	0.0 KB	3.6 KB	100%	1.8 KB
TOTAL: 4		638.5 GB	771.8 MB	5.1 GB	644.4 GB	99%	237.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 28 04:15:03 - 04:59:59	53933	1.9%	20.00	14.5 GB	2.3%	5626.59
Oct 28 05:00:00 - 05:59:59	60879	2.2%	16.91	15.8 GB	2.5%	4610.77
Oct 28 06:00:00 - 06:59:59	54815	2.0%	15.23	15.4 GB	2.4%	4495.86
Oct 28 07:00:00 - 07:59:59	51170	1.8%	14.21	18.6 GB	2.9%	5426.98
Oct 28 08:00:00 - 08:59:59	49034	1.7%	13.62	19.1 GB	3.0%	5553.38
Oct 28 09:00:00 - 09:59:59	62568	2.2%	17.38	16.8 GB	2.6%	4897.00
Oct 28 10:00:00 - 10:59:59	46292	1.6%	12.86	15.3 GB	2.4%	4446.44
Oct 28 11:00:00 - 11:59:59	11817	0.4%	3.28	3.2 GB	0.5%	939.72
Oct 28 12:00:00 - 12:59:59	62863	2.2%	17.46	20.1 GB	3.1%	5844.42
Oct 28 13:00:00 - 13:59:59	48074	1.7%	13.35	17.0 GB	2.7%	4943.21
Oct 28 14:00:00 - 14:59:59	54685	1.9%	15.19	13.7 GB	2.1%	3985.81
Oct 28 15:00:00 - 15:59:59	65131	2.3%	18.09	16.9 GB	2.6%	4911.21
Oct 28 16:00:00 - 16:59:59	103393	3.7%	28.72	27.1 GB	4.2%	7886.53
Oct 28 17:00:00 - 17:59:59	129518	4.6%	35.98	29.8 GB	4.7%	8668.38
Oct 28 18:00:00 - 18:59:59	120167	4.3%	33.38	33.9 GB	5.3%	9864.82
Oct 28 19:00:00 - 19:59:59	129355	4.6%	35.93	37.9 GB	5.9%	11036.52
Oct 28 20:00:00 - 20:59:59	136349	4.9%	37.87	39.6 GB	6.2%	11528.42
Oct 28 21:00:00 - 21:59:59	138028	4.9%	38.34	38.8 GB	6.1%	11306.24
Oct 28 22:00:00 - 22:59:59	175548	6.3%	48.76	38.2 GB	6.0%	11118.45
Oct 28 23:00:00 - 23:59:59	120801	4.3%	33.56	36.9 GB	5.8%	10753.68
Oct 29 00:00:00 - 00:59:59	160359	5.7%	44.54	29.4 GB	4.6%	8554.11
Oct 29 01:00:00 - 01:59:59	273184	9.7%	75.88	33.9 GB	5.3%	9883.31
Oct 29 02:00:00 - 02:59:59	418899	14.9%	116.36	71.5 GB	11.2%	20824.49
Oct 29 03:00:00 - 03:59:59	194005	6.9%	53.89	27.7 GB	4.3%	8063.04
Oct 29 04:00:00 - 04:15:03	86013	3.1%	95.25	8.3 GB	1.3%	9630.10
TOTAL: 24:00:00	2806880	100.0%	32.49	639.2 GB	100.0%	7757.23

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	25373	14	5511	8	19840
2	news.nask.pl	10160	23	317	3	9817
3	news.icm.edu.pl	15	0	1	0	14
TOTAL: 3		35548	37	5829	11	29671

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.ipad	18
comp.sys.raspberry-pi	5
de.rec.sf.startrek	4
uk.railway	2
de.comm.software.mailreader	2
it.tlc.cellulari.android	2
it.comp.os.win.windows10	2
rec.arts.tv.x-factor	1
comp.mobile.android	1
TOTAL: 9	37

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

Groups	Count
pl.praca.oferowana	9
pl.sci.matematyka	1
bit.listserv.catholic	1
TOTAL: 3	11

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	26127
EMP (md5)	2971
Scoring filter (8)	42
Poison newsgroup	25
Scoring filter (9)	20
HTML post	16
Scoring filter (10)	4
Scoring filter (17)	1
Scoring filter (12)	1
Scoring filter (11)	1
TOTAL: 10	29208

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.nask.pl	343
	newsfeed.pionier.net.pl	117
	news.icm.edu.pl	2
	TOTAL: 3	462
TOTAL: 1		462

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	50469	1389	21105	497	33	34855	2%	24:59:58
2	icm	14615	154	12141	230	0	1632	1%	23:43:38
3	poznan	12677	66	9001	27	0	1	0%	18:38:47
4	nask	2448	4	2110	0	0	0	0%	12:44:21
5	okapi	0	0	0	0	0	956	0%	24:57:50
TOTAL: 5		80209	1613	44357	754	33	37444	2%	105:04:34

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	6.4 MB	5.6 MB	12.1 MB	0.1 KB/s	6.6 KB	24:59:58
2	icm	943.0 KB	64.0 MB	65.0 MB	0.8 KB/s	173.2 KB	23:43:38
3	nask	482.5 KB	0.0 KB	482.5 KB	0.0 KB/s	120.6 KB	12:44:21
4	poznan	222.7 KB	174.1 KB	396.8 KB	0.0 KB/s	4.3 KB	18:38:47
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:57:50
TOTAL: 5		8.1 MB	69.8 MB	77.9 MB	0.2 KB/s	33.7 KB	105:04:34

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	300	40	30.5 KB	17	0	00:00:23
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:01
TOTAL: 2		302	40	30.5 KB	17	2	00:00:49

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	702	40	30.5 KB	17	2	00:00:30
2	*.084.063.pools.vodafone-ip.de	2	0	0.0 KB	0	0	00:00:19
TOTAL: 2		704	40	30.5 KB	17	2	00:00:49

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.388	12.064	00:00:23
dslb-084-063-075-032.084.063.pools.vodafone-ip.de	0.036	0.100	00:00:19
mon.man.lodz.pl	1.040	11.448	00:00:04
david.man.lodz.pl	0.300	3.956	00:00:01
isvcs01.man.lodz.pl	0.016	0.060	00:00:01
TOTAL: 5	2.780	27.628	00:00:49

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	300
david.man.lodz.pl	100
dslb-084-063-075-032.084.063.pools.vodafone-ip.de	2
TOTAL: 3	402

NNRP client timeouts [Top 20]:

System	Conn	Peer
dslb-084-063-075-032.084.063.pools.vodafone-ip.de	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	40
TOTAL: 1		40

Daily Usenet report

Oct 28 04:15:03 -- Oct 29 04:15:03