Daily Usenet report: Jul 15 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jul 15 10:35:33 newsfeed nnrpd[16433]: SERVER perl filter not defined
Jul 15 15:06:42 newsfeed nnrpd[26064]: SERVER perl filter not defined
Jul 15 15:07:36 newsfeed nnrpd[26083]: SERVER perl filter not defined
Jul 15 15:08:33 newsfeed nnrpd[26084]: SERVER perl filter not defined
Jul 15 15:09:14 newsfeed nnrpd[26097]: SERVER perl filter not defined
Jul 15 15:18:15 newsfeed nnrpd[26424]: SERVER perl filter not defined
Jul 15 15:27:03 newsfeed nnrpd[26753]: SERVER perl filter not defined
Jul 15 17:00:11 newsfeed pgpverify[29884]: pgpverify: verification failed
Jul 15 19:04:41 newsfeed nnrpd[1646]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1859849	98.1%	213.4 MB	97.6%
innd	21833	1.2%	3.4 MB	1.6%
nnrpd	7618	0.4%	809.4 KB	0.4%
innfeed	6760	0.4%	1.0 MB	0.5%
controlchan	3	0.0%	0.3 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
TOTAL: 6	1896064	100.0%	218.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1855278	95.0%
Negative hits	79444	4.1%
Positive hits	17058	0.9%
Cache misses	228	0.0%
TOTAL: 4	1952008	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:13.516	0.0%	276	0.000	48.971	565.000
article cleanup	00:00:31.930	0.0%	1859249	0.006	0.017	0.036
article logging	00:01:01.254	0.1%	1859391	0.011	0.033	0.508
article parse	01:17:11.281	5.4%	102289081	0.017	0.045	0.085
article write	00:17:22.365	1.2%	1849994	0.324	0.563	1.534
artlog/artcncl	00:00:00.009	0.0%	269	0.000	0.033	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:07:35.014	0.5%	113242089	0.001	0.004	0.137
hisgrep/artcncl	00:00:01.900	0.0%	238	0.000	7.983	115.000
hishave/artcncl	00:00:00.953	0.0%	276	0.000	3.453	168.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:23:19.517	14.1%	1952467	0.013	6.248	15.627
history sync	00:00:00.016	0.0%	290	0.000	0.055	1.000
history write	04:18:05.973	17.9%	1855721	1.709	8.345	18.718
hiswrite/artcncl	00:00:00.141	0.0%	38	0.000	3.711	13.000
idle	08:21:55.596	34.9%	56264409	0.223	0.535	1.546
nntp read	00:55:09.958	3.8%	100687040	0.017	0.033	0.060
overview write	00:00:12.710	0.0%	1849994	0.000	0.007	0.017
perl filter	04:38:52.348	19.4%	1855719	6.501	9.017	13.132
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:01.296	0.3%	3742778	0.039	0.064	0.195
TOTAL: 23:59:51.765	23:25:35.777	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.166	0.0%	42814	0.000	0.004	0.125
article prepare	00:00:00.019	0.0%	54420	0.000	0.000	0.250
article read	00:00:14.383	0.0%	11800	0.000	1.219	173.000
backlog stats	00:00:00.361	0.0%	416041	0.000	0.001	0.019
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:02.344	0.0%	189924	0.000	0.012	1.000
data write	00:00:14.332	0.0%	248060	0.000	0.058	23.000
idle	23:59:59.810	100.0%	416041	0.000	207.671	17082.000
status file	00:00:01.246	0.0%	186	0.000	6.699	291.000
TOTAL: 24:00:41.914	24:00:32.661	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	01:53:03.191	99.4%	6630	0.000	1023.106	600075.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.288	0.0%	15194	0.000	0.019	1.333
readart	00:00:00.329	0.0%	427	0.000	0.770	28.000
TOTAL: 01:53:43.231	01:53:03.808	99.4%	-	-	-	-

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
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	962	1854379	1844682	1259	8438	99%	452:19:24
2	news.nask.pl	2	17403	4746	11915	742	27%	23:31:00
3	localhost	9	8	8	0	0	100%	00:00:00
4	news.icm.edu.pl	42	292	2	229	61	0%	17:33:12
TOTAL: 4		1015	1872082	1849438	13403	9241	98%	493:23:36

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	615.7 GB	16.4 MB	822.4 MB	616.5 GB	99%	348.8 KB
2	news.nask.pl	22.6 MB	2.0 MB	2.1 MB	26.7 MB	84%	5.0 KB
3	news.icm.edu.pl	39.6 KB	11.3 KB	1.5 MB	1.6 MB	2%	25.8 KB
4	localhost	12.7 KB	0.0 KB	0.0 KB	12.7 KB	100%	1.6 KB
TOTAL: 4		615.7 GB	18.4 MB	826.0 MB	616.5 GB	99%	347.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 15 04:15:02 - 04:59:59	45210	2.4%	16.76	13.3 GB	2.2%	5161.45
Jul 15 05:00:00 - 05:59:59	63498	3.4%	17.64	20.1 GB	3.3%	5843.83
Jul 15 06:00:00 - 06:59:59	62410	3.4%	17.34	20.0 GB	3.2%	5811.43
Jul 15 07:00:00 - 07:59:59	60335	3.3%	16.76	18.8 GB	3.0%	5465.45
Jul 15 08:00:00 - 08:59:59	61766	3.3%	17.16	18.9 GB	3.1%	5494.24
Jul 15 09:00:00 - 09:59:59	65837	3.6%	18.29	21.6 GB	3.5%	6294.51
Jul 15 10:00:00 - 10:59:59	84656	4.6%	23.52	30.0 GB	4.9%	8738.17
Jul 15 11:00:00 - 11:59:59	91429	4.9%	25.40	31.8 GB	5.2%	9250.20
Jul 15 12:00:00 - 12:59:59	80259	4.3%	22.29	28.3 GB	4.6%	8235.53
Jul 15 13:00:00 - 13:59:59	89875	4.9%	24.97	31.7 GB	5.1%	9232.06
Jul 15 14:00:00 - 14:59:59	77245	4.2%	21.46	27.9 GB	4.5%	8127.13
Jul 15 15:00:00 - 15:59:59	92148	5.0%	25.60	32.6 GB	5.3%	9497.57
Jul 15 16:00:00 - 16:59:59	97198	5.3%	27.00	32.1 GB	5.2%	9359.81
Jul 15 17:00:00 - 17:59:59	96485	5.2%	26.80	31.7 GB	5.2%	9240.85
Jul 15 18:00:00 - 18:59:59	97900	5.3%	27.19	31.2 GB	5.1%	9100.71
Jul 15 19:00:00 - 19:59:59	92577	5.0%	25.72	28.9 GB	4.7%	8406.33
Jul 15 20:00:00 - 20:59:59	61035	3.3%	16.95	20.8 GB	3.4%	6069.84
Jul 15 21:00:00 - 21:59:59	66921	3.6%	18.59	22.0 GB	3.6%	6402.36
Jul 15 22:00:00 - 22:59:59	59179	3.2%	16.44	19.0 GB	3.1%	5525.74
Jul 15 23:00:00 - 23:59:59	64430	3.5%	17.90	22.4 GB	3.6%	6525.20
Jul 16 00:00:00 - 00:59:59	69645	3.8%	19.35	23.5 GB	3.8%	6846.27
Jul 16 01:00:00 - 01:59:59	84380	4.6%	23.44	26.8 GB	4.3%	7804.11
Jul 16 02:00:00 - 02:59:59	90324	4.9%	25.09	30.3 GB	4.9%	8839.37
Jul 16 03:00:00 - 03:59:59	77982	4.2%	21.66	26.4 GB	4.3%	7682.49
Jul 16 04:00:00 - 04:15:01	17456	0.9%	19.37	6.0 GB	1.0%	7040.25
TOTAL: 23:59:59	1850180	100.0%	21.41	616.0 GB	100.0%	7476.06

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	8566	178	2817	0	5571
2	news.nask.pl	773	29	712	3	29
3	news.icm.edu.pl	61	0	1	0	60
TOTAL: 3		9400	207	3530	3	5660

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	79
comp.sys.raspberry-pi	26
it.tlc.cellulari.android	21
comp.mobile.android	19
it.comp.os.win.windows7	18
alt.sex.telephones	10
it.comp.os.win.windows8	8
comp.mac.ipad	7
hr.alt.cellular.gsm.android	4
comp.sys.mac.vintage	3
uk.rec.cycling.moderated	3
de.comm.provider.telefonie	2
hr.ponuda.hardver.komponente	2
hr.alt.cellular.gsm.iphone	2
comp.mobile.ipad	1
de.comp.lang.perl	1
hr.ponuda.hardver.konfiguracije	1
TOTAL: 17	207

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

Groups	Count
pl.sci.matematyka	2
bit.listserv.catholic	1
TOTAL: 2	3

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	5447
EMP (md5)	69
TOTAL: 2	5516

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	66569	2268	36148	3852	6	14	3%	23:59:46
2	panorama	43620	977	41433	277	0	0	2%	23:53:31
3	nask	37294	207	19952	5884	0	0	0%	23:58:58
4	poznan	5819	55	4402	46	0	0	0%	24:02:08
5	okapi	0	0	0	0	0	3308	0%	24:00:01
TOTAL: 5		153302	3507	101935	10059	6	3322	2%	119:54:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	206.5 MB	1.3 GB	1.5 GB	18.8 KB/s	265.3 KB	23:59:46
2	nask	23.2 MB	1.4 GB	1.5 GB	17.8 KB/s	251.6 KB	23:58:58
3	panorama	4.0 MB	890.1 KB	4.9 MB	0.1 KB/s	4.0 KB	23:53:31
4	poznan	174.6 KB	87.9 KB	262.5 KB	0.0 KB/s	2.6 KB	24:02:08
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		233.8 MB	2.8 GB	3.0 GB	7.3 KB/s	233.1 KB	119:54:24

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	354	532.8 KB	288	0	00:00:09
2	web.man.lodz.pl	288	72	60.2 KB	32	0	00:00:25
3	ip-176.105.135.22.tvsat364.lodz.pl	4	1	1.7 KB	1	0	00:57:43
4	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:01
TOTAL: 4		588	427	594.7 KB	321	8	01:53:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	354	532.8 KB	288	0	00:00:09
2	*.man.lodz.pl	680	72	60.2 KB	32	8	00:00:33
3	*.105.135.22.tvsat364.lodz.pl	4	1	1.7 KB	1	0	00:57:43
4	*.pa.nsw.optusnet.com.au	112	0	0.0 KB	0	0	00:19:29
5	*.cbmm.lodz.pl	2	0	0.0 KB	0	0	00:00:10
6	unresolved	1	0	0.0 KB	0	0	00:01:07
7	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	00:30:01
8	*.206.15.62.static.jazztel.es	2	0	0.0 KB	0	0	00:04:14
9	*.toya.net.pl	66	0	0.0 KB	0	0	00:00:11
TOTAL: 9		1156	427	594.7 KB	321	8	01:53:40

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ip-176.105.135.22.tvsat364.lodz.pl	0.004	0.048	00:57:43
ages43.neoplus.adsl.tpnet.pl	0.020	0.024	00:30:01
pa49-181-246-128.pa.nsw.optusnet.com.au	0.272	1.176	00:19:29
229.206.15.62.static.jazztel.es	0.108	0.148	00:04:14
194.33.77.50	0.000	0.020	00:01:07
web.man.lodz.pl	0.660	3.604	00:00:25
staticline41435.toya.net.pl	0.132	0.856	00:00:11
router2.cbmm.lodz.pl	0.004	0.024	00:00:10
pc-skrzep2.cm.p.lodz.pl	0.760	3.400	00:00:09
mon.man.lodz.pl	0.524	3.120	00:00:04
david.man.lodz.pl	0.188	1.168	00:00:01
isvcs01.man.lodz.pl	0.040	0.140	00:00:01
TOTAL: 12	2.712	13.728	01:53:40

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
pa49-181-246-128.pa.nsw.optusnet.com.au	112
david.man.lodz.pl	96
staticline41435.toya.net.pl	66
229.206.15.62.static.jazztel.es	2
router2.cbmm.lodz.pl	2
ages43.neoplus.adsl.tpnet.pl	1
194.33.77.50	1
TOTAL: 8	568

NNRP client timeouts [Top 20]:

System	Conn	Peer
pa49-181-246-128.pa.nsw.optusnet.com.au	2	0
ages43.neoplus.adsl.tpnet.pl	1	0
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 3	4	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	354	82.9%
2	pl	73	17.1%
TOTAL: 2		427	100.0%

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

Newsgroup		Count
1	lodman.info	354
2	pl.comp.pecet	56
3	pl.comp.os.ms-windows.winnt	16
4	pl.regionalne.lodz	1
TOTAL: 4		427

Daily Usenet report

Jul 15 04:15:02 -- Jul 16 04:15:01