Daily Usenet report: Oct 29 04:15:03

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 29 09:36:27 newsfeed pgpverify[29449]: pgpverify: verification failed
Oct 29 09:36:31 newsfeed pgpverify[29464]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3167536	98.6%	367.4 MB	98.3%
innd	34232	1.1%	5.0 MB	1.3%
innfeed	5029	0.2%	696.1 KB	0.2%
nnrpd	4983	0.2%	515.1 KB	0.1%
controlchan	6	0.0%	0.9 KB	0.0%
pgpverify	2	0.0%	0.3 KB	0.0%
TOTAL: 6	3211788	100.0%	373.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3161781	96.8%
Negative hits	91837	2.8%
Positive hits	13099	0.4%
Cache misses	111	0.0%
TOTAL: 4	3266828	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.795	0.0%	170	0.000	22.324	1903.000
article cleanup	00:00:53.800	0.1%	3167116	0.007	0.017	0.030
article logging	00:01:48.852	0.1%	3167692	0.020	0.034	0.627
article parse	01:31:25.219	6.1%	168318716	0.016	0.033	0.076
article write	00:29:54.970	2.0%	3152530	0.348	0.569	2.987
artlog/artcncl	00:00:00.005	0.0%	169	0.000	0.030	1.000
data move	00:04:11.194	0.3%	186932889	0.001	0.001	0.006
hisgrep/artcncl	00:00:00.242	0.0%	149	0.000	1.624	19.000
hishave/artcncl	00:00:00.138	0.0%	170	0.000	0.812	13.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:34:03.127	2.3%	3268119	0.112	0.625	13.239
history sync	00:00:00.013	0.0%	302	0.000	0.043	1.000
history write	00:51:04.470	3.4%	3163132	0.217	0.969	14.782
hiswrite/artcncl	00:00:00.019	0.0%	21	0.000	0.905	16.000
idle	12:34:24.727	50.3%	95849031	0.336	0.472	0.741
nntp read	01:11:37.938	4.8%	165594144	0.016	0.026	0.043
overview write	00:00:21.074	0.0%	3152530	0.002	0.007	0.020
perl filter	06:48:59.619	27.3%	3163132	5.818	7.758	10.340
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:55.695	0.4%	6333601	0.029	0.056	0.094
TOTAL: 25:00:14.167	24:14:44.897	97.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.137	0.0%	35530	0.000	0.004	0.222
article prepare	00:00:00.011	0.0%	35038	0.000	0.000	0.250
article read	00:00:03.170	0.0%	8932	0.000	0.355	57.500
backlog stats	00:00:00.146	0.0%	175899	0.000	0.001	0.037
callbacks	00:00:00.001	0.0%	182	0.000	0.005	0.026
data read	00:00:01.341	0.0%	91533	0.000	0.015	0.158
data write	00:00:07.592	0.0%	82311	0.000	0.092	0.286
idle	25:00:28.289	100.0%	175899	25.267	511.818	5469.545
status file	00:00:00.764	0.0%	949	0.000	0.805	5.000
TOTAL: 25:00:47.298	25:00:41.451	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	08:27:20.297	99.9%	189189	0.000	160.899	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:08.384	0.0%	379083	0.000	0.022	0.667
readart	00:00:01.825	0.0%	71	0.000	25.704	121.533
TOTAL: 08:27:56.455	08:27:30.506	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	25
flushlogs	2
go	2
logmode	2
mode	154
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	196

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
grisbi-control@grisbi.org	0	0	0	2	0	0
TOTAL	0	0	0	2	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1143	3153161	3142870	5852	4439	99%	449:52:13
2	news.nask.pl	2	22469	9506	2857	10106	42%	25:01:17
3	news.icm.edu.pl	39	459	14	391	54	3%	18:19:08
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		1185	3176089	3152390	9100	14599	99%	493:12:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	939.8 GB	123.7 MB	209.3 MB	940.1 GB	99%	313.2 KB
2	news.nask.pl	65.7 MB	792.4 KB	190.7 MB	257.2 MB	25%	13.4 KB
3	news.icm.edu.pl	287.3 KB	28.1 KB	1.4 MB	1.7 MB	16%	26.3 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		939.9 GB	124.5 MB	401.4 MB	940.4 GB	99%	311.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 29 04:15:03 - 04:59:59	73136	2.3%	27.12	26.0 GB	2.8%	10092.63
Oct 29 05:00:00 - 05:59:59	107694	3.4%	29.91	39.0 GB	4.2%	11369.29
Oct 29 06:00:00 - 06:59:59	102254	3.2%	28.40	37.4 GB	4.0%	10883.81
Oct 29 07:00:00 - 07:59:59	103286	3.3%	28.69	35.5 GB	3.8%	10342.20
Oct 29 08:00:00 - 08:59:59	131041	4.2%	36.40	38.0 GB	4.0%	11067.67
Oct 29 09:00:00 - 09:59:59	123460	3.9%	34.29	36.9 GB	3.9%	10752.75
Oct 29 10:00:00 - 10:59:59	128342	4.1%	35.65	38.6 GB	4.1%	11235.03
Oct 29 11:00:00 - 11:59:59	128051	4.1%	35.57	39.3 GB	4.2%	11436.48
Oct 29 12:00:00 - 12:59:59	123192	3.9%	34.22	39.0 GB	4.2%	11357.98
Oct 29 13:00:00 - 13:59:59	136903	4.3%	38.03	40.6 GB	4.3%	11835.20
Oct 29 14:00:00 - 14:59:59	123925	3.9%	34.42	39.3 GB	4.2%	11434.28
Oct 29 15:00:00 - 15:59:59	123972	3.9%	34.44	37.7 GB	4.0%	10995.18
Oct 29 16:00:00 - 16:59:59	114708	3.6%	31.86	31.0 GB	3.3%	9026.56
Oct 29 17:00:00 - 17:59:59	155953	4.9%	43.32	40.6 GB	4.3%	11812.85
Oct 29 18:00:00 - 18:59:59	152391	4.8%	42.33	38.9 GB	4.1%	11322.80
Oct 29 19:00:00 - 19:59:59	132355	4.2%	36.77	38.4 GB	4.1%	11197.26
Oct 29 20:00:00 - 20:59:59	137937	4.4%	38.32	38.0 GB	4.1%	11080.64
Oct 29 21:00:00 - 21:59:59	162135	5.1%	45.04	40.8 GB	4.3%	11888.13
Oct 29 22:00:00 - 22:59:59	145440	4.6%	40.40	40.1 GB	4.3%	11689.37
Oct 29 23:00:00 - 23:59:59	127933	4.1%	35.54	38.4 GB	4.1%	11185.38
Oct 30 00:00:00 - 00:59:59	110898	3.5%	30.80	31.5 GB	3.4%	9164.79
Oct 30 01:00:00 - 01:59:59	138074	4.4%	38.35	39.7 GB	4.2%	11556.39
Oct 30 02:00:00 - 02:59:59	240368	7.6%	66.77	73.0 GB	7.8%	21275.19
Oct 30 03:00:00 - 03:59:59	102597	3.3%	28.50	32.0 GB	3.4%	9315.15
Oct 30 04:00:00 - 04:15:02	26165	0.8%	29.01	8.9 GB	0.9%	10290.92
TOTAL: 23:59:59	3152210	100.0%	36.48	938.5 GB	100.0%	11390.29

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	10319	9	284	26	10000
2	newsfeed.pionier.net.pl	4784	128	3696	0	960
3	news.icm.edu.pl	54	0	1	0	53
TOTAL: 3		15157	137	3981	26	11013

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	99
uk.rec.cycling.moderated	14
comp.mobile.ipad	6
it.comp.os.win.windows7	4
it.comp.os.win.windows10	4
it.tlc.cellulari.android	4
comp.sys.raspberry-pi	3
it.tlc.cellulari.iphone	1
uk.net.providers.gradwell	1
de.rec.sf.startrek	1
TOTAL: 10	137

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

Groups	Count
pl.sci.matematyka	14
pl.praca.oferowana	11
bit.listserv.catholic	1
TOTAL: 3	26

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8879
Binary in non-binary group	1282
EMP (phl)	168
Scoring filter (8)	52
Scoring filter (9)	29
Too many newsgroups	9
Scoring filter (10)	7
Scoring filter (11)	5
Scoring filter (13)	4
HTML post	2
TOTAL: 10	10437

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	32371	394	19142	7736	0	0	1%	24:57:28
2	panorama	8149	186	6044	68	371	28811	2%	25:02:42
3	poznan	13407	116	9253	19	0	0	0%	24:59:35
4	nask	6435	24	4934	0	0	0	0%	24:52:33
5	okapi	0	0	0	0	0	1579	0%	25:00:04
TOTAL: 5		60362	720	39373	7823	371	30390	1%	124:52:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.1 MB	2.0 GB	2.0 GB	23.5 KB/s	259.5 KB	24:57:28
2	panorama	834.8 KB	764.3 KB	1.6 MB	0.0 KB/s	6.3 KB	25:02:42
3	poznan	666.9 KB	67.5 KB	734.4 KB	0.0 KB/s	5.4 KB	24:59:35
4	nask	119.3 KB	0.0 KB	119.3 KB	0.0 KB/s	5.0 KB	24:52:33
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	25:00:04
TOTAL: 5		7.7 MB	2.0 GB	2.0 GB	4.7 KB/s	247.2 KB	124:52:22

Backlog files shrunk by innfeed:

Server	Size
panorama	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	web.man.lodz.pl	300	56	94.5 KB	25	0	0	00:00:24
TOTAL: 1		300	56	94.5 KB	25	0	0	08:27:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.man.lodz.pl	700	56	94.5 KB	25	00:00:30
2	unresolved	6	0	0.0 KB	0	08:27:25
TOTAL: 2		706	56	94.5 KB	25	08:27:56

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.119	10.414	16.196	08:20:22
185.48.194.205	0.100	0.228	00:06:57
web.man.lodz.pl	1.029	6.162	00:00:24
196.52.16.22	0.004	0.021	00:00:05
mon.man.lodz.pl	1.037	5.896	00:00:03
david.man.lodz.pl	0.320	1.785	00:00:01
TOTAL: 6	12.904	30.288	08:27:56

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	300
david.man.lodz.pl	100
185.48.194.205	3
185.48.193.119	2
196.52.16.22	1
TOTAL: 5	406

NNRP client timeouts [Top 20]:

System	Conn	Peer
185.48.193.119	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	32
2	pl.comp.pecet	24
TOTAL: 2		56

Daily Usenet report

Oct 29 04:15:03 -- Oct 30 04:15:02