Daily Usenet report: Feb 25 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Feb 25 14:23:37 newsfeed nnrpd[18365]: SERVER perl filter not defined
Feb 25 14:24:47 newsfeed nnrpd[18373]: SERVER perl filter not defined
Feb 25 14:25:10 newsfeed nnrpd[18558]: SERVER perl filter not defined
Feb 25 14:46:28 newsfeed nnrpd[19209]: SERVER perl filter not defined
Feb 25 14:48:08 newsfeed nnrpd[19251]: SERVER perl filter not defined
Feb 25 15:17:32 newsfeed nnrpd[20254]: SERVER perl filter not defined
Feb 25 22:00:03 newsfeed pgpverify[1186]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	558760	96.1%	62.9 MB	95.4%
innd	9154	1.6%	1.5 MB	2.2%
nnrpd	6996	1.2%	722.1 KB	1.1%
innfeed	6454	1.1%	914.6 KB	1.4%
controlchan	1	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	581366	100.0%	65.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	555067	94.3%
Positive hits	17654	3.0%
Negative hits	15511	2.6%
Cache misses	372	0.1%
TOTAL: 4	588604	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:13.248	0.0%	572	0.000	23.161	263.000
article cleanup	00:00:07.832	0.0%	557933	0.000	0.014	0.050
article logging	00:00:13.999	0.0%	558076	0.000	0.025	0.104
article parse	00:16:22.056	1.1%	41195915	0.009	0.024	0.046
article write	00:05:01.430	0.3%	553813	0.133	0.544	6.632
artlog/artcncl	00:00:00.005	0.0%	556	0.000	0.009	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:51.593	0.1%	44311899	0.000	0.001	0.018
hisgrep/artcncl	00:00:05.246	0.0%	540	0.000	9.715	47.750
hishave/artcncl	00:00:01.945	0.0%	572	0.000	3.400	54.750
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:54:19.838	3.8%	588190	1.247	5.542	29.538
history sync	00:00:00.015	0.0%	541	0.000	0.028	1.000
history write	01:14:07.836	5.1%	555178	1.875	8.012	32.968
hiswrite/artcncl	00:00:00.400	0.0%	32	0.000	12.500	13.207
idle	19:50:27.508	82.7%	33097581	0.464	2.158	12.558
nntp read	00:16:31.669	1.1%	40847630	0.012	0.024	0.057
overview write	00:00:03.392	0.0%	553813	0.000	0.006	0.034
perl filter	01:07:43.992	4.7%	555176	3.028	7.320	10.476
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:14.266	0.1%	1147816	0.031	0.065	0.140
TOTAL: 24:00:20.958	23:47:26.270	99.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.138	0.0%	40217	0.000	0.003	0.091
article prepare	00:00:00.004	0.0%	20004	0.000	0.000	0.062
article read	00:00:00.457	0.0%	4926	0.000	0.093	1.000
backlog stats	00:00:00.112	0.0%	237625	0.000	0.000	0.018
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.476	0.0%	158135	0.000	0.009	1.000
data write	00:00:04.177	0.0%	118388	0.000	0.035	2.000
idle	24:00:16.475	100.0%	237625	0.000	363.667	12304.000
status file	00:00:01.389	0.0%	203	0.000	6.842	347.000
TOTAL: 24:00:29.550	24:00:24.228	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.264	0.0%	21	12.571	12.571	12.571
idle	02:17:07.824	99.6%	17000	0.000	483.990	450826.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.946	0.0%	36024	0.000	0.026	16.300
readart	00:00:09.403	0.1%	541	0.000	17.381	63.476
TOTAL: 02:17:40.544	02:17:18.437	99.7%	-	-	-	-

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
group-admin@isc.org	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	187	554328	550797	244	3287	99%	110:04:38
2	news.nask.pl	4	17679	2634	14227	818	14%	23:42:15
3	news.icm.edu.pl	53	219	24	187	8	10%	17:31:06
4	localhost	7	6	6	0	0	100%	00:00:00
TOTAL: 4		251	572232	553461	14658	4113	96%	151:17:59

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	128.1 GB	12.1 MB	169.4 MB	128.3 GB	99%	242.8 KB
2	news.nask.pl	13.4 MB	2.2 MB	2.4 MB	18.0 MB	74%	5.3 KB
3	news.icm.edu.pl	449.0 KB	46.6 KB	315.0 KB	810.6 KB	55%	25.3 KB
4	localhost	12.5 KB	0.0 KB	0.0 KB	12.5 KB	100%	2.1 KB
TOTAL: 4		128.1 GB	14.4 MB	172.0 MB	128.3 GB	99%	241.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 25 04:15:02 - 04:59:59	7513	1.4%	2.78	1.2 GB	0.9%	460.07
Feb 25 05:00:00 - 05:59:59	9434	1.7%	2.62	1.2 GB	0.9%	338.53
Feb 25 06:00:00 - 06:59:59	7141	1.3%	1.98	1.1 GB	0.9%	317.98
Feb 25 07:00:00 - 07:59:59	7313	1.3%	2.03	1.0 GB	0.8%	292.10
Feb 25 08:00:00 - 08:59:59	8860	1.6%	2.46	1.2 GB	0.9%	350.99
Feb 25 09:00:00 - 09:59:59	10541	1.9%	2.93	1.8 GB	1.4%	511.03
Feb 25 10:00:00 - 10:59:59	10735	1.9%	2.98	1.6 GB	1.3%	472.03
Feb 25 11:00:00 - 11:59:59	9913	1.8%	2.75	1.1 GB	0.9%	331.37
Feb 25 12:00:00 - 12:59:59	9769	1.8%	2.71	1.2 GB	1.0%	363.41
Feb 25 13:00:00 - 13:59:59	10147	1.8%	2.82	1.2 GB	0.9%	336.62
Feb 25 14:00:00 - 14:59:59	10976	2.0%	3.05	1.2 GB	0.9%	337.95
Feb 25 15:00:00 - 15:59:59	12244	2.2%	3.40	1.3 GB	1.0%	379.74
Feb 25 16:00:00 - 16:59:59	12034	2.2%	3.34	1.2 GB	1.0%	360.33
Feb 25 17:00:00 - 17:59:59	10980	2.0%	3.05	1.2 GB	1.0%	355.46
Feb 25 18:00:00 - 18:59:59	10903	2.0%	3.03	1.3 GB	1.0%	382.29
Feb 25 19:00:00 - 19:59:59	12209	2.2%	3.39	1.5 GB	1.2%	443.21
Feb 25 20:00:00 - 20:59:59	15903	2.9%	4.42	2.0 GB	1.5%	568.80
Feb 25 21:00:00 - 21:59:59	26015	4.7%	7.23	6.4 GB	5.0%	1854.85
Feb 25 22:00:00 - 22:59:59	31577	5.7%	8.77	7.9 GB	6.1%	2294.74
Feb 25 23:00:00 - 23:59:59	56861	10.3%	15.79	16.5 GB	12.9%	4806.67
Feb 26 00:00:00 - 00:59:59	54108	9.8%	15.03	13.9 GB	10.9%	4057.87
Feb 26 01:00:00 - 01:59:59	71422	12.9%	19.84	20.1 GB	15.7%	5860.07
Feb 26 02:00:00 - 02:59:59	51932	9.4%	14.43	15.0 GB	11.7%	4378.51
Feb 26 03:00:00 - 03:59:59	71177	12.8%	19.77	21.6 GB	16.8%	6277.53
Feb 26 04:00:00 - 04:15:02	14221	2.6%	15.77	4.7 GB	3.7%	5448.42
TOTAL: 24:00:00	553928	100.0%	6.41	128.3 GB	100.0%	1557.58

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3433	200	1971	16	1246
2	news.nask.pl	835	8	785	19	23
3	news.icm.edu.pl	8	0	2	1	5
TOTAL: 3		4276	208	2758	36	1274

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	83
it.comp.os.win.windows8	22
it.tlc.cellulari.android	21
hr.ponuda.hardver.komponente	14
comp.mobile.ipad	13
it.comp.os.win.windows7	12
comp.sys.raspberry-pi	10
comp.mobile.android	9
it.comp.os.linux.ubuntu	7
nl.comp.os.linux.techniek	5
alt.sex.telephones	4
hr.alt.cellular.gsm.iphone	4
it.comp.virtualizzazione	1
hr.alt.cellular.gsm.android	1
nl.wetenschap.regulier	1
de.comm.software.mailreader	1
TOTAL: 16	208

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

Groups	Count
pl.sci.historia	26
pl.praca.oferowana	7
clari.local.indiana	2
bit.listserv.catholic	1
TOTAL: 4	36

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	1107
EMP (md5)	19
HTML post	3
TOTAL: 3	1129

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	47697	3105	34882	591	23	6%	24:08:11
2	panorama	40744	1075	38936	136	0	2%	23:59:54
3	nask	23248	44	15877	7	0	0%	24:08:32
4	poznan	3215	19	2293	19	0	0%	23:58:49
5	okapi	0	0	0	0	2746	0%	24:00:00
TOTAL: 5		114904	4243	91988	753	2769	3%	120:15:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	442.5 MB	36.4 MB	478.9 MB	5.6 KB/s	132.7 KB	24:08:11
2	panorama	5.3 MB	494.5 KB	5.8 MB	0.1 KB/s	4.9 KB	23:59:54
3	nask	232.7 KB	70.6 KB	303.3 KB	0.0 KB/s	5.9 KB	24:08:32
4	poznan	187.4 KB	32.2 KB	219.7 KB	0.0 KB/s	5.8 KB	23:58:49
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		448.3 MB	37.0 MB	485.3 MB	1.1 KB/s	99.5 KB	120:15:26

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	340	654.7 KB	288	0	00:00:07
2	bursztyn.p.lodz.pl	2	145	25.5 MB	6	0	00:25:16
3	web.man.lodz.pl	288	50	40.1 KB	22	0	00:00:19
4	pc-vicki.man.lodz.pl	3	6	14.7 KB	2	0	01:04:17
5	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 5		587	541	26.2 MB	318	6	02:17:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	340	654.7 KB	288	0	00:00:07
2	*.p.lodz.pl	2	145	25.5 MB	6	0	00:25:16
3	*.man.lodz.pl	681	56	54.8 KB	24	6	01:04:42
4	*.elsnet.pl	8	0	0.0 KB	0	0	00:01:11
5	unresolved	2	0	0.0 KB	0	0	00:29:26
6	*.105.135.22.tvsat364.lodz.pl	1	0	0.0 KB	0	0	00:16:49
7	*.toya.net.pl	20	0	0.0 KB	0	0	00:00:04
TOTAL: 7		1002	541	26.2 MB	318	6	02:17:40

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-vicki.man.lodz.pl	0.050	0.070	01:04:17
185.48.193.11	0.565	0.650	00:29:26
bursztyn.p.lodz.pl	0.073	0.226	00:25:16
ip-176.105.135.22.tvsat364.lodz.pl	0.006	0.012	00:16:49
host227.elsnet.pl	0.027	0.106	00:01:11
web.man.lodz.pl	0.949	3.785	00:00:19
pc-skrzep2.cm.p.lodz.pl	1.040	3.900	00:00:07
staticline41435.toya.net.pl	0.074	0.251	00:00:04
mon.man.lodz.pl	0.997	3.662	00:00:04
david.man.lodz.pl	0.319	1.212	00:00:01
isvcs01.man.lodz.pl	0.035	0.086	00:00:00
TOTAL: 11	4.135	13.960	02:17:40

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	20
host227.elsnet.pl	8
185.48.193.11	2
ip-176.105.135.22.tvsat364.lodz.pl	1
TOTAL: 6	415

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-vicki.man.lodz.pl	2	0
TOTAL: 1	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	340	62.8%
2	alt	145	26.8%
3	pl	56	10.4%
TOTAL: 3		541	100.0%

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

Newsgroup		Count
1	lodman.info	340
2	alt.binaries.erotic	59
3	pl.comp.pecet	40
4	alt.binaries.erotica.pornstar	38
5	alt.binares.erotica	30
6	alt.binaries.erotica.pictures.croats.female	14
7	pl.comp.os.ms-windows.winnt	10
8	pl.sci.medycyna	6
9	alt.binaries.erotica.sex.in.the.morning	3
10	alt.binaries.erotica.dicks	1
TOTAL: 10		541

Daily Usenet report

Feb 25 04:15:02 -- Feb 26 04:15:02