Daily Usenet report: Nov 26 04:15:04

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Nov 26 20:45:12 newsfeed overchan[26071]: input line too long, skipping
Nov 26 20:45:48 newsfeed overchan[26071]: input line too long, skipping
Nov 26 20:52:20 newsfeed overchan[26071]: input line too long, skipping
Nov 26 20:58:19 newsfeed overchan[26071]: input line too long, skipping
Nov 27 01:07:37 newsfeed overchan[26071]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2995937	97.7%	342.6 MB	97.3%
innfeed	43922	1.4%	5.2 MB	1.5%
innd	22423	0.7%	3.6 MB	1.0%
nnrpd	4796	0.2%	492.2 KB	0.1%
overchan	6	0.0%	1.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3067085	100.0%	351.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2969977	96.5%
Negative hits	98030	3.2%
Positive hits	10273	0.3%
Cache misses	139	0.0%
TOTAL: 4	3078419	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:10.756	0.0%	204	0.000	52.725	399.000
article cleanup	00:00:32.610	0.0%	2996805	0.006	0.011	0.016
article logging	00:01:48.598	0.1%	2997481	0.020	0.036	0.061
article parse	00:41:10.300	2.9%	80286120	0.017	0.031	0.053
article write	00:18:03.692	1.3%	2989679	0.109	0.362	0.702
artlog/artcncl	00:00:00.007	0.0%	201	0.000	0.035	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:33.040	0.2%	94968949	0.001	0.002	0.004
hisgrep/artcncl	00:00:01.765	0.0%	196	0.000	9.005	57.000
hishave/artcncl	00:00:00.672	0.0%	204	0.000	3.294	35.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:43:35.624	15.5%	3102053	0.500	4.325	18.914
history sync	00:00:00.006	0.0%	290	0.000	0.021	0.500
history write	07:44:38.838	32.3%	2993529	1.351	9.313	31.314
hiswrite/artcncl	00:00:00.119	0.0%	8	0.333	14.875	27.000
idle	06:07:28.152	25.5%	47748629	0.086	0.462	0.942
nntp read	00:44:05.572	3.1%	77794071	0.022	0.034	0.053
overview write	00:00:13.282	0.0%	2989679	0.002	0.004	0.008
perl filter	04:11:25.545	17.5%	2993512	2.180	5.039	7.879
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:20.711	0.3%	5997486	0.024	0.043	0.062
TOTAL: 24:00:06.761	23:41:09.289	98.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.106	0.0%	55605	0.000	0.002	0.008
article prepare	00:00:00.004	0.0%	12540	0.000	0.000	0.024
article read	00:02:00.263	0.1%	3175	3.741	37.878	169.100
backlog stats	00:00:00.136	0.0%	147788	0.000	0.001	0.007
callbacks	00:00:00.000	0.0%	71	0.000	0.000	0.000
data read	00:00:01.131	0.0%	79531	0.004	0.014	0.053
data write	00:00:03.540	0.0%	63723	0.017	0.056	0.246
idle	23:49:48.195	99.7%	147788	178.546	580.481	1050.958
status file	00:01:55.483	0.1%	15398	0.683	7.500	30.929
TOTAL: 23:54:00.090	23:53:48.858	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:43.463	81.7%	3086	0.000	14.084	221.222
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.181	0.3%	6968	0.000	0.026	0.500
readart	00:00:00.024	0.0%	110	0.000	0.218	5.250
TOTAL: 00:00:53.209	00:00:43.668	82.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	2987050	2978012	6273	2765	99%	482:28:00
2	news.nask.pl	3	14700	9866	510	4324	67%	23:47:39
3	news.icm.edu.pl	42	235	7	206	22	2%	16:29:33
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		844	3001985	2987885	6989	7111	99%	522:45:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	770.2 GB	41.1 MB	42.1 MB	770.3 GB	99%	271.0 KB
2	news.nask.pl	80.3 MB	3.9 MB	19.6 MB	103.8 MB	77%	7.5 KB
3	news.icm.edu.pl	188.9 KB	32.5 KB	1.5 MB	1.8 MB	10%	62.0 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		770.3 GB	45.1 MB	63.2 MB	770.4 GB	99%	269.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 26 04:15:04 - 04:59:59	58588	2.0%	21.73	17.1 GB	2.2%	6639.77
Nov 26 05:00:00 - 05:59:59	66177	2.2%	18.38	22.6 GB	2.9%	6578.09
Nov 26 06:00:00 - 06:59:59	75377	2.5%	20.94	25.1 GB	3.3%	7297.38
Nov 26 07:00:00 - 07:59:59	77329	2.6%	21.48	26.7 GB	3.5%	7783.29
Nov 26 08:00:00 - 08:59:59	86049	2.9%	23.90	25.2 GB	3.3%	7352.18
Nov 26 09:00:00 - 09:59:59	88943	3.0%	24.71	24.3 GB	3.2%	7074.05
Nov 26 10:00:00 - 10:59:59	87132	2.9%	24.20	26.7 GB	3.5%	7787.30
Nov 26 11:00:00 - 11:59:59	101055	3.4%	28.07	31.8 GB	4.1%	9271.41
Nov 26 12:00:00 - 12:59:59	101950	3.4%	28.32	32.6 GB	4.2%	9496.29
Nov 26 13:00:00 - 13:59:59	82956	2.8%	23.04	27.6 GB	3.6%	8052.78
Nov 26 14:00:00 - 14:59:59	131084	4.4%	36.41	28.3 GB	3.7%	8244.72
Nov 26 15:00:00 - 15:59:59	167080	5.6%	46.41	30.5 GB	4.0%	8873.88
Nov 26 16:00:00 - 16:59:59	210133	7.0%	58.37	31.1 GB	4.0%	9048.12
Nov 26 17:00:00 - 17:59:59	288339	9.7%	80.09	36.4 GB	4.7%	10603.14
Nov 26 18:00:00 - 18:59:59	136759	4.6%	37.99	40.4 GB	5.3%	11769.20
Nov 26 19:00:00 - 19:59:59	135577	4.5%	37.66	41.5 GB	5.4%	12090.47
Nov 26 20:00:00 - 20:59:59	131781	4.4%	36.61	38.0 GB	4.9%	11072.40
Nov 26 21:00:00 - 21:59:59	134448	4.5%	37.35	39.6 GB	5.2%	11547.58
Nov 26 22:00:00 - 22:59:59	133753	4.5%	37.15	39.9 GB	5.2%	11620.52
Nov 26 23:00:00 - 23:59:59	172975	5.8%	48.05	39.3 GB	5.1%	11456.09
Nov 27 00:00:00 - 00:59:59	131980	4.4%	36.66	33.0 GB	4.3%	9601.80
Nov 27 01:00:00 - 01:59:59	122441	4.1%	34.01	31.9 GB	4.2%	9305.69
Nov 27 02:00:00 - 02:59:59	129421	4.3%	35.95	38.0 GB	4.9%	11068.04
Nov 27 03:00:00 - 03:59:59	109379	3.7%	30.38	33.1 GB	4.3%	9632.68
Nov 27 04:00:00 - 04:15:03	27242	0.9%	30.17	8.6 GB	1.1%	9938.76
TOTAL: 23:59:59	2987948	100.0%	34.58	769.4 GB	100.0%	9337.30

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	4606	30	721	5	3850
2	newsfeed.pionier.net.pl	3160	140	2541	1	478
3	news.icm.edu.pl	22	0	2	0	20
TOTAL: 3		7788	170	3264	6	4348

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	85
it.comp.os.win.windows10	27
comp.mobile.android	20
it.tlc.cellulari.android	9
comp.sys.raspberry-pi	7
de.comm.software.mailreader	4
it.comp.os.linux.ubuntu	3
hr.ponuda.hardver.komponente	3
comp.sys.mac.vintage	3
uk.rec.cycling.moderated	3
it.comp.os.win.windows7	3
nl.comp.sys.android	3
TOTAL: 12	170

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

Groups	Count
pl.sci.historia	5
bit.listserv.catholic	1
TOTAL: 2	6

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3458
Binary in non-binary group	131
EMP (phl)	16
Scoring filter (9)	16
HTML post	11
Scoring filter (8)	10
Scoring filter (11)	6
Too many newsgroups	3
Scoring filter (10)	2
TOTAL: 9	3653

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	398
	news.nask.pl	280
	TOTAL: 2	678
TOTAL: 1		678

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	43443	1165	16243	245	168	37974	2%	23:59:56
2	poznan	14102	334	9412	18	0	0	2%	23:58:50
3	icm	20050	43	17548	17	0	0	0%	23:59:33
4	nask	2254	1	1683	319	0	0	0%	23:36:45
5	okapi	0	0	0	0	0	1310	0%	23:57:49
TOTAL: 5		79849	1543	44886	599	168	39284	1%	119:32:53

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	10.3 MB	886.3 KB	11.2 MB	0.1 KB/s	8.1 KB	23:59:56
2	icm	7.2 MB	4.8 MB	12.0 MB	0.1 KB/s	204.9 KB	23:59:33
3	poznan	1.1 MB	151.3 KB	1.2 MB	0.0 KB/s	3.5 KB	23:58:50
4	nask	5.0 KB	194.5 MB	194.5 MB	2.3 KB/s	622.4 KB	23:36:45
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		18.6 MB	200.3 MB	218.9 MB	0.5 KB/s	104.6 KB	119:32:53

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
panorama	488.3 KB
TOTAL: 2	976.7 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	110	107.6 KB	52	0	0	00:00:47
TOTAL: 1		288	110	107.6 KB	52	0	0	00:00:52

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	672	110	107.6 KB	52	0	0	00:00:52
TOTAL: 1		672	110	107.6 KB	52	0	0	00:00:52

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.016	5.540	00:00:47
mon.man.lodz.pl	0.988	5.500	00:00:03
david.man.lodz.pl	0.272	2.040	00:00:01
TOTAL: 3	2.276	13.080	00:00:52

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
TOTAL: 2	384

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	62
2	pl.comp.os.ms-windows.winnt	48
TOTAL: 2		110

Daily Usenet report

Nov 26 04:15:04 -- Nov 27 04:15:03