Daily Usenet report: Oct 21 04:15:03

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Oct 21 14:50:38 newsfeed overchan[5040]: input line too long, skipping
Oct 21 17:27:12 newsfeed overchan[5040]: input line too long, skipping
Oct 21 17:37:23 newsfeed overchan[5040]: input line too long, skipping
Oct 21 18:01:37 newsfeed overchan[5040]: input line too long, skipping
Oct 21 21:27:53 newsfeed overchan[5040]: input line too long, skipping
Oct 21 23:06:10 newsfeed overchan[5040]: input line too long, skipping
Oct 22 00:40:10 newsfeed overchan[5040]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3653319	97.2%	424.8 MB	96.9%
innd	54796	1.5%	7.8 MB	1.8%
innfeed	45785	1.2%	5.4 MB	1.2%
nnrpd	4778	0.1%	503.2 KB	0.1%
overchan	8	0.0%	1.3 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3758687	100.0%	438.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3580137	89.6%
Negative hits	283670	7.1%
Positive hits	130607	3.3%
Cache misses	233	0.0%
TOTAL: 4	3994647	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.713	0.0%	181	0.000	14.989	119.000
article cleanup	00:00:53.427	0.1%	3648837	0.010	0.015	0.020
article logging	00:02:34.605	0.2%	3649986	0.030	0.042	0.162
article parse	01:14:08.246	5.1%	202563585	0.014	0.022	0.046
article write	00:26:49.026	1.9%	3578155	0.103	0.450	1.300
artlog/artcncl	00:00:00.009	0.0%	180	0.000	0.050	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:04:13.677	0.3%	222641102	0.001	0.001	0.005
hisgrep/artcncl	00:00:01.159	0.0%	176	0.000	6.585	50.500
hishave/artcncl	00:00:00.301	0.0%	181	0.000	1.663	16.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:12:44.048	5.1%	4032539	0.074	1.082	6.399
history sync	00:00:00.016	0.0%	290	0.000	0.055	1.000
history write	02:14:33.979	9.3%	3610257	0.246	2.236	11.837
hiswrite/artcncl	00:00:00.001	0.0%	5	0.000	0.200	1.000
idle	10:10:14.799	42.4%	131537691	0.095	0.278	0.525
nntp read	01:20:44.826	5.6%	199916393	0.015	0.024	0.034
overview write	00:00:18.449	0.0%	3578155	0.004	0.005	0.007
perl filter	06:15:43.276	26.1%	3610257	2.068	6.244	8.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:30.138	0.4%	7318086	0.034	0.045	0.058
TOTAL: 24:00:02.857	23:08:32.695	96.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.800	0.0%	305900	0.000	0.003	0.015
article prepare	00:00:00.028	0.0%	97206	0.000	0.000	0.083
article read	00:02:03.802	0.1%	23408	0.000	5.289	1843.000
backlog stats	00:00:00.725	0.0%	989969	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:11.366	0.0%	608753	0.006	0.019	0.070
data write	00:00:42.133	0.0%	464214	0.019	0.091	0.140
idle	23:50:39.667	99.7%	989969	26.518	86.709	1039.865
status file	00:00:15.690	0.0%	16387	0.600	0.957	8.522
TOTAL: 23:54:26.468	23:53:54.211	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:33:04.769	99.7%	23118	0.000	241.577	10030.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.098	0.0%	46944	0.000	0.023	1.000
readart	00:00:00.018	0.0%	66	0.000	0.273	7.000
TOTAL: 01:33:20.438	01:33:05.885	99.7%	-	-	-	-

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	1123	3608915	3549003	5240	54672	98%	428:41:10
2	news.nask.pl	2	135824	33250	87431	15143	24%	23:50:32
3	news.icm.edu.pl	48	230	23	200	7	10%	16:02:05
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		1174	3744969	3582276	92871	69822	95%	468:33:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	925.0 GB	9.8 GB	13.6 GB	948.4 GB	97%	275.9 KB
2	news.nask.pl	8.1 GB	159.0 MB	2.4 GB	10.6 GB	76%	229.5 KB
3	news.icm.edu.pl	1.3 MB	17.8 KB	141.5 KB	1.5 MB	89%	51.3 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		933.0 GB	9.9 GB	16.0 GB	959.0 GB	97%	275.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 21 04:15:03 - 04:59:59	85675	2.4%	31.77	26.8 GB	2.9%	10406.39
Oct 21 05:00:00 - 05:59:59	124242	3.5%	34.51	38.4 GB	4.1%	11189.39
Oct 21 06:00:00 - 06:59:59	126059	3.5%	35.02	41.5 GB	4.4%	12078.15
Oct 21 07:00:00 - 07:59:59	128155	3.6%	35.60	41.8 GB	4.5%	12166.41
Oct 21 08:00:00 - 08:59:59	129847	3.6%	36.07	43.9 GB	4.7%	12794.67
Oct 21 09:00:00 - 09:59:59	119329	3.3%	33.15	40.3 GB	4.3%	11735.50
Oct 21 10:00:00 - 10:59:59	133878	3.7%	37.19	42.9 GB	4.6%	12504.81
Oct 21 11:00:00 - 11:59:59	125513	3.5%	34.86	36.6 GB	3.9%	10665.42
Oct 21 12:00:00 - 12:59:59	132503	3.7%	36.81	42.8 GB	4.6%	12477.09
Oct 21 13:00:00 - 13:59:59	347887	9.7%	96.64	33.3 GB	3.6%	9687.77
Oct 21 14:00:00 - 14:59:59	347520	9.7%	96.53	28.1 GB	3.0%	8195.12
Oct 21 15:00:00 - 15:59:59	157516	4.4%	43.75	40.1 GB	4.3%	11668.95
Oct 21 16:00:00 - 16:59:59	129570	3.6%	35.99	39.2 GB	4.2%	11410.63
Oct 21 17:00:00 - 17:59:59	136920	3.8%	38.03	40.8 GB	4.4%	11880.20
Oct 21 18:00:00 - 18:59:59	133130	3.7%	36.98	40.2 GB	4.3%	11719.87
Oct 21 19:00:00 - 19:59:59	136089	3.8%	37.80	38.6 GB	4.1%	11234.56
Oct 21 20:00:00 - 20:59:59	146527	4.1%	40.70	38.8 GB	4.2%	11312.36
Oct 21 21:00:00 - 21:59:59	130469	3.6%	36.24	40.4 GB	4.3%	11775.54
Oct 21 22:00:00 - 22:59:59	133951	3.7%	37.21	38.3 GB	4.1%	11149.33
Oct 21 23:00:00 - 23:59:59	127039	3.5%	35.29	39.2 GB	4.2%	11428.38
Oct 22 00:00:00 - 00:59:59	102714	2.9%	28.53	32.3 GB	3.5%	9398.98
Oct 22 01:00:00 - 01:59:59	142690	4.0%	39.64	42.1 GB	4.5%	12252.44
Oct 22 02:00:00 - 02:59:59	131488	3.7%	36.52	40.3 GB	4.3%	11747.44
Oct 22 03:00:00 - 03:59:59	139403	3.9%	38.72	35.3 GB	3.8%	10293.19
Oct 22 04:00:00 - 04:15:03	34112	1.0%	37.78	10.2 GB	1.1%	11869.60
TOTAL: 24:00:00	3582226	100.0%	41.46	932.3 GB	100.0%	11314.15

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	54962	158	37201	0	17603
2	news.nask.pl	15943	24	1064	1	14854
3	news.icm.edu.pl	8	0	1	0	7
TOTAL: 3		70913	182	38266	1	32464

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	92
it.tlc.cellulari.android	26
it.comp.os.win.windows10	19
comp.mobile.android	11
nl.comp.os.linux.techniek	9
alt.sex.telephones	6
de.rec.sf.startrek	5
comp.sys.raspberry-pi	3
de.comp.lang.vbclassic	3
de.comp.office-pakete.ms-office.excel	3
de.comm.software.mailreader	2
uk.rec.cycling.moderated	2
de.comp.office-pakete.ms-office.outlook	1
TOTAL: 13	182

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	27866
EMP (md5)	3262
Scoring filter (8)	71
Scoring filter (10)	70
Scoring filter (9)	37
Scoring filter (11)	9
HTML post	5
Poison newsgroup	3
Too many newsgroups	3
Scoring filter (14)	1
Scoring filter (15)	1
TOTAL: 11	31328

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.nask.pl	844
	newsfeed.pionier.net.pl	292
	TOTAL: 2	1136
TOTAL: 1		1136

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	nask	184816	16971	96762	1	0	0	9%	23:43:58
2	panorama	155396	1945	123280	2885	10	178562	1%	23:59:57
3	poznan	15422	415	9115	80	1	0	2%	23:59:57
4	icm	176292	53	150396	1348	0	0	0%	23:59:57
5	okapi	0	0	0	0	0	1076	0%	23:57:50
TOTAL: 5		531926	19384	379553	4314	11	179638	3%	119:41:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	5.7 GB	2.2 KB	5.7 GB	70.2 KB/s	353.2 KB	23:43:58
2	panorama	36.1 MB	54.1 MB	90.1 MB	1.1 KB/s	19.1 KB	23:59:57
3	icm	2.9 MB	463.0 MB	465.9 MB	5.5 KB/s	340.5 KB	23:59:57
4	poznan	1.9 MB	3.1 MB	5.0 MB	0.1 KB/s	10.2 KB	23:59:57
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		5.8 GB	520.2 MB	6.3 GB	15.2 KB/s	277.2 KB	119:41:39

Backlog files shrunk by innfeed:

Server	Size
panorama	3.3 MB
TOTAL: 1	3.3 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	66	67.3 KB	29	0	0	00:00:25
TOTAL: 1		288	66	67.3 KB	29	0	0	01:33:19

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	672	66	67.3 KB	29	00:00:31
2	unresolved	3	0	0.0 KB	0	01:32:48
TOTAL: 2		675	66	67.3 KB	29	01:33:19

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.192.120	1.172	1.860	01:32:38
web.man.lodz.pl	1.232	11.320	00:00:25
45.55.14.184	0.004	0.052	00:00:09
mon.man.lodz.pl	1.028	11.216	00:00:03
david.man.lodz.pl	0.360	3.908	00:00:02
TOTAL: 5	3.796	28.356	01:33:19

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.192.120	2
45.55.14.184	1
TOTAL: 4	387

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Oct 21 04:15:03 -- Oct 22 04:15:03