Daily Usenet report: May 28 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

May 28 05:58:05 newsfeed overchan[11153]: input line too long, skipping
May 28 08:53:26 newsfeed overchan[11153]: input line too long, skipping
May 28 10:04:47 newsfeed nnrpd[25084]: SERVER perl filter not defined
May 28 10:06:06 newsfeed overchan[11153]: input line too long, skipping
May 28 11:28:13 newsfeed nnrpd[28405]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3314756	97.6%	389.9 MB	97.4%
innfeed	48297	1.4%	5.7 MB	1.4%
innd	26446	0.8%	4.3 MB	1.1%
nnrpd	5441	0.2%	575.6 KB	0.1%
overchan	4	0.0%	0.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3394945	100.0%	400.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3289146	97.9%
Negative hits	61660	1.8%
Positive hits	10331	0.3%
Cache misses	103	0.0%
TOTAL: 4	3361240	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.350	0.0%	257	0.000	9.144	697.000
article cleanup	00:00:39.692	0.0%	3313571	0.009	0.012	0.017
article logging	00:01:59.169	0.1%	3314022	0.026	0.036	0.139
article parse	01:13:09.084	5.1%	239050160	0.013	0.018	0.032
article write	00:24:20.975	1.7%	3304390	0.345	0.442	2.612
artlog/artcncl	00:00:00.006	0.0%	232	0.000	0.026	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:04:23.319	0.3%	259755576	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.721	0.0%	224	0.000	3.219	102.000
hishave/artcncl	00:00:00.092	0.0%	257	0.000	0.358	3.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:32:01.999	2.2%	3381792	0.040	0.568	4.428
history sync	00:00:00.016	0.0%	290	0.000	0.055	1.000
history write	01:31:33.174	6.4%	3308766	0.127	1.660	7.479
hiswrite/artcncl	00:00:00.415	0.0%	33	0.000	12.576	32.000
idle	11:54:07.188	49.6%	159511158	0.187	0.269	0.358
nntp read	01:33:48.851	6.5%	236379486	0.017	0.024	0.034
overview write	00:00:16.598	0.0%	3304390	0.004	0.005	0.006
perl filter	05:49:06.347	24.2%	3308764	5.818	6.331	7.852
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:42.022	0.3%	6639241	0.034	0.042	0.062
TOTAL: 24:00:01.477	23:10:12.018	96.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.221	0.0%	84556	0.000	0.003	0.013
article prepare	00:00:00.016	0.0%	60758	0.000	0.000	0.013
article read	00:00:28.125	0.0%	15182	0.000	1.853	103.500
backlog stats	00:00:00.186	0.0%	215546	0.000	0.001	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.584	0.0%	113714	0.005	0.023	0.061
data write	00:00:15.302	0.0%	94662	0.017	0.162	0.464
idle	23:52:15.317	99.9%	215546	22.062	398.687	884.779
status file	00:00:13.634	0.0%	16947	0.558	0.805	2.550
TOTAL: 23:53:33.291	23:53:15.385	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:27.028	62.7%	3279	0.000	8.243	222.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.196	0.5%	7239	0.000	0.027	1.000
readart	00:00:00.003	0.0%	16	0.000	0.188	0.500
TOTAL: 00:00:43.112	00:00:27.227	63.2%	-	-	-	-

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	1205	3304708	3297386	2667	4655	99%	429:02:22
2	news.nask.pl	2	14706	7624	2579	4503	51%	24:01:59
3	news.icm.edu.pl	50	281	24	226	31	8%	17:19:01
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		1260	3319697	3305036	5472	9189	99%	470:23:22

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	990.7 GB	24.8 MB	26.0 MB	990.7 GB	99%	314.6 KB
2	news.nask.pl	33.0 MB	640.6 KB	25.9 MB	59.6 MB	55%	5.0 KB
3	news.icm.edu.pl	544.0 KB	212.5 KB	1.7 MB	2.5 MB	21%	46.1 KB
4	localhost	6.3 KB	0.0 KB	0.0 KB	6.3 KB	100%	3.2 KB
TOTAL: 4		990.7 GB	25.7 MB	53.6 MB	990.8 GB	99%	313.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 28 04:15:02 - 04:59:59	97668	3.0%	36.20	30.9 GB	3.1%	11996.71
May 28 05:00:00 - 05:59:59	135445	4.1%	37.62	42.7 GB	4.3%	12448.07
May 28 06:00:00 - 06:59:59	114269	3.5%	31.74	36.3 GB	3.7%	10579.35
May 28 07:00:00 - 07:59:59	134408	4.1%	37.34	43.5 GB	4.4%	12665.09
May 28 08:00:00 - 08:59:59	132495	4.0%	36.80	42.5 GB	4.3%	12390.38
May 28 09:00:00 - 09:59:59	129863	3.9%	36.07	39.6 GB	4.0%	11543.10
May 28 10:00:00 - 10:59:59	145467	4.4%	40.41	40.5 GB	4.1%	11792.51
May 28 11:00:00 - 11:59:59	122125	3.7%	33.92	34.9 GB	3.5%	10155.89
May 28 12:00:00 - 12:59:59	149897	4.5%	41.64	42.6 GB	4.3%	12407.71
May 28 13:00:00 - 13:59:59	151388	4.6%	42.05	42.4 GB	4.3%	12345.44
May 28 14:00:00 - 14:59:59	143948	4.4%	39.99	42.4 GB	4.3%	12358.82
May 28 15:00:00 - 15:59:59	133534	4.0%	37.09	39.8 GB	4.0%	11578.04
May 28 16:00:00 - 16:59:59	138308	4.2%	38.42	40.8 GB	4.1%	11890.77
May 28 17:00:00 - 17:59:59	144385	4.4%	40.11	42.3 GB	4.3%	12320.79
May 28 18:00:00 - 18:59:59	146152	4.4%	40.60	42.0 GB	4.3%	12241.39
May 28 19:00:00 - 19:59:59	145778	4.4%	40.49	43.1 GB	4.4%	12539.87
May 28 20:00:00 - 20:59:59	148437	4.5%	41.23	44.0 GB	4.5%	12824.21
May 28 21:00:00 - 21:59:59	146170	4.4%	40.60	42.4 GB	4.3%	12361.17
May 28 22:00:00 - 22:59:59	141560	4.3%	39.32	41.8 GB	4.2%	12162.37
May 28 23:00:00 - 23:59:59	141264	4.3%	39.24	41.5 GB	4.2%	12091.13
May 29 00:00:00 - 00:59:59	122015	3.7%	33.89	36.8 GB	3.7%	10715.14
May 29 01:00:00 - 01:59:59	142762	4.3%	39.66	43.1 GB	4.4%	12556.20
May 29 02:00:00 - 02:59:59	138697	4.2%	38.53	43.6 GB	4.4%	12687.70
May 29 03:00:00 - 03:59:59	125373	3.8%	34.83	38.5 GB	3.9%	11207.58
May 29 04:00:00 - 04:15:02	33465	1.0%	37.10	10.4 GB	1.0%	12034.93
TOTAL: 24:00:00	3304873	100.0%	38.25	988.3 GB	100.0%	11994.54

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4933	73	4550	0	310
2	news.nask.pl	4687	22	262	1	4402
3	news.icm.edu.pl	31	0	6	0	25
TOTAL: 3		9651	95	4818	1	4737

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	37
comp.mobile.android	24
it.comp.os.win.windows10	11
nl.comp.os.linux.techniek	10
it.tlc.cellulari.android	6
comp.sys.mac.vintage	2
de.comp.lang.vbclassic	2
comp.sys.raspberry-pi	2
uk.net.providers.gradwell	1
TOTAL: 9	95

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)	3978
EMP (phl)	156
Binary in non-binary group	65
Scoring filter (8)	41
Scoring filter (9)	14
Too many newsgroups	9
Scoring filter (10)	7
Scoring filter (13)	6
Scoring filter (15)	5
Scoring filter (12)	1
HTML post	1
TOTAL: 11	4283

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	276
	news.nask.pl	176
	TOTAL: 2	452
TOTAL: 1		452

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	35460	13207	16308	754	1	1177	37%	23:59:15
2	panorama	56115	344	27342	189	4	55724	0%	23:59:58
3	poznan	11993	292	7304	4	0	0	2%	23:59:58
4	nask	5077	17	3407	0	0	0	0%	23:59:58
5	okapi	0	0	0	0	0	1207	0%	23:57:50
TOTAL: 5		108645	13860	54361	947	5	58108	12%	119:56:59

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	2.4 GB	232.3 MB	2.6 GB	31.4 KB/s	194.3 KB	23:59:15
2	panorama	1.1 MB	698.9 KB	1.8 MB	0.0 KB/s	3.4 KB	23:59:58
3	poznan	1006.3 KB	13.6 KB	1019.9 KB	0.0 KB/s	3.4 KB	23:59:58
4	nask	32.3 KB	0.0 KB	32.3 KB	0.0 KB/s	1.9 KB	23:59:58
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		2.4 GB	233.0 MB	2.6 GB	6.3 KB/s	183.4 KB	119:56:59

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	16	12.9 KB	8	0	00:00:25
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		290	16	12.9 KB	8	2	00:00:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	674	16	12.9 KB	8	2	00:00:31
2	*.versanet.de	176	0	0.0 KB	0	0	00:00:10
TOTAL: 2		850	16	12.9 KB	8	2	00:00:42

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.136	4.228	00:00:25
i59f7ed26.versanet.de	0.516	2.036	00:00:10
mon.man.lodz.pl	1.152	4.464	00:00:04
david.man.lodz.pl	0.360	1.392	00:00:01
isvcs01.man.lodz.pl	0.016	0.040	00:00:00
TOTAL: 5	3.180	12.160	00:00:42

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
i59f7ed26.versanet.de	176
david.man.lodz.pl	96
TOTAL: 3	560

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	16
TOTAL: 1		16

Daily Usenet report

May 28 04:15:02 -- May 29 04:15:02