Daily Usenet report: May 27 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

May 27 05:18:06 newsfeed overchan[19929]: input line too long, skipping
May 27 08:28:41 newsfeed overchan[19929]: input line too long, skipping
May 27 08:55:32 newsfeed nnrpd[31220]: SERVER perl filter not defined
May 27 09:32:23 newsfeed overchan[19929]: input line too long, skipping
May 27 13:12:57 newsfeed overchan[19929]: input line too long, skipping
May 27 20:10:49 newsfeed overchan[19929]: input line too long, skipping
May 27 20:11:05 newsfeed overchan[19929]: input line too long, skipping
May 27 20:12:02 newsfeed overchan[19929]: input line too long, skipping
May 27 20:12:19 newsfeed overchan[19929]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3100111	98.3%	363.4 MB	98.0%
innfeed	25312	0.8%	3.0 MB	0.8%
innd	24981	0.8%	3.9 MB	1.1%
nnrpd	4744	0.2%	499.4 KB	0.1%
overchan	9	0.0%	1.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3155158	100.0%	370.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3076672	97.3%
Negative hits	74242	2.3%
Positive hits	10940	0.3%
Cache misses	97	0.0%
TOTAL: 4	3161951	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.175	0.0%	202	0.000	5.817	116.000
article cleanup	00:00:37.592	0.0%	3099762	0.009	0.012	0.018
article logging	00:01:59.678	0.1%	3100156	0.026	0.039	0.153
article parse	01:13:33.634	5.1%	234404409	0.015	0.019	0.036
article write	00:29:07.701	2.0%	3092814	0.377	0.565	3.561
artlog/artcncl	00:00:00.004	0.0%	181	0.000	0.022	0.167
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:10.513	0.2%	254280917	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.292	0.0%	182	0.000	1.604	14.500
hishave/artcncl	00:00:00.100	0.0%	202	0.000	0.495	2.821
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:42:34.828	3.0%	3183095	0.036	0.803	7.114
history sync	00:00:00.019	0.0%	290	0.000	0.066	1.000
history write	01:59:32.365	8.3%	3097093	0.144	2.316	10.216
hiswrite/artcncl	00:00:00.086	0.0%	20	0.000	4.300	6.300
idle	11:31:09.177	48.0%	155818454	0.093	0.266	0.435
nntp read	01:24:12.418	5.8%	231901214	0.017	0.022	0.030
overview write	00:00:15.622	0.0%	3092814	0.004	0.005	0.007
perl filter	05:40:09.571	23.6%	3097093	5.925	6.590	7.944
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:35.358	0.3%	6240248	0.034	0.044	0.072
TOTAL: 24:00:02.958	23:11:00.133	96.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.296	0.0%	115555	0.000	0.003	0.013
article prepare	00:00:00.035	0.0%	152456	0.000	0.000	0.000
article read	00:00:13.932	0.0%	38094	0.000	0.366	9.500
backlog stats	00:00:00.289	0.0%	293904	0.000	0.001	0.009
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:03.564	0.0%	160131	0.000	0.022	0.058
data write	00:00:33.051	0.0%	135609	0.014	0.244	0.468
idle	23:54:08.747	99.9%	293904	23.572	292.778	1369.662
status file	00:00:06.710	0.0%	8102	0.483	0.828	1.552
TOTAL: 23:55:21.545	23:55:06.624	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:35.631	72.1%	3010	0.000	11.838	3793.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.182	0.4%	6634	0.000	0.027	0.737
readart	00:00:00.002	0.0%	20	0.000	0.100	0.500
TOTAL: 00:00:49.411	00:00:35.815	72.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	1167	3092529	3083672	6109	2748	99%	404:47:31
2	news.nask.pl	2	14933	8865	1915	4153	59%	24:05:44
3	news.icm.edu.pl	44	316	26	239	51	8%	17:01:50
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		1215	3107779	3092564	8263	6952	99%	445:55:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	981.7 GB	36.7 MB	52.8 MB	981.8 GB	99%	333.5 KB
2	news.nask.pl	56.2 MB	402.0 KB	24.3 MB	80.9 MB	69%	6.4 KB
3	news.icm.edu.pl	531.0 KB	52.2 KB	2.2 MB	2.8 MB	18%	37.0 KB
4	localhost	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
TOTAL: 4		981.7 GB	37.1 MB	79.3 MB	981.9 GB	99%	332.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 27 04:15:02 - 04:59:59	95312	3.1%	35.33	30.9 GB	3.2%	12010.53
May 27 05:00:00 - 05:59:59	128551	4.2%	35.71	41.9 GB	4.3%	12200.61
May 27 06:00:00 - 06:59:59	136706	4.4%	37.97	43.3 GB	4.4%	12607.91
May 27 07:00:00 - 07:59:59	137485	4.4%	38.19	45.7 GB	4.7%	13309.00
May 27 08:00:00 - 08:59:59	124489	4.0%	34.58	36.8 GB	3.7%	10705.32
May 27 09:00:00 - 09:59:59	140278	4.5%	38.97	41.9 GB	4.3%	12213.93
May 27 10:00:00 - 10:59:59	110337	3.6%	30.65	32.9 GB	3.4%	9591.86
May 27 11:00:00 - 11:59:59	111441	3.6%	30.96	33.8 GB	3.4%	9841.76
May 27 12:00:00 - 12:59:59	132350	4.3%	36.76	40.9 GB	4.2%	11902.91
May 27 13:00:00 - 13:59:59	130975	4.2%	36.38	42.2 GB	4.3%	12295.62
May 27 14:00:00 - 14:59:59	106764	3.5%	29.66	35.0 GB	3.6%	10189.18
May 27 15:00:00 - 15:59:59	137990	4.5%	38.33	42.9 GB	4.4%	12498.34
May 27 16:00:00 - 16:59:59	137703	4.5%	38.25	43.3 GB	4.4%	12619.91
May 27 17:00:00 - 17:59:59	134812	4.4%	37.45	42.3 GB	4.3%	12334.30
May 27 18:00:00 - 18:59:59	140168	4.5%	38.94	44.2 GB	4.5%	12867.47
May 27 19:00:00 - 19:59:59	133827	4.3%	37.17	43.0 GB	4.4%	12534.31
May 27 20:00:00 - 20:59:59	134707	4.4%	37.42	43.2 GB	4.4%	12584.34
May 27 21:00:00 - 21:59:59	134368	4.3%	37.32	43.3 GB	4.4%	12604.79
May 27 22:00:00 - 22:59:59	133622	4.3%	37.12	43.9 GB	4.5%	12798.34
May 27 23:00:00 - 23:59:59	135298	4.4%	37.58	42.7 GB	4.4%	12440.06
May 28 00:00:00 - 00:59:59	118448	3.8%	32.90	37.3 GB	3.8%	10870.17
May 28 01:00:00 - 01:59:59	136413	4.4%	37.89	43.9 GB	4.5%	12800.04
May 28 02:00:00 - 02:59:59	125739	4.1%	34.93	40.4 GB	4.1%	11766.70
May 28 03:00:00 - 03:59:59	104053	3.4%	28.90	34.6 GB	3.5%	10089.06
May 28 04:00:00 - 04:15:02	30757	1.0%	34.10	10.1 GB	1.0%	11795.89
TOTAL: 24:00:00	3092593	100.0%	35.79	980.6 GB	100.0%	11900.95

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	4287	21	166	4	4096
2	newsfeed.pionier.net.pl	2998	132	2500	3	363
3	news.icm.edu.pl	52	0	3	0	49
TOTAL: 3		7337	153	2669	7	4508

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	63
it.comp.os.win.windows10	28
comp.mobile.android	18
it.tlc.cellulari.android	15
it.comp.os.win.windows7	12
comp.sys.raspberry-pi	7
comp.mobile.ipad	4
de.comp.lang.vbclassic	2
uk.net.providers.gradwell	1
de.rec.sf.startrek	1
hr.ponuda.hardver.komponente	1
it.tlc.cellulari.iphone	1
TOTAL: 12	153

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)	3599
Binary in non-binary group	213
EMP (phl)	188
Scoring filter (8)	34
Poison newsgroup	27
Scoring filter (9)	16
Too many newsgroups (low_xpost)	11
Scoring filter (10)	9
Too many newsgroups	6
HTML post	6
Scoring filter (11)	5
Scoring filter (12)	1
TOTAL: 12	4115

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	250
	news.nask.pl	142
	news.icm.edu.pl	1
	TOTAL: 3	393
TOTAL: 1		393

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	56470	36576	16126	1180	261	64%	23:59:58
2	poznan	13503	158	8609	4	2	1%	23:59:35
3	panorama	62398	155	48767	25	66454	0%	23:59:58
4	nask	4227	8	3093	0	0	0%	23:59:21
5	okapi	0	0	0	0	1486	0%	23:57:50
TOTAL: 5		136598	36897	76595	1209	68203	27%	119:56:42

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.6 GB	262.5 MB	6.8 GB	82.7 KB/s	189.2 KB	23:59:58
2	panorama	813.7 KB	1.2 MB	2.0 MB	0.0 KB/s	11.2 KB	23:59:58
3	poznan	554.7 KB	43.6 KB	598.3 KB	0.0 KB/s	3.7 KB	23:59:35
4	nask	14.0 KB	0.0 KB	14.0 KB	0.0 KB/s	1.7 KB	23:59:21
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		6.6 GB	263.7 MB	6.8 GB	16.5 KB/s	187.5 KB	119:56:42

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	20	22.3 KB	9	0	00:00:23
2	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 2		289	20	22.3 KB	9	1	00:00:48

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	673	20	22.3 KB	9	1	00:00:29
2	*.binaryedge.ninja	1	0	0.0 KB	0	0	00:00:02
3	unresolved	2	0	0.0 KB	0	0	00:00:17
TOTAL: 3		676	20	22.3 KB	9	1	00:00:48

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.052	4.300	00:00:23
185.178.96.62	0.008	0.024	00:00:17
mon.man.lodz.pl	1.156	4.496	00:00:04
min-extra-grab-41-ustx-prod.binaryedge.ninja	0.008	0.012	00:00:02
david.man.lodz.pl	0.360	1.376	00:00:01
isvcs01.man.lodz.pl	0.000	0.028	00:00:00
TOTAL: 6	2.584	10.236	00:00:48

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.178.96.62	2
min-extra-grab-41-ustx-prod.binaryedge.ninja	1
TOTAL: 4	387

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

May 27 04:15:02 -- May 28 04:15:02