Daily Usenet report: Sep 21 04:15:03

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 21 04:39:12 newsfeed pgpverify[13485]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2201445	98.5%	247.6 MB	98.0%
innd	19661	0.9%	3.2 MB	1.3%
innfeed	6853	0.3%	1.0 MB	0.4%
nnrpd	6836	0.3%	722.2 KB	0.3%
controlchan	3	0.0%	0.4 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
TOTAL: 6	2234799	100.0%	252.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2196659	94.0%
Negative hits	104889	4.5%
Positive hits	33897	1.5%
Cache misses	228	0.0%
TOTAL: 4	2335673	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.223	0.0%	376	0.000	24.529	615.000
article cleanup	00:00:30.450	0.0%	2200757	0.005	0.014	0.028
article logging	00:01:18.433	0.1%	2200939	0.008	0.036	0.790
article parse	01:09:06.860	4.8%	69659191	0.012	0.060	0.098
article write	00:24:45.583	1.7%	2194528	0.342	0.677	2.085
artlog/artcncl	00:00:00.007	0.0%	333	0.000	0.021	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:26.912	0.2%	82710003	0.000	0.002	0.005
hisgrep/artcncl	00:00:02.255	0.0%	276	0.000	8.170	290.000
hishave/artcncl	00:00:01.260	0.0%	376	0.000	3.351	143.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:57:39.609	16.5%	2336327	1.136	6.103	13.439
history sync	00:00:00.012	0.0%	291	0.000	0.041	1.000
history write	05:04:59.116	21.2%	2197357	4.834	8.328	20.284
hiswrite/artcncl	00:00:00.762	0.0%	100	0.000	7.620	247.000
idle	06:22:15.770	26.5%	32045640	0.163	0.716	3.150
nntp read	00:40:01.612	2.8%	67829725	0.010	0.035	0.055
overview write	00:00:13.904	0.0%	2194528	0.000	0.006	0.016
perl filter	05:50:36.476	24.3%	2197356	4.781	9.574	12.127
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:07.277	0.3%	4431176	0.014	0.056	0.083
TOTAL: 23:59:52.514	23:38:15.521	98.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.154	0.0%	42124	0.000	0.004	0.091
article prepare	00:00:00.011	0.0%	49158	0.000	0.000	0.050
article read	00:00:02.782	0.0%	12064	0.000	0.231	3.489
backlog stats	00:00:00.276	0.0%	314903	0.000	0.001	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.381	0.0%	181035	0.000	0.013	1.000
data write	00:00:07.884	0.0%	170645	0.000	0.046	1.000
idle	23:59:41.314	100.0%	314903	0.000	274.311	16010.000
status file	00:00:01.567	0.0%	232	0.000	6.754	273.500
TOTAL: 24:00:03.355	23:59:56.369	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:05.196	0.0%	35148	0.148	0.148	0.148
idle	03:24:18.783	99.7%	48960	0.000	250.384	602172.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.973	0.0%	99509	0.000	0.020	9.480
readart	00:00:10.192	0.1%	35426	0.000	0.288	65.000
TOTAL: 03:25:01.345	03:24:36.144	99.8%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	190

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
nl-admin@nic.surfnet.nl	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	899	2189546	2181220	4431	3895	99%	457:51:17
2	news.nask.pl	3	14809	6890	6484	1435	46%	24:34:20
3	news.task.gda.pl	14	26933	6022	20018	893	22%	44:52:56
4	news.icm.edu.pl	46	249	8	207	34	3%	17:07:38
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		963	2231537	2194140	31140	6257	98%	544:26:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	807.6 GB	63.4 MB	310.7 MB	808.0 GB	99%	387.7 KB
2	news.nask.pl	65.3 MB	3.7 MB	4.0 MB	72.9 MB	89%	9.0 KB
3	news.task.gda.pl	10.9 MB	59.2 KB	2.7 MB	13.6 MB	79%	2.0 KB
4	news.icm.edu.pl	169.2 KB	19.6 KB	694.7 KB	883.5 KB	19%	21.0 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		807.7 GB	67.2 MB	318.0 MB	808.1 GB	99%	385.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 21 04:15:03 - 04:59:59	63693	2.9%	23.62	26.1 GB	3.2%	10147.50
Sep 21 05:00:00 - 05:59:59	91846	4.2%	25.51	36.6 GB	4.5%	10662.41
Sep 21 06:00:00 - 06:59:59	79570	3.6%	22.10	31.7 GB	3.9%	9237.37
Sep 21 07:00:00 - 07:59:59	74627	3.4%	20.73	29.4 GB	3.6%	8554.20
Sep 21 08:00:00 - 08:59:59	89193	4.1%	24.78	34.5 GB	4.3%	10049.07
Sep 21 09:00:00 - 09:59:59	93730	4.3%	26.04	36.4 GB	4.5%	10600.14
Sep 21 10:00:00 - 10:59:59	96079	4.4%	26.69	36.5 GB	4.5%	10632.94
Sep 21 11:00:00 - 11:59:59	90621	4.1%	25.17	34.2 GB	4.2%	9953.72
Sep 21 12:00:00 - 12:59:59	78020	3.6%	21.67	28.1 GB	3.5%	8193.73
Sep 21 13:00:00 - 13:59:59	102640	4.7%	28.51	36.1 GB	4.5%	10525.82
Sep 21 14:00:00 - 14:59:59	102919	4.7%	28.59	35.5 GB	4.4%	10343.85
Sep 21 15:00:00 - 15:59:59	109007	5.0%	30.28	38.0 GB	4.7%	11081.20
Sep 21 16:00:00 - 16:59:59	104961	4.8%	29.16	36.9 GB	4.6%	10742.36
Sep 21 17:00:00 - 17:59:59	80330	3.7%	22.31	24.7 GB	3.1%	7208.07
Sep 21 18:00:00 - 18:59:59	92350	4.2%	25.65	30.4 GB	3.8%	8841.60
Sep 21 19:00:00 - 19:59:59	95924	4.4%	26.65	33.9 GB	4.2%	9874.16
Sep 21 20:00:00 - 20:59:59	92370	4.2%	25.66	32.1 GB	4.0%	9335.50
Sep 21 21:00:00 - 21:59:59	93850	4.3%	26.07	34.6 GB	4.3%	10066.33
Sep 21 22:00:00 - 22:59:59	67004	3.1%	18.61	25.4 GB	3.1%	7404.91
Sep 21 23:00:00 - 23:59:59	94352	4.3%	26.21	35.0 GB	4.3%	10197.62
Sep 22 00:00:00 - 00:59:59	84162	3.8%	23.38	31.6 GB	3.9%	9202.25
Sep 22 01:00:00 - 01:59:59	83923	3.8%	23.31	32.0 GB	4.0%	9319.18
Sep 22 02:00:00 - 02:59:59	103138	4.7%	28.65	39.2 GB	4.8%	11403.74
Sep 22 03:00:00 - 03:59:59	104174	4.7%	28.94	38.9 GB	4.8%	11325.88
Sep 22 04:00:00 - 04:15:02	26217	1.2%	29.07	9.8 GB	1.2%	11396.04
TOTAL: 23:59:59	2194700	100.0%	25.40	807.5 GB	100.0%	9800.68

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4029	226	2015	0	1788
2	news.nask.pl	1464	49	1355	0	60
3	news.task.gda.pl	885	716	29	1	139
4	news.icm.edu.pl	34	0	2	0	32
TOTAL: 4		6412	991	3401	1	2019

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	68
mailing.freebsd.svn-ports-head	68
mailing.freebsd.ports-bugs	47
alt.windows7.general	45
uk.railway	41
it.tlc.cellulari.android	40
mailing.unix.dovecot	36
mailing.freebsd.current	34
comp.sys.raspberry-pi	34
fr.usenet.abus.nocem	33
alt.politics.scorched-earth	32
comp.mobile.ipad	31
rec.arts.tv.x-factor	28
mailing.postfix.users	27
mozilla.dev.tree-management	26
fa.freebsd.cvs-all	25
mailing.freebsd.svn-src-all	24
mailing.freebsd.svn-src-head	21
mailing.freebsd.ports	19
it.tlc.cellulari.iphone	19
TOTAL: 74	991

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

Groups	Count
fr.comp.securite	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	1656
EMP (fsl)	133
EMP (md5)	39
HTML post	5
Scoring filter (8)	2
Attached HTML file	1
TOTAL: 6	1836

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	42964	2635	38870	730	0	0	6%	24:08:16
2	icm	57153	1911	31247	7011	0	2	3%	24:09:18
3	poznan	13691	13	12011	6	0	0	0%	23:50:23
4	task	1635	12	877	2	0	0	0%	20:12:27
5	nask	17368	11	13517	17	1	0	0%	23:59:59
6	okapi	0	0	0	0	0	1850	0%	24:00:00
TOTAL: 6		132811	4582	96522	7766	1	1852	3%	140:20:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	29.8 MB	2.7 GB	2.7 GB	32.4 KB/s	316.1 KB	24:09:18
2	panorama	7.3 MB	2.7 MB	9.9 MB	0.1 KB/s	3.0 KB	24:08:16
3	poznan	45.6 KB	40.3 KB	85.9 KB	0.0 KB/s	4.5 KB	23:50:23
4	nask	24.1 KB	4.2 MB	4.2 MB	0.0 KB/s	154.2 KB	23:59:59
5	task	21.4 KB	3.9 KB	25.3 KB	0.0 KB/s	1.8 KB	20:12:27
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		37.2 MB	2.7 GB	2.7 GB	5.6 KB/s	229.6 KB	140:20:23

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	vegas.cm.p.lodz.pl	288	288	525.7 KB	288	00:00:07
2	web.man.lodz.pl	288	48	49.8 KB	22	00:00:19
3	staticline-31-182-72-163.toya.net.pl	2	5	4.6 KB	2	01:00:32
4	stgt-5f716e4f.pool.mediaways.net	2	3	4.4 KB	1	00:05:17
TOTAL: 4		580	344	584.5 KB	313	03:25:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.cm.p.lodz.pl	288	288	525.7 KB	288	00:00:07
2	*.man.lodz.pl	672	48	49.8 KB	22	00:00:30
3	*.toya.net.pl	9	5	4.6 KB	2	01:00:33
4	*.pool.mediaways.net	2	3	4.4 KB	1	00:05:17
5	*.181.14.62.static.jazztel.es	4	0	0.0 KB	0	02:18:31
TOTAL: 5		975	344	584.5 KB	313	03:25:00

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
53.181.14.62.static.jazztel.es	3.724	14.093	02:18:31
staticline-31-182-72-163.toya.net.pl	0.008	0.036	01:00:32
stgt-5f716e4f.pool.mediaways.net	0.056	0.048	00:05:17
web.man.lodz.pl	0.816	4.952	00:00:19
f-oper-v100.man.lodz.pl	0.788	4.864	00:00:10
vegas.cm.p.lodz.pl	0.760	4.672	00:00:07
david.man.lodz.pl	0.240	1.600	00:00:01
staticline41435.toya.net.pl	0.012	0.112	00:00:00
TOTAL: 8	6.404	30.377	03:25:00

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	7
53.181.14.62.static.jazztel.es	4
TOTAL: 4	395

NNRP client timeouts [Top 20]:

System	Conn	Peer
staticline-31-182-72-163.toya.net.pl	2	0
TOTAL: 1	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	292	84.9%
2	pl	48	14.0%
3	lodz	4	1.2%
TOTAL: 3		344	100.0%

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

Newsgroup		Count
1	lodman.info	292
2	pl.comp.os.ms-windows.winnt	24
3	pl.comp.pecet	24
4	lodz.test	4
TOTAL: 4		344

Daily Usenet report

Sep 21 04:15:03 -- Sep 22 04:15:02