Daily Usenet report: Jun 29 04:15:02

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Jun 29 04:21:45 newsfeed overchan[7436]: input line too long, skipping
Jun 29 04:25:45 newsfeed overchan[7436]: input line too long, skipping
Jun 29 06:30:05 newsfeed overchan[7436]: input line too long, skipping
Jun 29 07:31:56 newsfeed overchan[7436]: input line too long, skipping
Jun 29 08:42:22 newsfeed overchan[7436]: input line too long, skipping
Jun 29 10:26:12 newsfeed nnrpd[22343]: SERVER perl filter not defined
Jun 29 11:34:29 newsfeed nnrpd[25056]: SERVER perl filter not defined
Jun 29 12:24:08 newsfeed nnrpd[26923]: SERVER perl filter not defined
Jun 29 13:44:02 newsfeed overchan[7436]: input line too long, skipping
Jun 29 14:46:57 newsfeed nnrpd[32239]: SERVER perl filter not defined
Jun 29 15:29:30 newsfeed overchan[7436]: input line too long, skipping
Jun 29 17:49:51 newsfeed nnrpd[6599]: SERVER perl filter not defined
Jun 29 18:14:45 newsfeed overchan[7436]: input line too long, skipping
Jun 29 20:41:43 newsfeed overchan[7436]: input line too long, skipping
Jun 29 20:42:20 newsfeed overchan[7436]: input line too long, skipping
Jun 29 20:42:42 newsfeed overchan[7436]: input line too long, skipping
Jun 29 21:40:06 newsfeed nnrpd[15356]: SERVER perl filter not defined
Jun 30 01:07:12 newsfeed overchan[7436]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2406384	97.1%	278.1 MB	96.8%
innfeed	45288	1.8%	5.3 MB	1.8%
innd	20546	0.8%	3.3 MB	1.1%
nnrpd	4795	0.2%	506.3 KB	0.2%
overchan	13	0.0%	2.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2477027	100.0%	287.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2397182	96.4%
Negative hits	76930	3.1%
Positive hits	12431	0.5%
Cache misses	110	0.0%
TOTAL: 4	2486653	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.799	0.0%	178	0.000	15.725	1900.000
article cleanup	00:00:30.159	0.0%	2410754	0.010	0.013	0.019
article logging	00:01:24.715	0.1%	2411373	0.028	0.035	0.089
article parse	00:51:57.200	3.6%	204851751	0.009	0.015	0.029
article write	00:19:19.080	1.3%	2401656	0.357	0.483	1.541
artlog/artcncl	00:00:00.005	0.0%	176	0.000	0.028	0.250
data move	00:02:48.777	0.2%	219879686	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.939	0.0%	155	0.000	6.058	771.000
hishave/artcncl	00:00:00.161	0.0%	178	0.000	0.904	38.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:40:24.160	2.8%	2496678	0.050	0.971	4.930
history sync	00:00:00.011	0.0%	290	0.000	0.038	1.000
history write	01:41:44.245	7.1%	2406981	0.204	2.536	7.600
hiswrite/artcncl	00:00:00.131	0.0%	23	0.000	5.696	71.000
idle	14:53:58.375	62.1%	138189218	0.245	0.388	0.713
nntp read	00:58:59.970	4.1%	202835076	0.014	0.017	0.028
overview write	00:00:12.140	0.0%	2401656	0.003	0.005	0.008
perl filter	04:03:56.962	16.9%	2406981	5.051	6.081	7.717
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:34.757	0.2%	4826425	0.035	0.044	0.070
TOTAL: 24:00:08.515	23:38:54.586	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.162	0.0%	72299	0.000	0.002	0.015
article prepare	00:00:00.005	0.0%	11358	0.000	0.000	0.028
article read	00:01:07.987	0.1%	2829	0.000	24.032	1139.000
backlog stats	00:00:00.168	0.0%	191672	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	3	0.000	0.000	0.000
data read	00:00:01.856	0.0%	103357	0.007	0.018	0.037
data write	00:00:04.140	0.0%	82593	0.011	0.050	0.212
idle	23:53:15.053	99.9%	191672	142.316	448.657	704.895
status file	00:00:12.053	0.0%	16065	0.483	0.750	1.052
TOTAL: 23:54:56.648	23:54:41.424	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:43.504	78.7%	3061	0.000	14.212	2715.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.124	0.2%	6714	0.000	0.018	1.000
readart	00:00:00.000	0.0%	24	0.000	0.000	0.000
TOTAL: 00:00:55.263	00:00:43.628	78.9%	-	-	-	-

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	677	2396591	2387382	5353	3856	99%	396:31:08
2	news.nask.pl	2	17855	9527	3040	5288	53%	23:55:19
3	news.icm.edu.pl	43	260	21	237	2	8%	16:47:03
4	localhost	7	6	6	0	0	100%	00:00:00
TOTAL: 4		729	2414712	2396936	8630	9146	99%	437:13:30

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	734.7 GB	38.8 MB	39.6 MB	734.8 GB	99%	322.2 KB
2	news.nask.pl	60.2 MB	496.9 KB	25.7 MB	86.4 MB	69%	6.0 KB
3	news.icm.edu.pl	1.1 MB	0.0 KB	74.3 KB	1.2 MB	93%	51.4 KB
4	localhost	9.6 KB	0.0 KB	0.0 KB	9.6 KB	100%	1.6 KB
TOTAL: 4		734.8 GB	39.2 MB	65.4 MB	734.9 GB	99%	320.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 29 04:15:02 - 04:59:59	91851	3.8%	34.04	29.3 GB	4.0%	11390.68
Jun 29 05:00:00 - 05:59:59	113709	4.7%	31.59	38.4 GB	5.2%	11193.69
Jun 29 06:00:00 - 06:59:59	134951	5.6%	37.49	43.4 GB	5.9%	12648.48
Jun 29 07:00:00 - 07:59:59	136476	5.7%	37.91	44.9 GB	6.1%	13070.48
Jun 29 08:00:00 - 08:59:59	112210	4.7%	31.17	40.5 GB	5.5%	11808.22
Jun 29 09:00:00 - 09:59:59	117759	4.9%	32.71	40.1 GB	5.5%	11693.29
Jun 29 10:00:00 - 10:59:59	111825	4.7%	31.06	39.7 GB	5.4%	11576.68
Jun 29 11:00:00 - 11:59:59	98730	4.1%	27.43	33.7 GB	4.6%	9827.85
Jun 29 12:00:00 - 12:59:59	116374	4.9%	32.33	39.2 GB	5.3%	11421.32
Jun 29 13:00:00 - 13:59:59	121106	5.1%	33.64	34.3 GB	4.7%	10001.46
Jun 29 14:00:00 - 14:59:59	119395	5.0%	33.17	32.8 GB	4.5%	9539.91
Jun 29 15:00:00 - 15:59:59	120695	5.0%	33.53	32.9 GB	4.5%	9587.76
Jun 29 16:00:00 - 16:59:59	114877	4.8%	31.91	31.9 GB	4.3%	9293.33
Jun 29 17:00:00 - 17:59:59	114694	4.8%	31.86	33.1 GB	4.5%	9629.26
Jun 29 18:00:00 - 18:59:59	58202	2.4%	16.17	17.2 GB	2.3%	5003.78
Jun 29 19:00:00 - 19:59:59	56011	2.3%	15.56	15.5 GB	2.1%	4523.22
Jun 29 20:00:00 - 20:59:59	53833	2.2%	14.95	16.5 GB	2.2%	4809.53
Jun 29 21:00:00 - 21:59:59	52140	2.2%	14.48	14.3 GB	2.0%	4177.05
Jun 29 22:00:00 - 22:59:59	47549	2.0%	13.21	12.8 GB	1.7%	3732.17
Jun 29 23:00:00 - 23:59:59	54309	2.3%	15.09	15.2 GB	2.1%	4435.18
Jun 30 00:00:00 - 00:59:59	115437	4.8%	32.07	32.0 GB	4.4%	9317.83
Jun 30 01:00:00 - 01:59:59	119403	5.0%	33.17	34.6 GB	4.7%	10073.72
Jun 30 02:00:00 - 02:59:59	109420	4.6%	30.39	31.9 GB	4.3%	9286.10
Jun 30 03:00:00 - 03:59:59	92723	3.9%	25.76	26.8 GB	3.7%	7817.52
Jun 30 04:00:00 - 04:15:02	12794	0.5%	14.18	3.5 GB	0.5%	4123.86
TOTAL: 24:00:00	2396473	100.0%	27.74	734.8 GB	100.0%	8918.24

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	5419	34	206	4	5175
2	newsfeed.pionier.net.pl	4314	215	3582	3	514
3	news.icm.edu.pl	2	0	0	0	2
TOTAL: 3		9735	249	3788	7	5691

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	89
it.comp.os.win.windows10	64
comp.mobile.android	34
it.tlc.cellulari.android	30
comp.sys.raspberry-pi	10
it.comp.os.win.windows7	9
comp.mobile.ipad	6
uk.rec.cycling.moderated	3
de.comp.lang.php	2
hr.ponuda.hardver.komponente	1
it.comp.virtualizzazione	1
TOTAL: 11	249

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

Groups	Count
pl.praca.oferowana	6
bit.listserv.catholic	1
TOTAL: 2	7

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4854
Binary in non-binary group	77
Scoring filter (8)	49
Scoring filter (9)	36
Scoring filter (12)	14
HTML post	9
Too many newsgroups	8
Scoring filter (11)	7
Scoring filter (10)	7
Poison newsgroup	5
Scoring filter (20)	4
Scoring filter (13)	2
Scoring filter (15)	2
TOTAL: 13	5074

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	457
	news.nask.pl	160
	TOTAL: 2	617
TOTAL: 1		617

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	54334	534	26844	195	9	44901	0%	23:59:58
2	poznan	14306	328	9140	35	0	0	2%	23:59:57
3	icm	28997	75	21289	1298	0	0	0%	23:59:49
4	nask	7504	8	5424	1	0	0	0%	23:59:58
5	okapi	0	0	0	0	0	2364	0%	23:57:51
TOTAL: 5		105141	945	62697	1529	9	47265	0%	119:57:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	10.7 MB	462.1 MB	472.8 MB	5.6 KB/s	352.6 KB	23:59:49
2	poznan	1.9 MB	133.7 KB	2.0 MB	0.0 KB/s	5.6 KB	23:59:57
3	panorama	1.7 MB	686.3 KB	2.4 MB	0.0 KB/s	3.3 KB	23:59:58
4	nask	18.2 KB	1.6 KB	19.8 KB	0.0 KB/s	2.2 KB	23:59:58
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		14.3 MB	462.9 MB	477.2 MB	1.1 KB/s	197.5 KB	119:57:33

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	24	39.0 KB	11	0	00:00:21
2	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 2		294	24	39.0 KB	11	6	00:00:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	678	24	39.0 KB	11	6	00:00:27
2	*.dynamic.gprs.plus.pl	4	0	0.0 KB	0	0	00:00:26
3	unresolved	1	0	0.0 KB	0	0	00:00:01
TOTAL: 3		683	24	39.0 KB	11	6	00:00:54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
apn-37-248-163-126.dynamic.gprs.plus.pl	0.016	0.032	00:00:26
web.man.lodz.pl	1.084	2.632	00:00:21
mon.man.lodz.pl	0.916	2.232	00:00:03
david.man.lodz.pl	0.308	0.728	00:00:01
185.181.102.18	0.000	0.004	00:00:01
isvcs01.man.lodz.pl	0.032	0.072	00:00:00
TOTAL: 6	2.356	5.700	00:00:54

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
apn-37-248-163-126.dynamic.gprs.plus.pl	4
185.181.102.18	1
TOTAL: 4	389

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	16
2	pl.comp.os.ms-windows.winnt	8
TOTAL: 2		24

Daily Usenet report

Jun 29 04:15:02 -- Jun 30 04:15:02