Daily Usenet report: Aug 7 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Aug 7 07:55:51 newsfeed nnrpd[32655]: SERVER perl filter not defined
Aug 7 07:58:03 newsfeed nnrpd[32675]: SERVER perl filter not defined
Aug 7 08:37:40 newsfeed nnrpd[1614]: SERVER perl filter not defined
Aug 7 10:31:07 newsfeed nnrpd[5578]: SERVER perl filter not defined
Aug 7 11:59:27 newsfeed nnrpd[8585]: SERVER perl filter not defined
Aug 7 13:23:07 newsfeed overchan[29462]: message repeated 7 times: [ input line too long, skipping]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3033868	98.1%	352.4 MB	97.8%
innfeed	27856	0.9%	3.4 MB	0.9%
innd	24745	0.8%	4.2 MB	1.2%
nnrpd	4806	0.2%	505.5 KB	0.1%
controlchan	2	0.0%	0.3 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 6	3091279	100.0%	360.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3027059	98.6%
Negative hits	27092	0.9%
Positive hits	15579	0.5%
Cache misses	191	0.0%
TOTAL: 4	3069921	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.952	0.0%	343	0.000	11.522	421.000
article cleanup	00:00:42.761	0.0%	3031717	0.005	0.014	0.025
article logging	00:01:43.197	0.1%	3032049	0.020	0.034	0.416
article parse	01:07:10.580	4.7%	122671464	0.024	0.033	0.078
article write	00:36:25.229	2.5%	3028222	0.368	0.722	3.028
artlog/artcncl	00:00:00.004	0.0%	334	0.000	0.012	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:03.187	0.1%	140490290	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.499	0.0%	311	0.000	1.605	30.000
hishave/artcncl	00:00:00.194	0.0%	343	0.000	0.566	21.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:27:18.330	1.9%	3071260	0.127	0.533	8.683
history sync	00:00:00.014	0.0%	291	0.000	0.048	1.000
history write	00:48:09.526	3.3%	3028617	0.264	0.954	14.993
hiswrite/artcncl	00:00:00.058	0.0%	32	0.000	1.812	19.000
idle	13:51:38.222	57.8%	89443874	0.256	0.558	1.886
nntp read	00:52:18.169	3.6%	120288925	0.019	0.026	0.038
overview write	00:00:18.998	0.0%	3028222	0.001	0.006	0.017
perl filter	05:28:51.221	22.8%	3028617	5.098	6.515	8.999
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:06:45.637	0.5%	6120961	0.007	0.066	0.101
TOTAL: 23:59:21.850	23:23:29.778	97.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.340	0.0%	106209	0.000	0.003	0.105
article prepare	00:00:00.026	0.0%	112454	0.000	0.000	0.083
article read	00:00:42.406	0.0%	28114	0.000	1.508	352.000
backlog stats	00:00:00.257	0.0%	322248	0.000	0.001	0.023
callbacks	00:00:00.000	0.0%	13	0.000	0.000	0.000
data read	00:00:02.713	0.0%	180415	0.000	0.015	0.122
data write	00:00:20.808	0.0%	124981	0.000	0.166	3.864
idle	23:57:26.940	99.9%	322248	30.275	267.642	1562.872
status file	00:00:08.101	0.0%	9118	0.100	0.888	78.667
TOTAL: 23:58:54.829	23:58:41.591	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:09:09.634	98.1%	3082	0.000	178.337	173055.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.139	0.0%	6848	0.000	0.020	0.500
readart	00:00:00.011	0.0%	60	0.000	0.183	4.000
TOTAL: 00:09:20.204	00:09:09.784	98.1%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	149
name	2
newgroup	1
pause	2
paused	2
reload	2
reserve	2
TOTAL: 12	191

Newsgroups created:

Group	Mode
alt.binaries.movies.christian	y
TOTAL	1

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
153fishare@gmail.com	1	0	0	0	1	1
TOTAL	1	0	0	0	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1528	3029967	3026549	205	3213	99%	352:49:48
2	news.nask.pl	2	15535	3422	11841	272	22%	23:32:28
3	news.icm.edu.pl	50	217	39	174	4	17%	16:53:08
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		1586	3045724	3030015	12220	3489	99%	393:15:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	865.0 GB	17.6 MB	25.0 MB	865.1 GB	99%	299.4 KB
2	news.nask.pl	15.7 MB	1.5 MB	1.6 MB	18.8 MB	83%	5.2 KB
3	news.icm.edu.pl	674.7 KB	84.0 KB	107.7 KB	866.4 KB	77%	20.1 KB
4	localhost	7.1 KB	0.0 KB	0.0 KB	7.1 KB	100%	1.4 KB
TOTAL: 4		865.0 GB	19.2 MB	26.7 MB	865.1 GB	99%	299.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 7 04:15:02 - 04:59:59	83287	2.7%	30.87	22.5 GB	2.6%	8731.62
Aug 7 05:00:00 - 05:59:59	92814	3.1%	25.78	29.7 GB	3.4%	8653.39
Aug 7 06:00:00 - 06:59:59	111590	3.7%	31.00	34.1 GB	4.0%	9937.61
Aug 7 07:00:00 - 07:59:59	130329	4.3%	36.20	39.5 GB	4.6%	11492.91
Aug 7 08:00:00 - 08:59:59	132487	4.4%	36.80	40.7 GB	4.7%	11858.16
Aug 7 09:00:00 - 09:59:59	144813	4.8%	40.23	41.6 GB	4.8%	12109.04
Aug 7 10:00:00 - 10:59:59	154395	5.1%	42.89	41.9 GB	4.9%	12201.64
Aug 7 11:00:00 - 11:59:59	136001	4.5%	37.78	40.3 GB	4.7%	11744.85
Aug 7 12:00:00 - 12:59:59	142804	4.7%	39.67	40.5 GB	4.7%	11794.67
Aug 7 13:00:00 - 13:59:59	134932	4.5%	37.48	38.1 GB	4.4%	11094.58
Aug 7 14:00:00 - 14:59:59	92813	3.1%	25.78	26.9 GB	3.1%	7847.08
Aug 7 15:00:00 - 15:59:59	127994	4.2%	35.55	36.4 GB	4.2%	10613.09
Aug 7 16:00:00 - 16:59:59	136798	4.5%	38.00	37.5 GB	4.3%	10909.28
Aug 7 17:00:00 - 17:59:59	133796	4.4%	37.17	36.1 GB	4.2%	10505.07
Aug 7 18:00:00 - 18:59:59	134967	4.5%	37.49	36.8 GB	4.3%	10718.36
Aug 7 19:00:00 - 19:59:59	139526	4.6%	38.76	38.6 GB	4.5%	11236.48
Aug 7 20:00:00 - 20:59:59	143522	4.7%	39.87	38.5 GB	4.5%	11203.08
Aug 7 21:00:00 - 21:59:59	136117	4.5%	37.81	38.1 GB	4.4%	11109.94
Aug 7 22:00:00 - 22:59:59	135508	4.5%	37.64	38.7 GB	4.5%	11282.16
Aug 7 23:00:00 - 23:59:59	129909	4.3%	36.09	38.2 GB	4.4%	11114.62
Aug 8 00:00:00 - 00:59:59	104368	3.4%	28.99	30.1 GB	3.5%	8766.40
Aug 8 01:00:00 - 01:59:59	134295	4.4%	37.30	37.6 GB	4.4%	10945.53
Aug 8 02:00:00 - 02:59:59	93036	3.1%	25.84	26.5 GB	3.1%	7726.56
Aug 8 03:00:00 - 03:59:59	92769	3.1%	25.77	26.3 GB	3.0%	7651.58
Aug 8 04:00:00 - 04:15:02	30837	1.0%	34.19	7.9 GB	0.9%	9164.95
TOTAL: 24:00:00	3029707	100.0%	35.07	863.0 GB	100.0%	10473.18

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3491	228	2852	1	410
2	news.nask.pl	331	17	246	12	56
3	news.icm.edu.pl	5	0	2	0	3
TOTAL: 3		3827	245	3100	13	469

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it.comp.os.win.windows10	67
uk.railway	65
it.tlc.cellulari.android	52
comp.mobile.android	11
comp.sys.raspberry-pi	10
alt.windows7.general	9
de.comp.lang.vbclassic	8
it.comp.os.win.windows7	7
nl.comp.os.linux.techniek	5
alt.sex.telephones	4
hr.rec.glazba.hifi	3
it.discussioni.energia	2
it.comp.os.win.windows8	1
comp.mac.ipad	1
TOTAL: 14	245

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	126
HTML post	6
Attached HTML file	2
Too many newsgroups	1
Scoring filter (10)	1
EMP (md5)	1
TOTAL: 6	137

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	44596	1685	27230	668	29	76724	3%	24:00:01
2	icm	63589	457	24073	24600	0	10	0%	23:59:39
3	poznan	5146	72	3376	34	0	0	1%	24:04:17
4	okapi	0	0	0	0	0	2474	0%	23:51:03
5	nask	0	0	0	0	0	12434	0%	23:51:03
TOTAL: 5		113331	2214	54679	25302	29	91642	1%	119:46:03

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.0 MB	5.8 GB	5.8 GB	70.1 KB/s	241.5 KB	23:59:39
2	panorama	4.9 MB	3.4 MB	8.3 MB	0.1 KB/s	3.6 KB	24:00:01
3	poznan	2.9 MB	62.9 KB	2.9 MB	0.0 KB/s	28.3 KB	24:04:17
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:51:03
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:51:03
TOTAL: 5		13.8 MB	5.8 GB	5.8 GB	14.1 KB/s	220.4 KB	119:46:03

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	60	66.5 KB	27	0	00:00:29
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 2		293	60	66.5 KB	27	5	00:09:19

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	677	60	66.5 KB	27	5	00:00:33
2	*.dynamic.mm.pl	1	0	0.0 KB	0	0	00:08:39
3	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:06
TOTAL: 3		680	60	66.5 KB	27	5	00:09:19

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
host-46-186-119-162.dynamic.mm.pl	0.018	0.029	00:08:39
web.man.lodz.pl	1.188	5.416	00:00:29
host227.elsnet.pl	0.017	0.021	00:00:06
mon.man.lodz.pl	1.043	5.771	00:00:03
david.man.lodz.pl	0.354	1.693	00:00:00
isvcs01.man.lodz.pl	0.034	0.101	00:00:00
TOTAL: 6	2.654	13.031	00:09:19

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
host227.elsnet.pl	2
host-46-186-119-162.dynamic.mm.pl	1
TOTAL: 4	387

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Aug 7 04:15:02 -- Aug 8 04:15:02