Daily Usenet report: Mar 6 04:15:03

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2889561	97.5%	340.2 MB	97.2%
innfeed	45469	1.5%	5.4 MB	1.6%
innd	22475	0.8%	3.9 MB	1.1%
nnrpd	4991	0.2%	527.5 KB	0.1%
TOTAL: 4	2962496	100.0%	350.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2883039	98.2%
Negative hits	34586	1.2%
Positive hits	16640	0.6%
Cache misses	165	0.0%
TOTAL: 4	2934430	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.087	0.0%	293	0.000	27.601	516.000
article cleanup	00:00:42.218	0.0%	2888982	0.006	0.015	0.026
article logging	00:01:30.196	0.1%	2889733	0.016	0.031	0.634
article parse	01:28:18.072	6.1%	197380650	0.014	0.027	0.087
article write	00:30:44.674	2.1%	2884369	0.279	0.640	3.746
artlog/artcncl	00:00:00.005	0.0%	293	0.000	0.017	0.333
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:06:11.857	0.4%	215484421	0.001	0.002	0.006
hisgrep/artcncl	00:00:02.050	0.0%	213	0.000	9.624	85.000
hishave/artcncl	00:00:00.109	0.0%	293	0.000	0.372	19.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:40:22.975	2.8%	2936111	0.136	0.825	21.274
history sync	00:00:00.009	0.0%	291	0.000	0.031	1.000
history write	00:54:34.654	3.8%	2884817	0.264	1.135	34.227
hiswrite/artcncl	00:00:00.019	0.0%	80	0.000	0.237	5.000
idle	10:23:30.558	43.3%	138866985	0.107	0.269	0.631
nntp read	01:37:29.057	6.8%	195063944	0.017	0.030	0.051
overview write	00:00:18.212	0.0%	2884369	0.001	0.006	0.015
perl filter	07:18:49.840	30.5%	2884816	6.101	9.127	12.022
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:59.354	0.4%	6207643	0.031	0.058	0.094
TOTAL: 24:00:17.238	23:08:41.946	96.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:02.009	0.0%	828810	0.000	0.002	0.020
article prepare	00:00:00.023	0.0%	121880	0.000	0.000	0.019
article read	00:02:16.853	0.2%	29698	0.000	4.608	563.000
backlog stats	00:00:01.288	0.0%	1807801	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:14.267	0.0%	1102667	0.000	0.013	0.053
data write	00:00:47.104	0.1%	704472	0.009	0.067	2.572
idle	23:56:06.191	99.7%	1807801	8.631	47.664	329.728
status file	00:00:13.674	0.0%	17115	0.250	0.799	6.667
TOTAL: 24:00:24.617	23:59:41.409	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:02:21.859	99.8%	55631	0.000	196.686	10047.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.601	0.0%	111992	0.000	0.023	0.667
readart	00:00:00.043	0.0%	16	0.000	2.688	15.500
TOTAL: 03:02:46.256	03:02:24.503	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1139	2879344	2874841	330	4173	99%	359:36:41
2	news.nask.pl	2	21611	8941	12292	378	41%	24:54:20
3	news.icm.edu.pl	43	306	73	153	80	23%	17:41:56
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		1185	2901261	2883855	12775	4631	99%	402:12:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	899.9 GB	78.9 MB	81.6 MB	900.1 GB	99%	327.8 KB
2	news.nask.pl	33.6 MB	1.0 MB	1.1 MB	35.7 MB	93%	3.9 KB
3	news.icm.edu.pl	2.9 MB	18.3 KB	4.7 MB	7.6 MB	38%	51.1 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		900.0 GB	80.0 MB	87.5 MB	900.1 GB	99%	326.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 6 04:15:03 - 04:59:59	72785	2.5%	26.99	23.4 GB	2.6%	9093.18
Mar 6 05:00:00 - 05:59:59	119392	4.1%	33.16	39.0 GB	4.3%	11364.62
Mar 6 06:00:00 - 06:59:59	108101	3.7%	30.03	38.9 GB	4.3%	11320.35
Mar 6 07:00:00 - 07:59:59	109529	3.8%	30.42	39.3 GB	4.4%	11445.45
Mar 6 08:00:00 - 08:59:59	110378	3.8%	30.66	39.4 GB	4.4%	11468.75
Mar 6 09:00:00 - 09:59:59	122962	4.3%	34.16	39.9 GB	4.4%	11613.16
Mar 6 10:00:00 - 10:59:59	123211	4.3%	34.23	39.7 GB	4.4%	11573.70
Mar 6 11:00:00 - 11:59:59	152171	5.3%	42.27	41.2 GB	4.6%	12014.23
Mar 6 12:00:00 - 12:59:59	116054	4.0%	32.24	38.3 GB	4.3%	11157.93
Mar 6 13:00:00 - 13:59:59	110515	3.8%	30.70	36.4 GB	4.0%	10598.70
Mar 6 14:00:00 - 14:59:59	120494	4.2%	33.47	36.7 GB	4.1%	10700.56
Mar 6 15:00:00 - 15:59:59	111624	3.9%	31.01	33.8 GB	3.8%	9837.64
Mar 6 16:00:00 - 16:59:59	113233	3.9%	31.45	34.8 GB	3.9%	10142.91
Mar 6 17:00:00 - 17:59:59	123455	4.3%	34.29	37.4 GB	4.2%	10881.31
Mar 6 18:00:00 - 18:59:59	141745	4.9%	39.37	38.8 GB	4.3%	11289.04
Mar 6 19:00:00 - 19:59:59	130384	4.5%	36.22	38.1 GB	4.2%	11105.45
Mar 6 20:00:00 - 20:59:59	124362	4.3%	34.55	38.2 GB	4.2%	11120.87
Mar 6 21:00:00 - 21:59:59	131920	4.6%	36.64	40.1 GB	4.5%	11681.98
Mar 6 22:00:00 - 22:59:59	134680	4.7%	37.41	40.2 GB	4.5%	11697.43
Mar 6 23:00:00 - 23:59:59	128494	4.5%	35.69	39.1 GB	4.4%	11394.88
Mar 7 00:00:00 - 00:59:59	102042	3.5%	28.34	31.0 GB	3.5%	9037.30
Mar 7 01:00:00 - 01:59:59	123563	4.3%	34.32	37.8 GB	4.2%	11004.99
Mar 7 02:00:00 - 02:59:59	113128	3.9%	31.42	34.2 GB	3.8%	9952.89
Mar 7 03:00:00 - 03:59:59	111904	3.9%	31.08	34.6 GB	3.8%	10069.77
Mar 7 04:00:00 - 04:15:02	27777	1.0%	30.79	8.9 GB	1.0%	10349.57
TOTAL: 23:59:59	2883903	100.0%	33.38	899.1 GB	100.0%	10911.77

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4839	245	3814	1	779
2	news.nask.pl	454	13	350	2	89
3	news.icm.edu.pl	72	0	2	0	70
TOTAL: 3		5365	258	4166	3	938

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	157
it.tlc.cellulari.android	28
comp.mobile.android	21
comp.sys.raspberry-pi	15
it.comp.os.win.windows10	14
de.rec.sf.startrek	6
it.comp.os.win.windows7	4
de.comp.office-pakete.ms-office.excel	3
it.comp.os.win.windows8	2
de.comm.software.mailreader	2
de.comp.office-pakete.ms-office.word	1
alt.sex.telephones	1
comp.sys.mac.vintage	1
de.comp.office-pakete.ms-office.outlook	1
it.comp.os.linux.ubuntu	1
comp.mobile.ipad	1
TOTAL: 16	258

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	108
EMP (md5)	71
EMP (fsl)	5
HTML post	2
TOTAL: 4	186

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	474571	10849	404369	14865	1	1917	2%	24:00:00
2	panorama	408333	3315	374822	1175	1	447403	0%	24:00:00
3	poznan	11904	41	8759	16	0	1	0%	24:02:24
4	nask	0	0	0	0	0	401975	0%	24:00:00
5	okapi	0	0	0	0	0	1814	0%	24:00:00
TOTAL: 5		894808	14205	787950	16056	2	853110	1%	120:02:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	2.0 GB	5.2 GB	7.2 GB	87.5 KB/s	294.0 KB	24:00:00
2	panorama	161.8 MB	226.7 MB	388.5 MB	4.6 KB/s	88.6 KB	24:00:00
3	poznan	175.9 KB	57.6 KB	233.5 KB	0.0 KB/s	4.1 KB	24:02:24
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		2.1 GB	5.5 GB	7.6 GB	18.4 KB/s	263.0 KB	120:02:24

Backlog files shrunk by innfeed:

Server	Size
panorama	4.3 MB
okapi	488.3 KB
TOTAL: 2	4.8 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	288	16	14.9 KB	8	0	0	00:00:34
TOTAL: 1		288	16	14.9 KB	8	0	0	03:02:45

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	672	16	14.9 KB	8	00:00:38
2	*.elsnet.pl	4	0	0.0 KB	0	00:00:20
3	unresolved	3	0	0.0 KB	0	03:01:39
4	*.toya.net.pl	59	0	0.0 KB	0	00:00:06
TOTAL: 4		738	16	14.9 KB	8	03:02:45

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89.38.40.100	3.315	4.469	03:01:37
web.man.lodz.pl	1.010	4.354	00:00:34
host227.elsnet.pl	0.010	0.052	00:00:20
staticline41435.toya.net.pl	0.165	0.846	00:00:06
mon.man.lodz.pl	1.039	3.830	00:00:03
196.52.18.39	0.003	0.013	00:00:01
david.man.lodz.pl	0.309	1.253	00:00:01
TOTAL: 7	5.851	14.817	03:02:45

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	59
host227.elsnet.pl	4
89.38.40.100	2
196.52.18.39	1
TOTAL: 6	450

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Mar 6 04:15:03 -- Mar 7 04:15:02