Daily Usenet report: Jun 10 04:15:05

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jun 10 11:23:17 newsfeed pgpverify[6563]: pgpverify: verification failed
Jun 10 14:15:07 newsfeed nnrpd[12030]: SERVER perl filter not defined
Jun 10 18:43:38 newsfeed nnrpd[20789]: SERVER perl filter not defined
Jun 10 21:29:10 newsfeed nnrpd[26134]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2510740	98.6%	288.4 MB	98.2%
innd	18123	0.7%	3.1 MB	1.1%
nnrpd	9780	0.4%	1.0 MB	0.3%
innfeed	7247	0.3%	1.1 MB	0.4%
controlchan	1	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
TOTAL: 6	2545892	100.0%	293.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2499700	95.0%
Negative hits	87108	3.3%
Positive hits	44097	1.7%
Cache misses	399	0.0%
TOTAL: 4	2631304	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:15.231	0.0%	314	0.000	48.506	909.000
article cleanup	00:00:36.674	0.0%	2509727	0.005	0.015	0.557
article logging	00:01:40.254	0.1%	2509911	0.014	0.040	0.852
article parse	01:08:47.315	4.8%	58317478	0.025	0.071	0.268
article write	00:29:27.281	2.0%	2498252	0.404	0.707	4.433
artlog/artcncl	00:00:00.006	0.0%	299	0.000	0.020	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:02:55.737	0.2%	70580222	0.001	0.002	0.032
hisgrep/artcncl	00:00:02.363	0.0%	257	0.000	9.195	285.000
hishave/artcncl	00:00:01.481	0.0%	314	0.000	4.717	198.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	05:07:56.934	21.4%	2631387	0.011	7.022	24.045
history sync	00:00:00.016	0.0%	293	0.000	0.055	13.000
history write	06:40:09.612	27.8%	2499778	0.227	9.605	52.077
hiswrite/artcncl	00:00:00.454	0.0%	57	0.000	7.965	128.000
idle	03:02:52.179	12.7%	21280944	0.145	0.516	7.466
nntp read	00:35:39.539	2.5%	56182224	0.019	0.038	0.191
overview write	00:00:18.076	0.0%	2498252	0.001	0.007	0.226
perl filter	06:20:21.757	26.4%	2499767	6.601	9.130	25.693
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:08:46.845	0.6%	5047385	0.009	0.104	0.891
TOTAL: 23:59:41.021	23:39:51.754	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.768	0.0%	52039	0.000	0.015	526.000
article prepare	00:00:00.038	0.0%	99608	0.000	0.000	0.125
article read	00:00:24.791	0.0%	23409	0.000	1.059	125.375
backlog stats	00:00:00.744	0.0%	348408	0.000	0.002	0.897
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:06.822	0.0%	219315	0.000	0.031	176.000
data write	00:00:17.661	0.0%	180810	0.000	0.098	307.000
idle	23:58:44.981	99.9%	348408	0.000	247.770	14646.000
status file	00:00:06.188	0.0%	233	0.000	26.558	1105.000
TOTAL: 24:00:01.707	23:59:41.993	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	42:13:21.753	100.0%	6344	0.000	23959.923	600040.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.090	0.0%	15272	0.000	0.071	13.667
readart	00:00:12.579	0.0%	692	0.000	18.178	255.000
TOTAL: 42:14:31.884	42:13:35.422	100.0%	-	-	-	-

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
control@usenet.org.uk	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	341	2493416	2483029	2516	7871	99%	484:44:11
2	news.nask.pl	4	19650	9713	6903	3034	49%	23:36:14
3	news.task.gda.pl	17	30205	5762	23959	484	19%	45:05:25
4	news.icm.edu.pl	40	407	63	296	48	15%	19:48:14
5	localhost	4	3	3	0	0	100%	00:00:01
TOTAL: 5		406	2543681	2498570	33674	11437	98%	573:14:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	710.9 GB	28.3 MB	51.5 MB	711.0 GB	99%	299.3 KB
2	news.nask.pl	33.8 MB	7.9 MB	8.8 MB	50.5 MB	66%	4.1 KB
3	news.icm.edu.pl	18.0 MB	57.1 KB	9.6 MB	27.7 MB	64%	255.1 KB
4	news.task.gda.pl	12.4 MB	93.6 KB	1.2 MB	13.7 MB	90%	2.2 KB
5	localhost	5.6 KB	0.0 KB	0.0 KB	5.6 KB	100%	1.9 KB
TOTAL: 5		711.0 GB	36.3 MB	71.2 MB	711.1 GB	99%	297.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 10 04:15:05 - 04:59:59	56651	2.3%	21.02	15.7 GB	2.2%	6121.62
Jun 10 05:00:00 - 05:59:59	106288	4.3%	29.52	30.7 GB	4.3%	8949.86
Jun 10 06:00:00 - 06:59:59	99955	4.0%	27.77	29.1 GB	4.1%	8489.36
Jun 10 07:00:00 - 07:59:59	111066	4.4%	30.85	34.0 GB	4.8%	9908.43
Jun 10 08:00:00 - 08:59:59	112649	4.5%	31.29	33.4 GB	4.7%	9735.79
Jun 10 09:00:00 - 09:59:59	121809	4.9%	33.84	33.7 GB	4.7%	9818.83
Jun 10 10:00:00 - 10:59:59	111051	4.4%	30.85	29.1 GB	4.1%	8473.70
Jun 10 11:00:00 - 11:59:59	65905	2.6%	18.31	18.3 GB	2.6%	5342.06
Jun 10 12:00:00 - 12:59:59	74870	3.0%	20.80	18.7 GB	2.6%	5457.15
Jun 10 13:00:00 - 13:59:59	108920	4.4%	30.26	28.1 GB	3.9%	8177.47
Jun 10 14:00:00 - 14:59:59	109305	4.4%	30.36	30.6 GB	4.3%	8909.58
Jun 10 15:00:00 - 15:59:59	91831	3.7%	25.51	27.0 GB	3.8%	7872.72
Jun 10 16:00:00 - 16:59:59	118650	4.7%	32.96	33.0 GB	4.6%	9603.93
Jun 10 17:00:00 - 17:59:59	119628	4.8%	33.23	31.3 GB	4.4%	9109.26
Jun 10 18:00:00 - 18:59:59	104434	4.2%	29.01	26.0 GB	3.7%	7586.44
Jun 10 19:00:00 - 19:59:59	84393	3.4%	23.44	22.7 GB	3.2%	6608.53
Jun 10 20:00:00 - 20:59:59	97491	3.9%	27.08	30.7 GB	4.3%	8928.76
Jun 10 21:00:00 - 21:59:59	101205	4.1%	28.11	32.3 GB	4.5%	9404.78
Jun 10 22:00:00 - 22:59:59	115018	4.6%	31.95	31.7 GB	4.5%	9239.69
Jun 10 23:00:00 - 23:59:59	116900	4.7%	32.47	32.3 GB	4.5%	9416.21
Jun 11 00:00:00 - 00:59:59	106859	4.3%	29.68	32.0 GB	4.5%	9326.89
Jun 11 01:00:00 - 01:59:59	107403	4.3%	29.83	29.3 GB	4.1%	8535.88
Jun 11 02:00:00 - 02:59:59	122488	4.9%	34.02	36.2 GB	5.1%	10553.91
Jun 11 03:00:00 - 03:59:59	106983	4.3%	29.72	36.0 GB	5.1%	10471.74
Jun 11 04:00:00 - 04:15:05	27027	1.1%	29.86	8.9 GB	1.3%	10336.55
TOTAL: 24:00:00	2498779	100.0%	28.92	711.0 GB	100.0%	8629.26

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	7997	236	7033	11	717
2	news.nask.pl	3120	144	2868	20	88
3	news.task.gda.pl	496	259	47	3	187
4	news.icm.edu.pl	49	0	4	0	45
TOTAL: 4		11662	639	9952	34	1037

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.sex.telephones	120
uk.railway	107
alt.windows7.general	49
uk.rec.cycling.moderated	43
gmane.linux.alsa.devel	41
comp.mobile.ipad	29
alt.politics.scorched-earth	27
24hoursupport.helpdesk	26
fa.freebsd.cvs-all	21
comp.mobile.android	20
mozilla.dev.identity	19
mozilla.dev.tree-management	14
hr.ponuda.hardver.komponente	14
it.comp.os.win.windows8	13
mozilla.dev.gaia	13
fr.rec.audio	8
comp.sys.raspberry-pi	8
fr.usenet.abus.nocem	7
mozilla.dev.platform	6
gnu.hurd.bug	6
TOTAL: 36	639

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

Groups	Count
pl.sci.matematyka	25
pl.sci.historia	5
fr.comp.securite	3
bit.listserv.catholic	1
TOTAL: 4	34

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	528
EMP (fsl)	141
EMP (phl)	62
HTML post	56
EMP (md5)	53
Attached HTML file	1
Scoring filter (12)	1
TOTAL: 7	842

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	56698	12029	27504	2907	14	1145	21%	24:09:29
2	panorama	52775	3265	46909	847	0	0	6%	24:02:26
3	poznan	17064	100	14968	83	0	0	0%	23:58:37
4	task	2117	34	1165	14	0	0	1%	21:36:04
5	nask	21742	2	12589	5743	0	0	0%	24:00:03
6	okapi	0	0	0	0	0	2729	0%	24:00:00
TOTAL: 6		150396	15430	103135	9594	14	3874	10%	141:46:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	574.2 MB	184.6 MB	758.7 MB	8.9 KB/s	52.0 KB	24:09:29
2	panorama	9.3 MB	3.0 MB	12.3 MB	0.1 KB/s	3.1 KB	24:02:26
3	poznan	312.1 KB	146.1 KB	458.2 KB	0.0 KB/s	2.5 KB	23:58:37
4	task	81.8 KB	21.1 KB	102.9 KB	0.0 KB/s	2.1 KB	21:36:04
5	nask	5.1 KB	1.0 GB	1.0 GB	12.4 KB/s	186.4 KB	24:00:03
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		583.8 MB	1.2 GB	1.8 GB	3.6 KB/s	74.4 KB	141:46:39

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	324	593.1 KB	288	0	00:00:16
2	web.man.lodz.pl	288	160	170.1 KB	69	0	00:00:28
3	212.191.78.190	259	85	157.3 KB	39	0	37:54:46
4	lze200.lze.lodz.pl	2	54	103.6 KB	4	0	00:17:11
5	212.191.196.1	3	37	75.8 KB	9	0	01:47:23
6	ip-176.105.135.22.tvsat364.lodz.pl	3	31	65.0 KB	3	0	01:32:53
7	212.51.203.199	2	1	1.7 KB	1	0	00:04:23
8	kujawiak.man.lodz.pl	3	0	0.0 KB	0	3	00:00:04
TOTAL: 8		848	692	1.1 MB	413	3	42:14:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	324	593.1 KB	288	0	00:00:16
2	*.man.lodz.pl	676	160	170.1 KB	69	3	00:30:46
3	unresolved	265	123	234.7 KB	49	0	39:47:08
4	*.lze.lodz.pl	2	54	103.6 KB	4	0	00:17:11
5	*.105.135.22.tvsat364.lodz.pl	3	31	65.0 KB	3	0	01:32:53
6	*.4web.pl	2	0	0.0 KB	0	0	00:05:50
7	*.internetdsl.tpnet.pl	1	0	0.0 KB	0	0	00:00:00
8	*.toya.net.pl	54	0	0.0 KB	0	0	00:00:22
TOTAL: 8		1291	692	1.1 MB	413	3	42:14:29

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	1.220	12.612	37:54:46
212.191.196.1	0.116	1.604	01:47:23
ip-176.105.135.22.tvsat364.lodz.pl	0.112	0.856	01:32:53
pc-vicki.man.lodz.pl	0.000	0.072	00:30:00
lze200.lze.lodz.pl	0.128	1.676	00:17:11
net135-137.4web.pl	0.008	0.060	00:05:50
212.51.203.199	0.004	0.332	00:04:23
194.247.62.80	0.004	0.016	00:00:35
web.man.lodz.pl	2.312	26.000	00:00:28
staticline41435.toya.net.pl	0.400	5.300	00:00:22
vegas.cm.p.lodz.pl	1.516	16.260	00:00:16
f-oper-v100.man.lodz.pl	1.876	20.696	00:00:11
kujawiak.man.lodz.pl	0.028	0.240	00:00:04
david.man.lodz.pl	0.684	9.052	00:00:02
gcq193.internetdsl.tpnet.pl	0.008	0.016	00:00:00
TOTAL: 15	8.416	94.792	42:14:29

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	54
net135-137.4web.pl	2
gcq193.internetdsl.tpnet.pl	1
194.247.62.80	1
pc-vicki.man.lodz.pl	1
TOTAL: 7	443

NNRP client timeouts [Top 20]:

System	Conn	Peer
212.191.196.1	2	0
ip-176.105.135.22.tvsat364.lodz.pl	2	0
pc-vicki.man.lodz.pl	1	0
TOTAL: 3	5	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	368	53.2%
2	lodman	324	46.8%
TOTAL: 2		692	100.0%

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

Newsgroup		Count
1	lodman.info	324
2	pl.comp.os.ms-windows.winnt	147
3	pl.comp.pecet	50
4	pl.soc.prawo	35
5	pl.misc.kolej	33
6	pl.regionalne.warszawa	23
7	pl.comp.bazy-danych	20
8	pl.misc.paranauki	12
9	pl.comp.os.linux	12
10	pl.rec.dom	9
11	pl.rec.kuchnia	8
12	pl.rec.rowery	8
13	pl.regionalne.lodz	5
14	pl.praca.dyskusje	2
15	pl.listserv.chomor-l	2
16	pl.sci.filozofia	1
17	pl.rec.radio.amatorskie	1
TOTAL: 17		692

Daily Usenet report

Jun 10 04:15:05 -- Jun 11 04:15:05