Daily Usenet report: Nov 6 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Nov 6 08:40:46 newsfeed overchan[25425]: input line too long, skipping
Nov 6 13:30:37 newsfeed overchan[25425]: input line too long, skipping
Nov 6 14:26:26 newsfeed nnrpd[16353]: SERVER perl filter not defined
Nov 6 15:00:07 newsfeed overchan[25425]: input line too long, skipping
Nov 6 15:20:04 newsfeed overchan[25425]: input line too long, skipping
Nov 6 16:44:11 newsfeed overchan[25425]: input line too long, skipping
Nov 6 17:10:20 newsfeed overchan[25425]: input line too long, skipping
Nov 6 18:02:30 newsfeed overchan[25425]: input line too long, skipping
Nov 6 21:10:58 newsfeed nnrpd[31396]: SERVER perl filter not defined
Nov 6 21:55:29 newsfeed overchan[25425]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4154672	97.7%	469.6 MB	97.3%
innd	49810	1.2%	7.3 MB	1.5%
innfeed	43716	1.0%	5.2 MB	1.1%
nnrpd	4805	0.1%	502.5 KB	0.1%
overchan	9	0.0%	1.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	4253013	100.0%	482.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	4099103	95.5%
Negative hits	165220	3.9%
Positive hits	25597	0.6%
Cache misses	125	0.0%
TOTAL: 4	4290045	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.233	0.0%	145	0.000	8.503	205.000
article cleanup	00:00:44.883	0.1%	4149267	0.008	0.011	0.015
article logging	00:02:02.947	0.1%	4149899	0.022	0.030	0.096
article parse	00:58:09.634	4.0%	168090008	0.011	0.021	0.041
article write	00:20:03.253	1.4%	4112300	0.161	0.293	0.483
artlog/artcncl	00:00:00.003	0.0%	145	0.000	0.021	0.500
data move	00:05:25.709	0.4%	189247198	0.001	0.002	0.004
hisgrep/artcncl	00:00:00.256	0.0%	141	0.000	1.816	28.000
hishave/artcncl	00:00:00.080	0.0%	145	0.000	0.552	2.727
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:43:38.104	3.0%	4328529	0.050	0.605	5.765
history sync	00:00:00.008	0.0%	290	0.000	0.028	0.500
history write	01:31:35.636	6.4%	4135516	0.148	1.329	9.176
hiswrite/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
idle	12:48:28.876	53.4%	131738282	0.241	0.350	0.736
nntp read	01:15:34.810	5.2%	164784505	0.017	0.028	0.043
overview write	00:00:18.758	0.0%	4112300	0.003	0.005	0.007
perl filter	05:42:17.533	23.8%	4135516	2.796	4.966	6.757
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:15.311	0.4%	8244642	0.027	0.038	0.059
TOTAL: 24:00:03.633	23:33:37.034	98.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.147	0.0%	59832	0.000	0.002	0.019
article prepare	00:00:00.002	0.0%	9920	0.000	0.000	0.029
article read	00:01:24.093	0.1%	2523	0.000	33.331	354.818
backlog stats	00:00:00.133	0.0%	170740	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	53	0.000	0.000	0.000
data read	00:00:01.650	0.0%	89896	0.003	0.018	0.050
data write	00:00:02.834	0.0%	70414	0.014	0.040	0.132
idle	23:52:26.120	99.9%	170740	159.237	503.374	955.506
status file	00:00:13.026	0.0%	15560	0.500	0.837	5.433
TOTAL: 23:54:20.164	23:54:08.005	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:07:30.255	96.5%	3083	0.000	146.044	90444.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.185	0.0%	6905	0.000	0.027	1.000
readart	00:00:00.004	0.0%	82	0.000	0.049	0.500
TOTAL: 00:07:46.586	00:07:30.444	96.5%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	192

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1364	4135993	4106975	5874	23144	99%	437:51:02
2	news.nask.pl	2	29707	10020	5876	13811	33%	23:50:44
3	news.icm.edu.pl	47	163	9	147	7	5%	14:43:43
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1416	4165865	4117006	11897	36962	98%	476:25:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	861.9 GB	1.8 GB	3.6 GB	867.3 GB	99%	220.2 KB
2	news.nask.pl	76.0 MB	17.5 MB	2.0 GB	2.1 GB	3%	90.3 KB
3	news.icm.edu.pl	179.4 KB	0.0 KB	415.6 KB	595.0 KB	30%	37.2 KB
4	localhost	3.1 KB	0.0 KB	0.0 KB	3.1 KB	100%	1.5 KB
TOTAL: 4		862.0 GB	1.8 GB	5.6 GB	869.4 GB	99%	219.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 6 04:15:02 - 04:59:59	111694	2.7%	41.40	27.7 GB	3.2%	10776.87
Nov 6 05:00:00 - 05:59:59	217219	5.3%	60.34	38.8 GB	4.5%	11289.82
Nov 6 06:00:00 - 06:59:59	168150	4.1%	46.71	38.7 GB	4.5%	11271.25
Nov 6 07:00:00 - 07:59:59	188930	4.6%	52.48	40.6 GB	4.7%	11826.65
Nov 6 08:00:00 - 08:59:59	145400	3.5%	40.39	37.1 GB	4.3%	10796.18
Nov 6 09:00:00 - 09:59:59	174973	4.3%	48.60	37.7 GB	4.4%	10989.14
Nov 6 10:00:00 - 10:59:59	162812	4.0%	45.23	40.9 GB	4.7%	11918.26
Nov 6 11:00:00 - 11:59:59	181063	4.4%	50.30	41.0 GB	4.8%	11954.89
Nov 6 12:00:00 - 12:59:59	169846	4.1%	47.18	39.3 GB	4.6%	11451.68
Nov 6 13:00:00 - 13:59:59	125340	3.0%	34.82	33.2 GB	3.8%	9663.86
Nov 6 14:00:00 - 14:59:59	175519	4.3%	48.76	36.3 GB	4.2%	10586.25
Nov 6 15:00:00 - 15:59:59	146286	3.6%	40.63	36.1 GB	4.2%	10523.35
Nov 6 16:00:00 - 16:59:59	174405	4.2%	48.45	38.9 GB	4.5%	11343.33
Nov 6 17:00:00 - 17:59:59	192298	4.7%	53.42	38.7 GB	4.5%	11259.28
Nov 6 18:00:00 - 18:59:59	163111	4.0%	45.31	34.8 GB	4.0%	10131.17
Nov 6 19:00:00 - 19:59:59	168952	4.1%	46.93	31.9 GB	3.7%	9285.34
Nov 6 20:00:00 - 20:59:59	147594	3.6%	41.00	36.4 GB	4.2%	10599.66
Nov 6 21:00:00 - 21:59:59	137131	3.3%	38.09	37.1 GB	4.3%	10804.40
Nov 6 22:00:00 - 22:59:59	160393	3.9%	44.55	36.0 GB	4.2%	10495.41
Nov 6 23:00:00 - 23:59:59	196747	4.8%	54.65	31.3 GB	3.6%	9111.63
Nov 7 00:00:00 - 00:59:59	202110	4.9%	56.14	26.7 GB	3.1%	7766.63
Nov 7 01:00:00 - 01:59:59	211581	5.1%	58.77	35.2 GB	4.1%	10243.34
Nov 7 02:00:00 - 02:59:59	201869	4.9%	56.07	32.8 GB	3.8%	9564.88
Nov 7 03:00:00 - 03:59:59	152317	3.7%	42.31	27.7 GB	3.2%	8067.77
Nov 7 04:00:00 - 04:15:05	41182	1.0%	45.50	8.1 GB	0.9%	9374.35
TOTAL: 24:00:03	4116922	100.0%	47.65	863.0 GB	100.0%	10473.70

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	23568	260	13468	0	9840
2	news.nask.pl	14033	31	319	3	13680
3	news.icm.edu.pl	9	0	2	0	7
TOTAL: 3		37610	291	13789	3	23527

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	201
it.comp.os.win.windows10	23
comp.mobile.android	16
it.comp.os.linux.ubuntu	12
it.tlc.cellulari.android	9
comp.sys.raspberry-pi	8
comp.mobile.ipad	7
de.rec.sf.startrek	4
uk.net.providers.gradwell	2
it.discussioni.energia	2
it.comp.os.win.windows7	2
alt.sex.telephones	2
alt.sex.telephone.alt.sex.services	1
hr.rec.glazba.hifi	1
de.comp.lang.php	1
TOTAL: 15	291

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

Groups	Count
pl.sci.matematyka	2
bit.listserv.catholic	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	20028
EMP (md5)	2768
Scoring filter (9)	45
Scoring filter (8)	30
HTML post	11
Scoring filter (10)	7
Too many newsgroups	2
Scoring filter (15)	1
Scoring filter (11)	1
TOTAL: 9	22893

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	424
	news.nask.pl	209
	news.icm.edu.pl	1
	TOTAL: 3	634
TOTAL: 1		634

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	45442	806	18300	251	150	39949	1%	24:00:01
2	poznan	16556	473	9449	56	0	0	2%	24:00:01
3	icm	24548	51	18790	99	0	0	0%	24:00:01
4	nask	3651	5	2548	32	0	0	0%	24:00:01
5	okapi	0	0	0	0	0	1034	0%	23:57:54
TOTAL: 5		90197	1335	49087	438	150	40983	1%	119:57:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	4.0 MB	1.7 MB	5.8 MB	0.1 KB/s	5.6 KB	24:00:01
2	icm	4.0 MB	20.2 MB	24.2 MB	0.3 KB/s	165.4 KB	24:00:01
3	poznan	1.7 MB	569.9 KB	2.3 MB	0.0 KB/s	4.4 KB	24:00:01
4	nask	75.1 KB	21.9 MB	22.0 MB	0.3 KB/s	608.0 KB	24:00:01
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:54
TOTAL: 5		9.8 MB	44.4 MB	54.2 MB	0.1 KB/s	31.3 KB	119:57:58

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	82	90.2 KB	39	0	00:00:29
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:04
TOTAL: 2		290	82	90.2 KB	39	2	00:07:46

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	674	82	90.2 KB	39	2	00:00:38
2	*.toya.net.pl	2	0	0.0 KB	0	0	00:07:07
TOTAL: 2		676	82	90.2 KB	39	2	00:07:46

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
staticline-31-182-152-66.toya.net.pl	0.040	0.028	00:07:07
web.man.lodz.pl	1.076	3.308	00:00:29
isvcs01.man.lodz.pl	0.012	0.032	00:00:04
mon.man.lodz.pl	0.824	3.084	00:00:03
david.man.lodz.pl	0.276	1.040	00:00:01
TOTAL: 5	2.228	7.492	00:07:46

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline-31-182-152-66.toya.net.pl	2
TOTAL: 3	386

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	60
2	pl.comp.pecet	22
TOTAL: 2		82

Daily Usenet report

Nov 6 04:15:02 -- Nov 7 04:15:05