Daily Usenet report: May 26 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

May 26 05:08:57 newsfeed overchan[28642]: input line too long, skipping
May 26 05:18:01 newsfeed overchan[28642]: input line too long, skipping
May 26 05:35:43 newsfeed overchan[28642]: input line too long, skipping
May 26 06:45:54 newsfeed overchan[28642]: input line too long, skipping
May 26 08:48:41 newsfeed overchan[28642]: input line too long, skipping
May 26 11:05:21 newsfeed overchan[28642]: input line too long, skipping
May 26 15:06:56 newsfeed overchan[28642]: input line too long, skipping
May 26 23:51:47 newsfeed overchan[28642]: input line too long, skipping
May 26 23:52:05 newsfeed overchan[28642]: input line too long, skipping
May 26 23:52:41 newsfeed overchan[28642]: input line too long, skipping
May 26 23:55:03 newsfeed overchan[28642]: input line too long, skipping
May 27 02:15:13 newsfeed overchan[28642]: input line too long, skipping
May 27 02:50:09 newsfeed nnrpd[16642]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3046853	97.7%	360.3 MB	97.5%
innfeed	43839	1.4%	5.2 MB	1.4%
innd	23360	0.7%	3.7 MB	1.0%
nnrpd	4742	0.2%	497.1 KB	0.1%
overchan	13	0.0%	2.4 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3118808	100.0%	369.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3022504	97.3%
Negative hits	72336	2.3%
Positive hits	12918	0.4%
Cache misses	101	0.0%
TOTAL: 4	3107859	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.582	0.0%	182	0.000	14.187	122.000
article cleanup	00:00:36.285	0.0%	3045220	0.009	0.012	0.015
article logging	00:01:52.059	0.1%	3045738	0.026	0.037	0.133
article parse	01:06:52.874	4.6%	224566543	0.012	0.018	0.030
article write	01:24:31.033	5.9%	3036538	0.360	1.670	5.024
artlog/artcncl	00:00:00.005	0.0%	178	0.000	0.028	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:39.529	0.3%	243803532	0.001	0.001	0.001
hisgrep/artcncl	00:00:01.574	0.0%	162	0.000	9.716	120.000
hishave/artcncl	00:00:00.037	0.0%	182	0.000	0.203	1.778
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:32:43.720	2.3%	3126391	0.113	0.628	3.014
history sync	00:00:00.008	0.0%	290	0.000	0.028	1.000
history write	01:26:46.739	6.0%	3040280	0.170	1.713	7.849
hiswrite/artcncl	00:00:00.073	0.0%	20	0.000	3.650	6.778
idle	11:44:41.366	48.9%	151690072	0.187	0.279	0.439
nntp read	01:22:06.340	5.7%	222131791	0.016	0.022	0.029
overview write	00:00:15.814	0.0%	3036538	0.004	0.005	0.007
perl filter	05:22:05.790	22.4%	3040280	5.521	6.357	7.465
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:54.562	0.4%	6412292	0.034	0.055	0.090
TOTAL: 24:00:02.328	23:12:10.390	96.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:01.438	0.0%	562672	0.000	0.003	0.039
article prepare	00:00:00.338	0.0%	1316492	0.000	0.000	0.013
article read	00:01:48.608	0.1%	328711	0.000	0.330	388.000
backlog stats	00:00:01.354	0.0%	1526304	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	7	0.000	0.000	0.000
data read	00:00:14.079	0.0%	816501	0.004	0.017	0.057
data write	00:04:57.687	0.3%	745991	0.017	0.399	0.539
idle	23:44:16.713	99.4%	1526304	16.335	55.989	970.774
status file	00:00:12.733	0.0%	16631	0.558	0.766	3.000
TOTAL: 23:52:24.193	23:51:32.950	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:15.874	50.1%	3020	0.000	5.256	35.556
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.181	0.6%	6688	0.000	0.027	1.000
readart	00:00:00.001	0.0%	38	0.000	0.026	0.500
TOTAL: 00:00:31.710	00:00:16.056	50.6%	-	-	-	-

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	955	3037913	3028487	4622	4804	99%	457:37:45
2	news.nask.pl	2	15685	8770	3071	3844	55%	23:56:17
3	news.icm.edu.pl	42	331	35	267	29	10%	18:14:37
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		1001	3053930	3037293	7960	8677	99%	499:48:39

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	923.7 GB	292.4 MB	293.3 MB	924.3 GB	99%	319.5 KB
2	news.nask.pl	40.3 MB	754.6 KB	23.2 MB	64.3 MB	62%	5.2 KB
3	news.icm.edu.pl	964.7 KB	8.7 KB	1.3 MB	2.3 MB	41%	36.3 KB
4	localhost	1.2 KB	0.0 KB	0.0 KB	1.2 KB	100%	1.2 KB
TOTAL: 4		923.8 GB	293.2 MB	317.8 MB	924.4 GB	99%	318.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 26 04:15:02 - 04:59:59	91144	3.0%	33.78	31.6 GB	3.4%	12290.20
May 26 05:00:00 - 05:59:59	119180	3.9%	33.11	43.2 GB	4.7%	12573.09
May 26 06:00:00 - 06:59:59	122937	4.0%	34.15	42.7 GB	4.6%	12434.13
May 26 07:00:00 - 07:59:59	123455	4.1%	34.29	39.8 GB	4.3%	11585.92
May 26 08:00:00 - 08:59:59	134240	4.4%	37.29	37.6 GB	4.1%	10944.83
May 26 09:00:00 - 09:59:59	127361	4.2%	35.38	34.2 GB	3.7%	9949.64
May 26 10:00:00 - 10:59:59	144593	4.8%	40.16	39.2 GB	4.3%	11422.52
May 26 11:00:00 - 11:59:59	118174	3.9%	32.83	32.6 GB	3.5%	9507.19
May 26 12:00:00 - 12:59:59	141961	4.7%	39.43	37.2 GB	4.0%	10838.60
May 26 13:00:00 - 13:59:59	142155	4.7%	39.49	38.3 GB	4.2%	11167.65
May 26 14:00:00 - 14:59:59	137410	4.5%	38.17	38.1 GB	4.1%	11087.65
May 26 15:00:00 - 15:59:59	134815	4.4%	37.45	37.3 GB	4.0%	10861.44
May 26 16:00:00 - 16:59:59	123620	4.1%	34.34	37.5 GB	4.1%	10919.24
May 26 17:00:00 - 17:59:59	116965	3.9%	32.49	37.1 GB	4.0%	10793.76
May 26 18:00:00 - 18:59:59	119272	3.9%	33.13	37.7 GB	4.1%	10974.51
May 26 19:00:00 - 19:59:59	121870	4.0%	33.85	36.8 GB	4.0%	10731.40
May 26 20:00:00 - 20:59:59	120611	4.0%	33.50	38.1 GB	4.1%	11092.66
May 26 21:00:00 - 21:59:59	119297	3.9%	33.14	38.7 GB	4.2%	11259.15
May 26 22:00:00 - 22:59:59	116285	3.8%	32.30	37.3 GB	4.0%	10856.04
May 26 23:00:00 - 23:59:59	114870	3.8%	31.91	36.6 GB	4.0%	10663.40
May 27 00:00:00 - 00:59:59	120424	4.0%	33.45	36.4 GB	3.9%	10608.39
May 27 01:00:00 - 01:59:59	138645	4.6%	38.51	42.7 GB	4.6%	12446.54
May 27 02:00:00 - 02:59:59	133003	4.4%	36.95	43.1 GB	4.7%	12566.82
May 27 03:00:00 - 03:59:59	122648	4.0%	34.07	38.5 GB	4.2%	11224.39
May 27 04:00:00 - 04:15:02	32548	1.1%	36.08	10.2 GB	1.1%	11863.57
TOTAL: 24:00:00	3037483	100.0%	35.16	922.5 GB	100.0%	11195.51

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	5139	96	4643	4	396
2	news.nask.pl	4024	29	284	5	3706
3	news.icm.edu.pl	29	0	1	0	28
TOTAL: 3		9192	125	4928	9	4130

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	43
it.comp.os.win.windows10	26
it.tlc.cellulari.android	17
comp.mobile.android	15
de.comp.lang.vbclassic	6
de.comp.lang.php	6
comp.sys.raspberry-pi	6
comp.mobile.ipad	3
hr.ponuda.hardver.komponente	2
alt.sex.telephones	1
TOTAL: 10	125

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

Groups	Count
pl.praca.oferowana	8
bit.listserv.catholic	1
TOTAL: 2	9

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3281
EMP (phl)	155
Binary in non-binary group	121
Scoring filter (8)	14
Scoring filter (9)	10
Scoring filter (13)	7
Scoring filter (11)	6
HTML post	5
Scoring filter (10)	5
Too many newsgroups	3
EMP (fsl)	2
Scoring filter (12)	1
Scoring filter (14)	1
TOTAL: 13	3611

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	338
	news.nask.pl	181
	TOTAL: 2	519
TOTAL: 1		519

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	340379	319562	12268	6719	7	831	93%	23:59:25
2	panorama	243958	1197	213832	1090	13	345777	0%	23:59:58
3	poznan	13791	232	8556	14	0	2	1%	23:59:58
4	nask	6370	34	4345	16	0	0	0%	23:59:58
5	okapi	0	0	0	0	0	1868	0%	23:57:51
TOTAL: 5		604498	321025	239001	7839	20	348478	53%	119:57:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	57.4 GB	25.1 MB	57.4 GB	696.7 KB/s	184.4 KB	23:59:25
2	panorama	4.5 MB	54.0 MB	58.5 MB	0.7 KB/s	26.2 KB	23:59:58
3	poznan	988.9 KB	39.9 KB	1.0 MB	0.0 KB/s	4.2 KB	23:59:58
4	nask	65.1 KB	2.1 MB	2.1 MB	0.0 KB/s	43.4 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		57.4 GB	81.2 MB	57.4 GB	139.5 KB/s	183.2 KB	119:57:10

Backlog files shrunk by innfeed:

Server	Size
panorama	11.4 MB
okapi	488.3 KB
TOTAL: 2	11.9 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	38	61.7 KB	17	0	00:00:25
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	38	61.7 KB	17	1	00:00:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	672	38	61.7 KB	17	1	0	00:00:31
TOTAL: 1		672	38	61.7 KB	17	1	0	00:00:31

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.104	4.232	00:00:25
mon.man.lodz.pl	1.060	4.304	00:00:04
david.man.lodz.pl	0.348	1.192	00:00:01
isvcs01.man.lodz.pl	0.008	0.020	00:00:00
TOTAL: 4	2.520	9.748	00:00:31

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	95
TOTAL: 2	383

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	34
2	pl.comp.os.ms-windows.winnt	4
TOTAL: 2		38

Daily Usenet report

May 26 04:15:02 -- May 27 04:15:02