Daily Usenet report: Jan 2 04:15:03

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jan 2 06:20:21 newsfeed pgpverify[1044]: pgpverify: verification failed
Jan 2 18:34:31 newsfeed nnrpd[25412]: SERVER perl filter not defined
Jan 2 20:04:29 newsfeed nnrpd[28377]: SERVER perl filter not defined
Jan 2 20:05:00 newsfeed nnrpd[28378]: SERVER perl filter not defined
Jan 2 20:05:19 newsfeed nnrpd[28425]: SERVER perl filter not defined
Jan 2 23:47:38 newsfeed nnrpd[3232]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2370069	98.5%	281.3 MB	98.2%
innd	17853	0.7%	3.0 MB	1.1%
nnrpd	10501	0.4%	1.1 MB	0.4%
innfeed	7036	0.3%	1.0 MB	0.4%
controlchan	3	0.0%	0.4 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	2405463	100.0%	286.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2362976	95.9%
Negative hits	65053	2.6%
Positive hits	36298	1.5%
Cache misses	661	0.0%
TOTAL: 4	2464988	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:23.341	0.0%	652	0.000	35.799	333.000
article cleanup	00:00:30.315	0.0%	2369106	0.001	0.013	0.026
article logging	00:01:04.027	0.1%	2369284	0.004	0.027	0.380
article parse	01:10:25.700	4.9%	180112301	0.003	0.023	0.074
article write	00:20:59.484	1.5%	2361201	0.212	0.533	3.760
artlog/artcncl	00:00:00.011	0.0%	648	0.000	0.017	1.000
artlog/artparse	00:00:00.000	0.0%	10	0.000	0.000	0.000
data move	00:05:02.443	0.4%	194522537	0.000	0.002	0.066
hisgrep/artcncl	00:00:04.404	0.0%	570	0.000	7.726	286.000
hishave/artcncl	00:00:02.353	0.0%	652	0.000	3.609	295.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:39:41.149	11.1%	2464710	0.223	3.887	7.971
history sync	00:00:00.005	0.0%	293	0.000	0.017	1.000
history write	05:47:40.864	24.1%	2363128	2.729	8.828	24.007
hiswrite/artcncl	00:00:01.213	0.0%	82	0.000	14.793	200.000
idle	07:18:46.085	30.5%	102014335	0.131	0.258	0.901
nntp read	00:54:56.782	3.8%	178318242	0.005	0.018	0.055
overview write	00:00:13.608	0.0%	2361201	0.000	0.006	0.013
perl filter	04:59:03.944	20.8%	2363118	3.257	7.593	12.452
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:37.685	0.3%	4774560	0.013	0.058	0.084
TOTAL: 23:59:51.938	23:23:33.413	97.5%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.186	0.0%	57442	0.000	0.003	0.250
article prepare	00:00:00.030	0.0%	93002	0.000	0.000	0.100
article read	00:01:00.810	0.1%	22669	0.000	2.683	130.500
backlog stats	00:00:00.269	0.0%	374722	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.625	0.0%	220993	0.000	0.012	1.000
data write	00:00:10.185	0.0%	189837	0.000	0.054	33.000
idle	23:58:24.671	99.9%	374722	0.000	230.317	13743.000
status file	00:00:01.250	0.0%	267	0.000	4.682	161.500
TOTAL: 23:59:48.843	23:59:40.026	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	50:32:30.168	99.9%	23817	0.000	7639.508	600556.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.956	0.0%	84246	0.000	0.047	1.333
readart	00:00:02.939	0.0%	651	0.000	4.515	19.329
TOTAL: 50:34:26.683	50:32:37.063	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
hun-mnt@news.sztaki.hu	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	486	2355316	2348224	1387	5705	99%	384:03:57
2	news.nask.pl	4	15908	6865	8098	945	43%	24:04:09
3	news.task.gda.pl	11	27983	6590	20162	1231	23%	44:57:27
4	localhost	6	5	5	0	0	100%	00:00:00
5	news.icm.edu.pl	42	272	3	250	19	1%	18:36:12
TOTAL: 5		549	2399484	2361687	29897	7900	98%	471:41:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	723.3 GB	63.2 MB	82.9 MB	723.4 GB	99%	322.3 KB
2	news.nask.pl	24.8 MB	2.5 MB	2.7 MB	30.0 MB	82%	3.9 KB
3	news.task.gda.pl	13.2 MB	38.4 KB	3.8 MB	17.0 MB	77%	2.2 KB
4	news.icm.edu.pl	60.7 KB	97.9 KB	555.8 KB	714.5 KB	8%	32.5 KB
5	localhost	7.5 KB	0.0 KB	0.0 KB	7.5 KB	100%	1.5 KB
TOTAL: 5		723.3 GB	65.8 MB	89.9 MB	723.5 GB	99%	320.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 2 04:15:03 - 04:59:59	75331	3.2%	27.93	23.5 GB	3.3%	9145.80
Jan 2 05:00:00 - 05:59:59	96368	4.1%	26.77	30.8 GB	4.3%	8982.28
Jan 2 06:00:00 - 06:59:59	95500	4.0%	26.53	30.9 GB	4.3%	8989.41
Jan 2 07:00:00 - 07:59:59	95036	4.0%	26.40	30.6 GB	4.2%	8911.33
Jan 2 08:00:00 - 08:59:59	101303	4.3%	28.14	33.4 GB	4.6%	9727.17
Jan 2 09:00:00 - 09:59:59	85734	3.6%	23.82	27.5 GB	3.8%	8019.43
Jan 2 10:00:00 - 10:59:59	89023	3.8%	24.73	29.6 GB	4.1%	8607.64
Jan 2 11:00:00 - 11:59:59	87688	3.7%	24.36	29.7 GB	4.1%	8642.04
Jan 2 12:00:00 - 12:59:59	90306	3.8%	25.09	30.8 GB	4.3%	8982.74
Jan 2 13:00:00 - 13:59:59	90704	3.8%	25.20	30.6 GB	4.2%	8908.58
Jan 2 14:00:00 - 14:59:59	98682	4.2%	27.41	29.4 GB	4.1%	8565.46
Jan 2 15:00:00 - 15:59:59	111280	4.7%	30.91	34.9 GB	4.8%	10178.87
Jan 2 16:00:00 - 16:59:59	109562	4.6%	30.43	35.0 GB	4.8%	10192.68
Jan 2 17:00:00 - 17:59:59	98995	4.2%	27.50	29.2 GB	4.0%	8501.57
Jan 2 18:00:00 - 18:59:59	97437	4.1%	27.07	26.2 GB	3.6%	7629.22
Jan 2 19:00:00 - 19:59:59	87046	3.7%	24.18	25.3 GB	3.5%	7371.12
Jan 2 20:00:00 - 20:59:59	92713	3.9%	25.75	29.3 GB	4.1%	8546.41
Jan 2 21:00:00 - 21:59:59	85217	3.6%	23.67	27.8 GB	3.9%	8107.68
Jan 2 22:00:00 - 22:59:59	112351	4.8%	31.21	33.5 GB	4.6%	9751.99
Jan 2 23:00:00 - 23:59:59	100623	4.3%	27.95	27.5 GB	3.8%	8019.52
Jan 3 00:00:00 - 00:59:59	88714	3.8%	24.64	24.5 GB	3.4%	7143.04
Jan 3 01:00:00 - 01:59:59	118872	5.0%	33.02	32.9 GB	4.5%	9576.64
Jan 3 02:00:00 - 02:59:59	117137	5.0%	32.54	31.9 GB	4.4%	9299.90
Jan 3 03:00:00 - 03:59:59	109959	4.7%	30.54	30.6 GB	4.2%	8903.21
Jan 3 04:00:00 - 04:15:02	25745	1.1%	28.54	7.2 GB	1.0%	8414.35
TOTAL: 23:59:59	2361326	100.0%	27.33	722.8 GB	100.0%	8771.68

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	5843	188	5049	2	604
2	news.task.gda.pl	1248	1049	20	4	175
3	news.nask.pl	985	16	919	7	43
4	news.icm.edu.pl	19	0	2	0	17
TOTAL: 4		8095	1253	5990	13	839

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	98
mailing.freebsd.svn-ports-head	98
alt.politics.scorched-earth	79
uk.railway	75
mailing.freebsd.ports-bugs	65
mailing.freebsd.svn-src-all	52
fa.freebsd.cvs-all	48
fr.usenet.abus.nocem	45
mailing.freebsd.svn-src-head	40
mozilla.dev.gaia	38
alt.windows7.general	37
mailing.freebsd.current	36
mailing.openbsd.source-changes	36
mailing.gcc.gcc-cvs	30
24hoursupport.helpdesk	30
comp.mobile.android	19
mailing.dragonflybsd.commits	18
mailing.unix.samba	17
mailing.openbsd.misc	17
mailing.freebsd.tinderbox	17
TOTAL: 81	1253

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

Groups	Count
pl.sci.historia	9
fr.comp.applications.libres	2
fr.comp.lang.php	1
fr.bienvenue	1
TOTAL: 4	13

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	339
EMP (fsl)	139
Attached HTML file	131
EMP (md5)	25
HTML post	10
EMP (phl)	7
TOTAL: 6	651

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	68995	18083	31100	1632	0	5288	26%	23:59:56
2	panorama	54105	2631	49029	590	0	0	4%	24:01:26
3	poznan	16017	200	13061	116	1	0	1%	23:58:48
4	nask	15526	14	11253	85	0	0	0%	24:03:50
5	task	2355	6	1305	1	0	0	0%	21:36:43
6	okapi	0	0	0	0	0	2677	0%	24:00:01
TOTAL: 6		156998	20934	105748	2424	1	7965	13%	141:40:44

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	2.7 GB	167.3 MB	2.8 GB	34.3 KB/s	150.5 KB	23:59:56
2	panorama	9.1 MB	2.0 MB	11.0 MB	0.1 KB/s	3.5 KB	24:01:26
3	poznan	614.4 KB	205.0 KB	819.5 KB	0.0 KB/s	2.6 KB	23:58:48
4	nask	34.7 KB	31.1 MB	31.1 MB	0.4 KB/s	321.8 KB	24:03:50
5	task	10.6 KB	2.6 KB	13.2 KB	0.0 KB/s	1.9 KB	21:36:43
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 6		2.7 GB	200.5 MB	2.9 GB	5.9 KB/s	128.9 KB	141:40:44

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	326	509.8 KB	288	0	00:00:17
2	lze200.lze.lodz.pl	3	98	171.1 KB	9	0	00:51:08
3	212.191.80.165	1	85	186.5 KB	3	0	00:55:09
4	web.man.lodz.pl	288	80	72.7 KB	39	0	00:00:29
5	212.191.78.190	314	53	92.1 KB	26	1	47:29:02
6	ip-176.105.135.22.tvsat364.lodz.pl	2	6	11.4 KB	2	0	00:40:03
7	078088067110.sieradz.vectranet.pl	2	3	5.2 KB	1	0	00:06:01
8	kujawiak.man.lodz.pl	4	0	0.0 KB	0	4	00:00:01
TOTAL: 8		902	651	1.0 MB	368	5	50:34:23

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	326	509.8 KB	288	0	00:00:17
2	unresolved	317	138	278.7 KB	29	1	48:24:52
3	*.lze.lodz.pl	3	98	171.1 KB	9	0	00:51:08
4	*.man.lodz.pl	676	80	72.7 KB	39	4	00:00:38
5	*.105.135.22.tvsat364.lodz.pl	2	6	11.4 KB	2	0	00:40:03
6	*.sieradz.vectranet.pl	2	3	5.2 KB	1	0	00:06:01
7	*.cbmm.lodz.pl	3	0	0.0 KB	0	0	00:00:46
8	*.neoplus.adsl.tpnet.pl	2	0	0.0 KB	0	0	00:30:23
9	*.toya.net.pl	104	0	0.0 KB	0	0	00:00:12
TOTAL: 9		1397	651	1.0 MB	368	5	50:34:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.632	3.036	47:29:02
212.191.80.165	6.092	3.644	00:55:09
lze200.lze.lodz.pl	0.020	0.068	00:51:08
ip-176.105.135.22.tvsat364.lodz.pl	0.000	0.032	00:40:03
bvl42.neoplus.adsl.tpnet.pl	0.000	0.016	00:30:01
078088067110.sieradz.vectranet.pl	0.000	0.028	00:06:01
router2.cbmm.lodz.pl	0.008	0.024	00:00:46
212.51.203.199	0.008	0.020	00:00:40
web.man.lodz.pl	0.560	2.764	00:00:29
ebw241.neoplus.adsl.tpnet.pl	0.000	0.004	00:00:21
vegas.cm.p.lodz.pl	0.508	2.912	00:00:17
staticline41435.toya.net.pl	0.264	1.008	00:00:12
mon.man.lodz.pl	0.476	2.448	00:00:04
david.man.lodz.pl	0.164	0.988	00:00:02
kujawiak.man.lodz.pl	0.032	0.044	00:00:01
?	0.004	0.004	00:00:00
TOTAL: 16	8.768	17.040	50:34:23

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
staticline41435.toya.net.pl	104
david.man.lodz.pl	96
router2.cbmm.lodz.pl	3
212.51.203.199	2
bvl42.neoplus.adsl.tpnet.pl	1
ebw241.neoplus.adsl.tpnet.pl	1
TOTAL: 7	495

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	2	1
bvl42.neoplus.adsl.tpnet.pl	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 3	4	4

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	329	50.5%
2	pl	322	49.5%
TOTAL: 2		651	100.0%

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

Newsgroup		Count
1	lodman.info	326
2	pl.misc.samochody	59
3	pl.comp.os.ms-windows.winnt	54
4	pl.comp.pecet	49
5	pl.misc.telefonia.gsm	45
6	pl.rec.rowery	28
7	pl.misc.kolej	19
8	pl.rec.kuchnia	15
9	pl.comp.os.linux	12
10	pl.pregierz	11
11	pl.comp.os.linux.sieci	9
12	pl.regionalne.warszawa	8
13	pl.soc.prawo	6
14	pl.misc.dieta	4
15	lodman.test	3
16	pl.rec.gory	2
17	pl.regionalne.lodz	1
TOTAL: 17		651

Daily Usenet report

Jan 2 04:15:03 -- Jan 3 04:15:02