Daily Usenet report: Feb 5 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3179629	98.6%	367.1 MB	98.3%
innd	36545	1.1%	5.2 MB	1.4%
innfeed	4821	0.1%	681.8 KB	0.2%
nnrpd	4767	0.1%	491.9 KB	0.1%
TOTAL: 4	3225762	100.0%	373.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3173146	96.8%
Negative hits	90829	2.8%
Positive hits	13728	0.4%
Cache misses	37	0.0%
TOTAL: 4	3277740	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.819	0.0%	115	0.000	15.817	947.000
article cleanup	00:00:45.570	0.1%	3179837	0.006	0.014	0.023
article logging	00:01:47.656	0.1%	3180437	0.018	0.034	0.530
article parse	01:31:13.451	6.3%	194209115	0.015	0.028	0.066
article write	00:51:29.714	3.6%	3161962	0.370	0.977	4.640
artlog/artcncl	00:00:00.001	0.0%	107	0.000	0.009	1.000
artlog/artparse	00:00:00.005	0.0%	100	0.000	0.050	1.000
data move	00:03:00.738	0.2%	213948554	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.120	0.0%	95	0.000	1.263	53.000
hishave/artcncl	00:00:00.010	0.0%	115	0.000	0.087	5.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:34:15.721	2.4%	3280145	0.138	0.627	8.646
history sync	00:00:00.019	0.0%	292	0.000	0.065	1.000
history write	00:49:30.345	3.4%	3175459	0.235	0.935	9.796
hiswrite/artcncl	00:00:00.013	0.0%	20	0.000	0.650	8.000
idle	10:49:13.880	45.1%	124086942	0.141	0.314	1.470
nntp read	01:16:45.875	5.3%	191669142	0.016	0.024	0.033
overview write	00:00:18.401	0.0%	3161962	0.001	0.006	0.013
perl filter	07:02:56.537	29.4%	3175359	6.126	7.992	10.227
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:45.208	0.4%	6457732	0.036	0.053	0.080
TOTAL: 24:00:38.613	23:07:05.083	96.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.585	0.0%	161425	0.000	0.004	0.133
article prepare	00:00:00.123	0.0%	460634	0.000	0.000	0.083
article read	00:05:28.984	0.4%	114988	0.000	2.861	122.733
backlog stats	00:00:00.814	0.0%	777306	0.000	0.001	0.050
callbacks	00:00:00.000	0.0%	7	0.000	0.000	0.000
data read	00:00:04.750	0.0%	327808	0.000	0.014	0.167
data write	00:01:05.354	0.1%	457022	0.000	0.143	0.400
idle	23:52:53.907	99.5%	777306	15.679	110.605	4897.938
status file	00:00:01.108	0.0%	1335	0.000	0.830	4.333
TOTAL: 23:59:55.587	23:59:35.625	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:41:04.084	99.8%	23946	0.000	403.578	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.178	0.0%	48589	0.000	0.024	0.500
readart	00:00:00.025	0.0%	50	0.000	0.500	9.000
TOTAL: 02:41:19.322	02:41:05.287	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	189

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1053	3162662	3151448	5354	5860	99%	409:16:06
2	news.nask.pl	2	25173	9484	3578	12111	37%	24:01:51
3	news.icm.edu.pl	43	279	24	236	19	8%	14:27:40
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		1099	3188114	3160956	9168	17990	99%	447:45:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	989.7 GB	120.9 MB	469.6 MB	990.3 GB	99%	328.9 KB
2	news.nask.pl	96.6 MB	998.4 KB	183.4 MB	281.0 MB	34%	13.3 KB
3	news.icm.edu.pl	497.6 KB	0.0 KB	1.0 MB	1.5 MB	31%	36.5 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		989.8 GB	121.8 MB	654.1 MB	990.6 GB	99%	326.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 5 04:15:02 - 04:59:59	85886	2.7%	31.83	29.1 GB	2.9%	11300.38
Feb 5 05:00:00 - 05:59:59	114635	3.6%	31.84	39.9 GB	4.0%	11633.99
Feb 5 06:00:00 - 06:59:59	124221	3.9%	34.51	41.6 GB	4.2%	12122.10
Feb 5 07:00:00 - 07:59:59	121016	3.8%	33.62	39.7 GB	4.0%	11569.16
Feb 5 08:00:00 - 08:59:59	120606	3.8%	33.50	40.0 GB	4.0%	11639.51
Feb 5 09:00:00 - 09:59:59	150458	4.8%	41.79	41.0 GB	4.2%	11952.80
Feb 5 10:00:00 - 10:59:59	148857	4.7%	41.35	40.3 GB	4.1%	11741.01
Feb 5 11:00:00 - 11:59:59	136378	4.3%	37.88	42.2 GB	4.3%	12295.52
Feb 5 12:00:00 - 12:59:59	122074	3.9%	33.91	41.2 GB	4.2%	11997.37
Feb 5 13:00:00 - 13:59:59	123499	3.9%	34.31	42.1 GB	4.3%	12254.58
Feb 5 14:00:00 - 14:59:59	132999	4.2%	36.94	43.6 GB	4.4%	12697.85
Feb 5 15:00:00 - 15:59:59	139572	4.4%	38.77	42.0 GB	4.3%	12240.73
Feb 5 16:00:00 - 16:59:59	147976	4.7%	41.10	42.8 GB	4.3%	12456.90
Feb 5 17:00:00 - 17:59:59	139783	4.4%	38.83	43.5 GB	4.4%	12657.51
Feb 5 18:00:00 - 18:59:59	129123	4.1%	35.87	43.4 GB	4.4%	12641.19
Feb 5 19:00:00 - 19:59:59	131903	4.2%	36.64	44.2 GB	4.5%	12875.88
Feb 5 20:00:00 - 20:59:59	126002	4.0%	35.00	41.3 GB	4.2%	12019.58
Feb 5 21:00:00 - 21:59:59	145713	4.6%	40.48	41.7 GB	4.2%	12132.60
Feb 5 22:00:00 - 22:59:59	143901	4.6%	39.97	42.1 GB	4.3%	12250.83
Feb 5 23:00:00 - 23:59:59	133591	4.2%	37.11	41.3 GB	4.2%	12029.85
Feb 6 00:00:00 - 00:59:59	114936	3.6%	31.93	35.3 GB	3.6%	10287.47
Feb 6 01:00:00 - 01:59:59	141276	4.5%	39.24	42.0 GB	4.3%	12247.35
Feb 6 02:00:00 - 02:59:59	137146	4.3%	38.10	42.1 GB	4.3%	12276.46
Feb 6 03:00:00 - 03:59:59	118618	3.8%	32.95	36.2 GB	3.7%	10538.71
Feb 6 04:00:00 - 04:15:03	30753	1.0%	34.06	9.5 GB	1.0%	11019.06
TOTAL: 24:00:01	3160922	100.0%	36.58	988.1 GB	100.0%	11991.19

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12334	52	327	1	11954
2	newsfeed.pionier.net.pl	6240	209	4148	0	1883
3	news.icm.edu.pl	26	0	0	0	26
TOTAL: 3		18600	261	4475	1	13863

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	104
it.tlc.cellulari.android	56
comp.mobile.android	31
it.comp.os.win.windows10	21
comp.mobile.ipad	11
comp.sys.raspberry-pi	8
de.rec.sf.startrek	6
comp.sys.mac.vintage	4
de.comp.office-pakete.ms-office.excel	4
nl.comp.os.linux.techniek	4
it.comp.os.win.windows7	4
nl.actueel	3
nl.comp.sys.android	2
it.comp.os.win.windows8	1
uk.rec.cycling.moderated	1
it.comp.os.linux.ubuntu	1
TOTAL: 16	261

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)	11153
Binary in non-binary group	1713
EMP (phl)	144
Scoring filter (8)	57
Adult group ECP	39
Scoring filter (9)	26
Scoring filter (10)	16
Scoring filter (15)	8
Scoring filter (12)	2
Scoring filter (13)	1
Scoring filter (11)	1
Too many newsgroups	1
Scoring filter (17)	1
HTML post	1
TOTAL: 14	13163

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	134944	82187	19518	28516	0	19182	60%	24:01:54
2	panorama	27407	1235	23345	629	21	117242	4%	24:00:14
3	poznan	14381	87	9190	11	0	0	0%	24:00:52
4	nask	9133	27	4728	2308	0	0	0%	23:55:17
5	okapi	0	0	0	0	0	1732	0%	24:00:01
TOTAL: 5		185865	83536	56781	31464	21	138156	44%	119:58:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	14.7 GB	6.7 GB	21.5 GB	260.1 KB/s	203.3 KB	24:01:54
2	panorama	3.9 MB	10.0 MB	13.8 MB	0.2 KB/s	7.6 KB	24:00:14
3	poznan	284.9 KB	80.3 KB	365.2 KB	0.0 KB/s	3.7 KB	24:00:52
4	nask	141.8 KB	871.3 MB	871.5 MB	10.4 KB/s	382.2 KB	23:55:17
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		14.8 GB	7.6 GB	22.3 GB	54.2 KB/s	203.6 KB	119:58:18

Backlog files shrunk by innfeed:

Server	Size
panorama	10.0 MB
TOTAL: 1	10.0 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	50	47.2 KB	25	0	0	00:00:22
TOTAL: 1		288	50	47.2 KB	25	0	0	02:41:19

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	672	50	47.2 KB	25	00:00:28
2	*.dyn.optonline.net	1	0	0.0 KB	0	00:00:00
3	unresolved	2	0	0.0 KB	0	02:40:50
TOTAL: 3		675	50	47.2 KB	25	02:41:19

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.115	1.355	1.909	02:40:50
web.man.lodz.pl	0.928	7.274	00:00:22
mon.man.lodz.pl	1.071	6.627	00:00:03
david.man.lodz.pl	0.294	2.123	00:00:01
ool-ae2c99f9.dyn.optonline.net	0.020	0.047	00:00:00
TOTAL: 5	3.668	17.980	02:41:19

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.115	2
ool-ae2c99f9.dyn.optonline.net	1
TOTAL: 4	387

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	34
2	pl.comp.os.ms-windows.winnt	16
TOTAL: 2		50

Daily Usenet report

Feb 5 04:15:02 -- Feb 6 04:15:03