Daily Usenet report: Dec 3 04:15:04

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Dec 3 16:25:33 newsfeed overchan[20515]: input line too long, skipping
Dec 3 16:46:59 newsfeed overchan[20515]: input line too long, skipping
Dec 3 21:47:29 newsfeed overchan[20515]: input line too long, skipping
Dec 3 21:50:19 newsfeed overchan[20515]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3858392	98.2%	438.1 MB	97.8%
innfeed	42111	1.1%	5.0 MB	1.1%
innd	25394	0.6%	4.2 MB	0.9%
nnrpd	4739	0.1%	498.6 KB	0.1%
overchan	5	0.0%	0.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3930642	100.0%	447.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3826644	97.9%
Negative hits	72279	1.8%
Positive hits	9448	0.2%
Cache misses	104	0.0%
TOTAL: 4	3908475	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:12.180	0.0%	182	0.000	66.923	2050.000
article cleanup	00:00:43.902	0.1%	3856995	0.008	0.011	0.019
article logging	00:02:22.495	0.2%	3857928	0.024	0.037	1.352
article parse	00:52:27.886	3.6%	108816820	0.015	0.029	0.070
article write	00:21:10.060	1.5%	3848214	0.171	0.330	1.521
artlog/artcncl	00:00:00.007	0.0%	175	0.000	0.040	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:30.048	0.2%	126393318	0.001	0.001	0.004
hisgrep/artcncl	00:00:00.794	0.0%	168	0.000	4.726	186.000
hishave/artcncl	00:00:00.063	0.0%	182	0.000	0.346	1.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:01:32.805	12.6%	3936277	1.312	2.767	22.878
history sync	00:00:00.015	0.0%	290	0.000	0.052	0.500
history write	07:11:13.249	29.9%	3853054	3.591	6.715	72.863
hiswrite/artcncl	00:00:00.044	0.0%	14	0.000	3.143	16.000
idle	05:21:58.119	22.4%	63831321	0.068	0.303	0.689
nntp read	00:51:12.458	3.6%	105492773	0.019	0.029	0.048
overview write	00:00:17.638	0.0%	3848214	0.003	0.005	0.007
perl filter	05:44:24.789	23.9%	3853052	3.615	5.363	8.394
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:35.436	0.4%	7713950	0.031	0.043	0.070
TOTAL: 24:00:08.589	23:35:41.988	98.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.136	0.0%	55929	0.000	0.002	0.023
article prepare	00:00:00.003	0.0%	13230	0.000	0.000	0.010
article read	00:01:51.789	0.1%	3418	2.100	32.706	362.538
backlog stats	00:00:00.122	0.0%	147787	0.000	0.001	0.005
callbacks	00:00:00.001	0.0%	116	0.000	0.009	1.000
data read	00:00:01.223	0.0%	79372	0.004	0.015	0.042
data write	00:00:02.863	0.0%	62254	0.022	0.046	0.095
idle	23:51:37.631	99.8%	147787	349.726	581.226	1134.112
status file	00:00:56.431	0.1%	15441	0.460	3.655	89.667
TOTAL: 23:54:40.436	23:54:30.199	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:47.747	81.9%	3015	0.000	15.836	9762.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.202	0.3%	6682	0.000	0.030	0.667
readart	00:00:00.006	0.0%	38	0.000	0.158	0.500
TOTAL: 00:00:58.300	00:00:47.955	82.3%	-	-	-	-

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	201	3848714	3840095	4231	4388	99%	553:16:17
2	news.nask.pl	2	14008	8580	1051	4377	61%	23:58:47
3	news.icm.edu.pl	39	312	35	256	21	11%	18:57:16
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		243	3863034	3848710	5538	8786	99%	596:12:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	878.7 GB	19.1 MB	126.2 MB	878.8 GB	99%	239.7 KB
2	news.nask.pl	34.9 MB	991.1 KB	20.7 MB	56.5 MB	61%	4.5 KB
3	news.icm.edu.pl	709.1 KB	119.9 KB	520.4 KB	1.3 MB	52%	24.1 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		878.7 GB	20.2 MB	147.4 MB	878.9 GB	99%	238.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 3 04:15:04 - 04:59:59	87768	2.3%	32.55	27.4 GB	3.1%	10646.88
Dec 3 05:00:00 - 05:59:59	132363	3.4%	36.77	39.6 GB	4.5%	11539.85
Dec 3 06:00:00 - 06:59:59	128172	3.3%	35.60	41.5 GB	4.7%	12100.29
Dec 3 07:00:00 - 07:59:59	129268	3.4%	35.91	45.7 GB	5.2%	13325.12
Dec 3 08:00:00 - 08:59:59	133015	3.5%	36.95	46.1 GB	5.3%	13440.27
Dec 3 09:00:00 - 09:59:59	154436	4.0%	42.90	32.7 GB	3.7%	9534.36
Dec 3 10:00:00 - 10:59:59	152843	4.0%	42.46	33.4 GB	3.8%	9722.85
Dec 3 11:00:00 - 11:59:59	169826	4.4%	47.17	35.0 GB	4.0%	10184.79
Dec 3 12:00:00 - 12:59:59	166130	4.3%	46.15	32.4 GB	3.7%	9433.07
Dec 3 13:00:00 - 13:59:59	186600	4.8%	51.83	34.9 GB	4.0%	10167.48
Dec 3 14:00:00 - 14:59:59	199764	5.2%	55.49	36.7 GB	4.2%	10690.53
Dec 3 15:00:00 - 15:59:59	161166	4.2%	44.77	37.8 GB	4.3%	11015.63
Dec 3 16:00:00 - 16:59:59	157875	4.1%	43.85	39.4 GB	4.5%	11466.17
Dec 3 17:00:00 - 17:59:59	128708	3.3%	35.75	38.5 GB	4.4%	11224.91
Dec 3 18:00:00 - 18:59:59	136045	3.5%	37.79	35.4 GB	4.0%	10317.29
Dec 3 19:00:00 - 19:59:59	171314	4.5%	47.59	40.4 GB	4.6%	11774.28
Dec 3 20:00:00 - 20:59:59	163953	4.3%	45.54	39.9 GB	4.5%	11617.70
Dec 3 21:00:00 - 21:59:59	180641	4.7%	50.18	41.9 GB	4.8%	12205.71
Dec 3 22:00:00 - 22:59:59	152298	4.0%	42.30	37.1 GB	4.2%	10796.18
Dec 3 23:00:00 - 23:59:59	185724	4.8%	51.59	38.9 GB	4.4%	11344.31
Dec 4 00:00:00 - 00:59:59	121720	3.2%	33.81	31.4 GB	3.6%	9141.71
Dec 4 01:00:00 - 01:59:59	252795	6.6%	70.22	31.8 GB	3.6%	9269.84
Dec 4 02:00:00 - 02:59:59	257180	6.7%	71.44	32.7 GB	3.7%	9534.20
Dec 4 03:00:00 - 03:59:59	104453	2.7%	29.01	20.1 GB	2.3%	5851.79
Dec 4 04:00:00 - 04:15:03	34440	0.9%	38.14	7.1 GB	0.8%	8268.96
TOTAL: 23:59:59	3848497	100.0%	44.54	878.0 GB	100.0%	10656.20

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	5079	202	3549	0	1328
2	news.nask.pl	4619	11	398	2	4208
3	news.icm.edu.pl	22	0	8	0	14
TOTAL: 3		9720	213	3955	2	5550

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	166
it.comp.os.win.windows10	13
it.tlc.cellulari.android	12
comp.mobile.android	10
uk.rec.cycling.moderated	7
de.comm.software.mailreader	3
comp.mobile.ipad	1
hr.ponuda.hardver.komponente	1
TOTAL: 8	213

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3698
Binary in non-binary group	728
EMP (fsl)	73
Scoring filter (8)	36
Scoring filter (9)	33
EMP (phl)	17
Poison newsgroup	10
HTML post	10
Scoring filter (10)	6
Scoring filter (12)	3
Attached HTML file	2
Scoring filter (13)	1
Scoring filter (16)	1
Scoring filter (11)	1
TOTAL: 14	4619

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	691
	news.nask.pl	238
	TOTAL: 2	929
TOTAL: 1		929

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	45164	1376	17389	443	296	36574	3%	23:59:56
2	poznan	13058	476	8105	12	1	0	3%	23:59:56
3	icm	20471	21	17317	5	0	0	0%	23:59:50
4	nask	2695	1	2381	12	0	0	0%	22:59:48
5	okapi	0	0	0	0	0	1165	0%	23:57:49
TOTAL: 5		81388	1874	45192	472	297	37739	2%	118:57:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	3.8 MB	5.6 MB	9.4 MB	0.1 KB/s	5.3 KB	23:59:56
2	poznan	1.5 MB	32.2 KB	1.5 MB	0.0 KB/s	3.1 KB	23:59:56
3	icm	54.8 KB	23.1 KB	77.9 KB	0.0 KB/s	3.0 KB	23:59:50
4	nask	3.0 KB	2.2 MB	2.2 MB	0.0 KB/s	174.0 KB	22:59:48
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		5.3 MB	7.9 MB	13.1 MB	0.0 KB/s	5.7 KB	118:57:19

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	38	37.1 KB	16	0	0	00:00:43
TOTAL: 1		288	38	37.1 KB	16	0	0	00:00:57

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	672	38	37.1 KB	16	00:00:47
2	unresolved	1	0	0.0 KB	0	00:00:09
TOTAL: 2		673	38	37.1 KB	16	00:00:57

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.248	7.544	00:00:43
104.236.159.107	0.004	0.012	00:00:09
mon.man.lodz.pl	1.020	7.544	00:00:03
david.man.lodz.pl	0.364	2.292	00:00:01
TOTAL: 4	2.636	17.392	00:00:57

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
104.236.159.107	1
TOTAL: 3	385

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	24
2	pl.comp.os.ms-windows.winnt	14
TOTAL: 2		38

Daily Usenet report

Dec 3 04:15:04 -- Dec 4 04:15:03