Daily Usenet report: Mar 17 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Mar 17 08:39:52 newsfeed overchan[2432]: input line too long, skipping
Mar 17 09:59:12 newsfeed nnrpd[18467]: SERVER perl filter not defined
Mar 17 12:42:39 newsfeed nnrpd[24003]: SERVER perl filter not defined
Mar 17 13:10:01 newsfeed pgpverify[24936]: pgpverify: verification failed
Mar 17 13:37:22 newsfeed nnrpd[25762]: SERVER perl filter not defined
Mar 17 13:49:39 newsfeed nnrpd[26253]: SERVER perl filter not defined
Mar 17 17:51:10 newsfeed nnrpd[1844]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1940509	98.4%	224.7 MB	98.0%
innd	16960	0.9%	2.8 MB	1.2%
nnrpd	7176	0.4%	757.5 KB	0.3%
innfeed	6833	0.3%	1022.0 KB	0.4%
controlchan	3	0.0%	0.4 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.2 KB	0.0%
TOTAL: 7	1971483	100.0%	229.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1926253	97.4%
Negative hits	33584	1.7%
Positive hits	17466	0.9%
Cache misses	115	0.0%
TOTAL: 4	1977418	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.858	0.0%	300	0.000	26.193	527.000
article cleanup	00:00:26.097	0.0%	1931271	0.000	0.014	0.028
article logging	00:00:49.569	0.1%	1940728	0.005	0.026	0.316
article parse	01:05:52.387	4.6%	124742388	0.013	0.032	0.050
article write	00:18:59.642	1.3%	1925743	0.271	0.592	1.369
artlog/artcncl	00:00:00.008	0.0%	281	0.000	0.028	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:02:14.937	0.2%	136429502	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.866	0.0%	264	0.000	3.280	23.833
hishave/artcncl	00:00:00.104	0.0%	300	0.000	0.347	9.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:51:31.694	3.6%	1978344	0.087	1.563	5.294
history sync	00:00:00.017	0.0%	292	0.000	0.058	1.000
history write	03:58:05.454	16.5%	1927363	3.460	7.412	26.020
hiswrite/artcncl	00:00:00.285	0.0%	36	0.000	7.917	56.000
idle	11:47:33.126	49.1%	76869638	0.347	0.552	5.307
nntp read	00:52:14.373	3.6%	123109361	0.013	0.025	0.036
overview write	00:00:12.955	0.0%	1925743	0.000	0.007	0.017
perl filter	04:24:40.849	18.4%	1927361	4.573	8.240	10.758
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:19.406	0.2%	3894589	0.011	0.051	0.090
TOTAL: 24:00:24.405	23:26:09.627	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.140	0.0%	43096	0.000	0.003	1.000
article prepare	00:00:00.005	0.0%	37458	0.000	0.000	0.036
article read	00:00:01.153	0.0%	9190	0.000	0.125	1.000
backlog stats	00:00:00.137	0.0%	260551	0.000	0.001	0.019
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.732	0.0%	170934	0.000	0.010	1.000
data write	00:00:08.222	0.0%	131420	0.000	0.063	19.000
idle	23:59:21.637	100.0%	260551	0.000	331.458	12060.000
status file	00:00:01.125	0.0%	196	0.000	5.740	204.500
TOTAL: 23:59:41.309	23:59:34.151	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	04:31:00.338	99.8%	4301	0.000	3780.595	450454.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.294	0.0%	10404	0.000	0.028	1.333
readart	00:00:00.657	0.0%	418	0.000	1.572	63.000
TOTAL: 04:31:25.621	04:31:01.289	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
newsmaster@carnet.hr	0	0	0	1	0	0
TOTAL	0	0	0	1	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	644	1925992	1920377	778	4837	99%	321:33:13
2	news.nask.pl	2	18079	4666	12848	565	25%	24:47:32
3	news.icm.edu.pl	38	370	44	179	147	11%	19:04:51
4	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 4		690	1944446	1925092	13805	5549	99%	365:25:36

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	597.8 GB	17.1 MB	147.5 MB	598.0 GB	99%	325.7 KB
2	news.nask.pl	19.7 MB	1.7 MB	1.8 MB	23.2 MB	85%	4.5 KB
3	news.icm.edu.pl	1.2 MB	147.7 KB	2.1 MB	3.4 MB	34%	18.3 KB
4	localhost	9.9 KB	0.0 KB	0.0 KB	9.9 KB	100%	2.0 KB
TOTAL: 4		597.8 GB	18.9 MB	151.3 MB	598.0 GB	99%	324.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 17 04:15:02 - 04:59:59	49576	2.6%	18.38	17.0 GB	2.8%	6617.61
Mar 17 05:00:00 - 05:59:59	77812	4.0%	21.61	26.4 GB	4.4%	7679.18
Mar 17 06:00:00 - 06:59:59	85619	4.4%	23.78	28.7 GB	4.8%	8357.89
Mar 17 07:00:00 - 07:59:59	83792	4.4%	23.28	28.5 GB	4.8%	8301.28
Mar 17 08:00:00 - 08:59:59	70659	3.7%	19.63	25.3 GB	4.2%	7363.74
Mar 17 09:00:00 - 09:59:59	78304	4.1%	21.75	27.1 GB	4.5%	7885.14
Mar 17 10:00:00 - 10:59:59	76497	4.0%	21.25	23.8 GB	4.0%	6932.77
Mar 17 11:00:00 - 11:59:59	72914	3.8%	20.25	24.2 GB	4.1%	7058.71
Mar 17 12:00:00 - 12:59:59	78186	4.1%	21.72	24.9 GB	4.2%	7266.38
Mar 17 13:00:00 - 13:59:59	81593	4.2%	22.66	26.6 GB	4.5%	7751.31
Mar 17 14:00:00 - 14:59:59	89275	4.6%	24.80	27.9 GB	4.7%	8116.60
Mar 17 15:00:00 - 15:59:59	80486	4.2%	22.36	27.2 GB	4.6%	7930.43
Mar 17 16:00:00 - 16:59:59	82024	4.3%	22.78	26.2 GB	4.4%	7639.19
Mar 17 17:00:00 - 17:59:59	102464	5.3%	28.46	28.3 GB	4.7%	8245.50
Mar 17 18:00:00 - 18:59:59	93523	4.9%	25.98	27.4 GB	4.6%	7984.06
Mar 17 19:00:00 - 19:59:59	86095	4.5%	23.92	28.2 GB	4.7%	8220.98
Mar 17 20:00:00 - 20:59:59	75738	3.9%	21.04	25.2 GB	4.2%	7340.91
Mar 17 21:00:00 - 21:59:59	83977	4.4%	23.33	26.1 GB	4.4%	7588.90
Mar 17 22:00:00 - 22:59:59	98613	5.1%	27.39	28.0 GB	4.7%	8163.44
Mar 17 23:00:00 - 23:59:59	111640	5.8%	31.01	27.8 GB	4.7%	8109.24
Mar 18 00:00:00 - 00:59:59	71833	3.7%	19.95	14.5 GB	2.4%	4234.36
Mar 18 01:00:00 - 01:59:59	45909	2.4%	12.75	11.6 GB	1.9%	3386.55
Mar 18 02:00:00 - 02:59:59	66787	3.5%	18.55	20.1 GB	3.4%	5862.71
Mar 18 03:00:00 - 03:59:59	63146	3.3%	17.54	20.2 GB	3.4%	5882.58
Mar 18 04:00:00 - 04:15:01	18785	1.0%	20.85	6.2 GB	1.0%	7255.49
TOTAL: 23:59:59	1925247	100.0%	22.28	597.6 GB	100.0%	7253.30

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	14273	181	3376	4	10712
2	news.nask.pl	560	6	525	7	22
3	news.icm.edu.pl	148	0	7	0	141
TOTAL: 3		14981	187	3908	11	10875

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	90
it.tlc.cellulari.android	26
hr.ponuda.hardver.komponente	21
comp.mobile.android	12
it.comp.os.win.windows7	10
it.comp.os.win.windows8	7
it.discussioni.energia	5
alt.sex.telephones	4
hr.alt.cellular.gsm.android	3
hr.ponuda.hardver.periferije	2
uk.rec.cycling.moderated	2
comp.sys.raspberry-pi	1
de.comm.software.mailreader	1
nl.comp.os.linux.techniek	1
hr.ponuda.hardver.konfiguracije	1
de.comp.office-pakete.ms-office.misc	1
TOTAL: 16	187

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

Groups	Count
pl.sci.historia	6
pl.praca.oferowana	4
bit.listserv.catholic	1
TOTAL: 3	11

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	1266
EMP (md5)	132
HTML post	9
Too many newsgroups	7
EMP (fsl)	1
Scoring filter (10)	1
TOTAL: 6	1416

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	44005	2215	40649	267	1	0	5%	24:01:28
2	icm	49746	509	34197	6268	1	8	1%	23:56:51
3	poznan	6318	58	4278	23	0	0	0%	24:01:00
4	nask	20937	39	14175	6	1	0	0%	23:56:05
5	okapi	0	0	0	0	0	2582	0%	24:00:01
TOTAL: 5		121006	2821	93299	6564	3	2590	2%	119:55:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	24.2 MB	1.4 GB	1.4 GB	17.0 KB/s	215.7 KB	23:56:51
2	panorama	9.7 MB	997.0 KB	10.7 MB	0.1 KB/s	4.4 KB	24:01:28
3	nask	284.2 KB	2.9 MB	3.2 MB	0.0 KB/s	72.5 KB	23:56:05
4	poznan	192.8 KB	60.5 KB	253.3 KB	0.0 KB/s	3.1 KB	24:01:00
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		34.4 MB	1.4 GB	1.4 GB	3.4 KB/s	157.3 KB	119:55:25

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	348	618.6 KB	288	0	00:00:11
2	web.man.lodz.pl	288	44	40.7 KB	20	0	00:00:24
3	pc-212-51-218-225.p.lodz.pl	6	26	57.6 KB	7	0	02:58:00
4	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:01
TOTAL: 4		587	418	716.9 KB	315	5	04:31:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	348	618.6 KB	288	0	00:00:11
2	*.man.lodz.pl	677	44	40.7 KB	20	5	00:00:31
3	*.p.lodz.pl	6	26	57.6 KB	7	0	02:58:00
4	*.shodan.io	1	0	0.0 KB	0	0	00:00:00
5	*.census.shodan.io	1	0	0.0 KB	0	0	00:00:00
6	unresolved	2	0	0.0 KB	0	0	01:32:36
7	*.toya.net.pl	61	0	0.0 KB	0	0	00:00:05
TOTAL: 7		1036	418	716.9 KB	315	5	04:31:25

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.036	0.082	02:58:00
212.191.87.58	0.006	0.044	01:32:36
web.man.lodz.pl	0.978	4.196	00:00:24
pc-skrzep2.cm.p.lodz.pl	1.132	4.326	00:00:11
staticline41435.toya.net.pl	0.243	0.878	00:00:05
mon.man.lodz.pl	0.942	4.062	00:00:03
isvcs01.man.lodz.pl	0.040	0.076	00:00:01
david.man.lodz.pl	0.387	1.300	00:00:01
census2.shodan.io	0.004	0.012	00:00:00
rim.census.shodan.io	0.005	0.014	00:00:00
TOTAL: 10	3.773	14.990	04:31:25

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	61
212.191.87.58	2
census2.shodan.io	1
rim.census.shodan.io	1
TOTAL: 6	449

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	4	0
212.191.87.58	1	0
TOTAL: 2	5	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	348	83.3%
2	pl	70	16.7%
TOTAL: 2		418	100.0%

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

Newsgroup		Count
1	lodman.info	348
2	pl.comp.pecet	24
3	pl.comp.os.ms-windows.winnt	20
4	pl.misc.elektronika	15
5	pl.misc.kolej	11
TOTAL: 5		418

Daily Usenet report

Mar 17 04:15:02 -- Mar 18 04:15:01