Daily Usenet report: Oct 14 04:15:03

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Oct 14 10:33:25 newsfeed overchan[21880]: input line too long, skipping
Oct 14 18:35:23 newsfeed overchan[21880]: input line too long, skipping
Oct 14 18:35:55 newsfeed overchan[21880]: input line too long, skipping
Oct 14 18:36:42 newsfeed overchan[21880]: input line too long, skipping
Oct 14 18:37:29 newsfeed overchan[21880]: input line too long, skipping
Oct 14 18:53:16 newsfeed overchan[21880]: input line too long, skipping
Oct 14 20:20:19 newsfeed overchan[21880]: input line too long, skipping
Oct 14 20:27:13 newsfeed overchan[21880]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2659911	97.4%	301.7 MB	97.1%
innfeed	46054	1.7%	5.5 MB	1.8%
innd	19089	0.7%	3.1 MB	1.0%
nnrpd	4848	0.2%	513.7 KB	0.2%
overchan	9	0.0%	1.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2729912	100.0%	310.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2637490	93.4%
Positive hits	92418	3.3%
Negative hits	91106	3.2%
Cache misses	2837	0.1%
TOTAL: 4	2823851	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:01:13.087	0.1%	2190	0.000	33.373	266.000
article cleanup	00:00:34.642	0.0%	2654729	0.010	0.013	0.020
article logging	00:01:56.786	0.1%	2655221	0.033	0.044	0.077
article parse	00:42:35.503	3.0%	78388230	0.018	0.033	0.048
article write	00:17:28.867	1.2%	2648083	0.190	0.396	0.695
artlog/artcncl	00:00:00.089	0.0%	2178	0.000	0.041	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:59.765	0.2%	91678282	0.001	0.002	0.005
hisgrep/artcncl	00:00:24.927	0.0%	1982	0.000	12.577	87.000
hishave/artcncl	00:00:05.545	0.0%	2190	0.000	2.532	12.700
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:56:47.606	8.1%	2836166	0.584	2.471	7.729
history sync	00:00:00.013	0.0%	290	0.000	0.045	1.000
history write	04:27:58.216	18.6%	2650306	1.653	6.067	15.100
hiswrite/artcncl	00:00:01.292	0.0%	208	6.212	6.212	6.212
idle	10:18:32.950	43.0%	53953267	0.247	0.688	1.705
nntp read	01:00:02.758	4.2%	76432652	0.032	0.047	0.062
overview write	00:00:13.857	0.0%	2648083	0.003	0.005	0.008
perl filter	04:41:31.445	19.5%	2650306	4.225	6.373	8.472
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:19.355	0.4%	5497224	0.042	0.058	0.078
TOTAL: 24:00:04.445	23:37:46.703	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.262	0.0%	465564	0.000	0.003	0.008
article prepare	00:00:00.119	0.0%	437584	0.000	0.000	0.001
article read	00:01:32.234	0.1%	99205	0.362	0.930	32.667
backlog stats	00:00:02.113	0.0%	2015096	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:17.482	0.0%	814805	0.011	0.021	0.030
data write	00:06:40.990	0.5%	1232402	0.098	0.325	0.516
idle	23:40:43.225	99.3%	2015096	7.536	42.302	180.665
status file	00:00:26.782	0.0%	16884	0.675	1.586	12.756
TOTAL: 23:50:43.451	23:49:44.207	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:19.504	57.6%	3018	0.000	6.463	1108.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.522	1.5%	6692	0.000	0.078	2.000
readart	00:00:00.003	0.0%	40	0.000	0.075	0.500
TOTAL: 00:00:33.886	00:00:20.029	59.1%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	798	2648427	2644290	1679	2458	99%	517:19:55
2	news.nask.pl	2	96587	5748	86703	4136	5%	23:42:35
3	news.icm.edu.pl	43	223	92	95	36	41%	17:06:30
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		844	2745237	2650130	88477	6630	96%	558:09:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	647.6 GB	101.6 MB	103.6 MB	647.8 GB	99%	256.6 KB
2	news.nask.pl	1.1 GB	637.8 MB	654.1 MB	2.4 GB	46%	251.1 KB
3	news.icm.edu.pl	2.4 MB	78.8 KB	1.7 MB	4.2 MB	56%	33.5 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		648.7 GB	739.4 MB	759.4 MB	650.2 GB	99%	256.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 14 04:15:03 - 04:59:59	79263	3.0%	29.39	25.7 GB	4.0%	9989.51
Oct 14 05:00:00 - 05:59:59	110352	4.2%	30.65	36.4 GB	5.6%	10601.25
Oct 14 06:00:00 - 06:59:59	107849	4.1%	29.96	35.9 GB	5.5%	10445.06
Oct 14 07:00:00 - 07:59:59	81973	3.1%	22.77	26.7 GB	4.1%	7765.69
Oct 14 08:00:00 - 08:59:59	68647	2.6%	19.07	22.1 GB	3.4%	6441.92
Oct 14 09:00:00 - 09:59:59	78321	3.0%	21.76	23.5 GB	3.6%	6832.44
Oct 14 10:00:00 - 10:59:59	94135	3.6%	26.15	21.2 GB	3.3%	6167.69
Oct 14 11:00:00 - 11:59:59	130608	4.9%	36.28	22.9 GB	3.5%	6680.46
Oct 14 12:00:00 - 12:59:59	125283	4.7%	34.80	32.8 GB	5.1%	9565.75
Oct 14 13:00:00 - 13:59:59	90634	3.4%	25.18	29.3 GB	4.5%	8523.85
Oct 14 14:00:00 - 14:59:59	76178	2.9%	21.16	22.7 GB	3.5%	6624.31
Oct 14 15:00:00 - 15:59:59	142384	5.4%	39.55	30.5 GB	4.7%	8876.97
Oct 14 16:00:00 - 16:59:59	111955	4.2%	31.10	32.2 GB	5.0%	9373.17
Oct 14 17:00:00 - 17:59:59	152165	5.7%	42.27	27.1 GB	4.2%	7882.26
Oct 14 18:00:00 - 18:59:59	118372	4.5%	32.88	23.6 GB	3.6%	6865.82
Oct 14 19:00:00 - 19:59:59	81121	3.1%	22.53	19.5 GB	3.0%	5680.58
Oct 14 20:00:00 - 20:59:59	151412	5.7%	42.06	22.1 GB	3.4%	6442.24
Oct 14 21:00:00 - 21:59:59	176102	6.6%	48.92	34.1 GB	5.2%	9927.84
Oct 14 22:00:00 - 22:59:59	107203	4.0%	29.78	23.5 GB	3.6%	6858.10
Oct 14 23:00:00 - 23:59:59	66484	2.5%	18.47	16.7 GB	2.6%	4859.84
Oct 15 00:00:00 - 00:59:59	106640	4.0%	29.62	20.2 GB	3.1%	5889.92
Oct 15 01:00:00 - 01:59:59	123952	4.7%	34.43	30.1 GB	4.6%	8777.79
Oct 15 02:00:00 - 02:59:59	119782	4.5%	33.27	32.7 GB	5.0%	9510.07
Oct 15 03:00:00 - 03:59:59	124867	4.7%	34.69	31.4 GB	4.8%	9159.06
Oct 15 04:00:00 - 04:15:03	24906	0.9%	27.58	6.6 GB	1.0%	7650.98
TOTAL: 24:00:00	2650588	100.0%	30.68	649.4 GB	100.0%	7881.46

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	4251	13	2112	1	2125
2	newsfeed.pionier.net.pl	2857	112	2315	0	430
3	news.icm.edu.pl	37	0	7	0	30
TOTAL: 3		7145	125	4434	1	2585

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	36
comp.mobile.android	35
it.comp.os.win.windows10	23
it.tlc.cellulari.android	22
it.comp.os.win.windows7	7
nl.comp.sys.android	1
rec.arts.tv.x-factor	1
TOTAL: 7	125

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1949
Binary in non-binary group	46
EMP (phl)	44
Scoring filter (9)	20
Scoring filter (16)	10
Scoring filter (8)	7
Scoring filter (11)	6
Scoring filter (10)	5
EMP (fsl)	2
Scoring filter (18)	1
Too many newsgroups	1
Scoring filter (12)	1
Angle-bracket bot	1
TOTAL: 13	2093

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	399
	news.nask.pl	92
	news.icm.edu.pl	1
	TOTAL: 3	492
TOTAL: 1		492

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	nask	253433	97002	92682	56	0	890	38%	23:59:57
2	panorama	282012	354	253456	600	2	211363	0%	23:59:57
3	poznan	5386	97	3893	14	0	0	1%	23:59:57
4	icm	229899	28	188344	11568	0	0	0%	23:59:57
5	okapi	0	0	0	0	0	987	0%	23:57:50
TOTAL: 5		770730	97481	538375	12238	2	213240	12%	119:57:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	55.8 GB	29.8 MB	55.9 GB	678.1 KB/s	603.6 KB	23:59:57
2	panorama	20.2 MB	8.0 MB	28.2 MB	0.3 KB/s	30.2 KB	23:59:57
3	icm	2.7 MB	6.6 GB	6.6 GB	79.9 KB/s	595.2 KB	23:59:57
4	poznan	322.1 KB	66.9 KB	389.0 KB	0.0 KB/s	3.5 KB	23:59:57
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		55.9 GB	6.6 GB	62.5 GB	151.7 KB/s	597.1 KB	119:57:38

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	40	41.8 KB	20	0	0	00:00:26
TOTAL: 1		288	40	41.8 KB	20	0	0	00:00:33

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	576	40	41.8 KB	20	00:00:30
2	unresolved	98	0	0.0 KB	0	00:00:02
TOTAL: 2		674	40	41.8 KB	20	00:00:33

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.608	7.972	00:00:26
mon.man.lodz.pl	1.440	7.084	00:00:04
212.51.192.185	0.440	2.284	00:00:01
185.100.87.250	0.012	0.044	00:00:01
TOTAL: 4	3.500	17.384	00:00:33

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	96
185.100.87.250	2
TOTAL: 3	386

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.os.ms-windows.winnt	36
2	pl.comp.pecet	4
TOTAL: 2		40

Daily Usenet report

Oct 14 04:15:03 -- Oct 15 04:15:03