Daily Usenet report: Aug 26 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 26 07:01:27 newsfeed nnrpd[25688]: SERVER perl filter not defined
Aug 26 07:16:41 newsfeed nnrpd[26259]: SERVER perl filter not defined
Aug 26 12:36:04 newsfeed nnrpd[4666]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1854070	98.4%	211.0 MB	97.9%
innd	16798	0.9%	2.8 MB	1.3%
nnrpd	7311	0.4%	770.6 KB	0.3%
innfeed	6594	0.3%	1006.6 KB	0.5%
TOTAL: 4	1884773	100.0%	215.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1848539	95.7%
Negative hits	63469	3.3%
Positive hits	18625	1.0%
Cache misses	175	0.0%
TOTAL: 4	1930808	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:09.563	0.0%	322	0.000	29.699	544.000
article cleanup	00:00:28.815	0.0%	1854383	0.006	0.016	0.034
article logging	00:00:54.714	0.1%	1854559	0.009	0.030	0.286
article parse	01:09:23.422	4.8%	148652054	0.008	0.028	0.060
article write	00:17:08.976	1.2%	1848304	0.279	0.557	1.594
artlog/artcncl	00:00:00.009	0.0%	305	0.000	0.030	1.000
artlog/artparse	00:00:00.000	0.0%	6	0.000	0.000	0.000
data move	00:02:51.734	0.2%	160241480	0.000	0.001	0.004
hisgrep/artcncl	00:00:02.216	0.0%	290	0.000	7.641	227.000
hishave/artcncl	00:00:00.501	0.0%	322	0.000	1.556	97.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:55:48.398	8.0%	1933360	0.009	3.594	8.851
history sync	00:00:00.014	0.0%	292	0.000	0.048	1.000
history write	04:04:42.964	17.0%	1851179	0.059	7.932	19.288
hiswrite/artcncl	00:00:00.120	0.0%	32	0.000	3.750	46.000
idle	10:37:56.571	44.3%	85106993	0.217	0.450	1.041
nntp read	01:00:51.896	4.2%	147061733	0.010	0.025	0.043
overview write	00:00:11.695	0.0%	1848304	0.000	0.006	0.016
perl filter	04:11:01.130	17.4%	1851173	4.522	8.136	10.509
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:01.864	0.3%	3730796	0.018	0.065	0.101
TOTAL: 24:00:29.688	23:25:34.602	97.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.112	0.0%	34194	0.000	0.003	0.125
article prepare	00:00:00.002	0.0%	20110	0.000	0.000	0.083
article read	00:00:00.566	0.0%	4827	0.000	0.117	23.143
backlog stats	00:00:00.147	0.0%	236856	0.000	0.001	0.030
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.716	0.0%	148933	0.000	0.012	1.000
data write	00:00:05.601	0.0%	122144	0.000	0.046	1.000
idle	24:00:32.004	100.0%	236856	0.000	364.914	19095.000
status file	00:00:00.149	0.0%	173	0.000	0.861	9.000
TOTAL: 24:00:45.480	24:00:40.297	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.013	0.0%	1	13.000	13.000	13.000
idle	01:13:46.858	99.4%	20491	0.000	216.039	201887.889
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.833	0.0%	42915	0.000	0.019	1.000
readart	00:00:00.560	0.0%	420	0.000	1.333	24.462
TOTAL: 01:14:11.621	01:13:48.264	99.5%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	410	1849067	1841585	2326	5156	99%	335:33:32
2	news.nask.pl	2	18431	5244	12342	845	28%	23:15:21
3	news.icm.edu.pl	39	341	31	239	71	9%	18:29:03
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		455	1867842	1846863	14907	6072	98%	377:17:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	628.8 GB	18.8 MB	350.2 MB	629.2 GB	99%	357.2 KB
2	news.nask.pl	25.1 MB	2.3 MB	2.7 MB	30.0 MB	83%	5.1 KB
3	news.icm.edu.pl	1.7 MB	238.6 KB	5.0 MB	6.8 MB	24%	68.7 KB
4	localhost	4.3 KB	0.0 KB	0.0 KB	4.3 KB	100%	1.4 KB
TOTAL: 4		628.8 GB	21.3 MB	357.8 MB	629.2 GB	99%	356.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 26 04:15:02 - 04:59:59	59823	3.2%	22.17	18.6 GB	3.0%	7237.26
Aug 26 05:00:00 - 05:59:59	86064	4.7%	23.91	26.6 GB	4.2%	7760.05
Aug 26 06:00:00 - 06:59:59	95820	5.2%	26.62	30.2 GB	4.8%	8784.79
Aug 26 07:00:00 - 07:59:59	97170	5.3%	26.99	31.4 GB	5.0%	9151.02
Aug 26 08:00:00 - 08:59:59	82992	4.5%	23.05	25.8 GB	4.1%	7512.79
Aug 26 09:00:00 - 09:59:59	96340	5.2%	26.76	30.7 GB	4.9%	8938.37
Aug 26 10:00:00 - 10:59:59	84812	4.6%	23.56	32.1 GB	5.1%	9344.78
Aug 26 11:00:00 - 11:59:59	75686	4.1%	21.02	28.8 GB	4.6%	8399.96
Aug 26 12:00:00 - 12:59:59	73974	4.0%	20.55	26.8 GB	4.3%	7798.77
Aug 26 13:00:00 - 13:59:59	96215	5.2%	26.73	30.4 GB	4.8%	8843.25
Aug 26 14:00:00 - 14:59:59	92239	5.0%	25.62	29.9 GB	4.8%	8714.17
Aug 26 15:00:00 - 15:59:59	92982	5.0%	25.83	31.0 GB	4.9%	9028.28
Aug 26 16:00:00 - 16:59:59	77727	4.2%	21.59	27.8 GB	4.4%	8101.57
Aug 26 17:00:00 - 17:59:59	71457	3.9%	19.85	25.8 GB	4.1%	7503.67
Aug 26 18:00:00 - 18:59:59	73739	4.0%	20.48	26.3 GB	4.2%	7671.53
Aug 26 19:00:00 - 19:59:59	75852	4.1%	21.07	26.2 GB	4.2%	7639.92
Aug 26 20:00:00 - 20:59:59	80084	4.3%	22.25	27.0 GB	4.3%	7868.16
Aug 26 21:00:00 - 21:59:59	84429	4.6%	23.45	27.4 GB	4.4%	7978.99
Aug 26 22:00:00 - 22:59:59	58024	3.1%	16.12	18.5 GB	2.9%	5387.34
Aug 26 23:00:00 - 23:59:59	44473	2.4%	12.35	15.1 GB	2.4%	4385.38
Aug 27 00:00:00 - 00:59:59	65726	3.6%	18.26	22.7 GB	3.6%	6624.52
Aug 27 01:00:00 - 01:59:59	68779	3.7%	19.11	25.7 GB	4.1%	7479.79
Aug 27 02:00:00 - 02:59:59	50332	2.7%	13.98	19.9 GB	3.2%	5792.96
Aug 27 03:00:00 - 03:59:59	48779	2.6%	13.55	19.3 GB	3.1%	5616.68
Aug 27 04:00:00 - 04:15:03	13988	0.8%	15.49	5.2 GB	0.8%	6045.92
TOTAL: 24:00:01	1847506	100.0%	21.38	629.2 GB	100.0%	7636.04

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	5315	246	2420	1	2648
2	news.nask.pl	873	68	782	1	22
3	news.icm.edu.pl	71	0	6	0	65
TOTAL: 3		6259	314	3208	2	2735

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	98
it.comp.os.win.windows8	47
alt.sex.telephones	42
it.tlc.cellulari.android	26
comp.mobile.ipad	25
comp.sys.raspberry-pi	21
hr.alt.cellular.gsm.android	9
nl.comp.sys.android	8
comp.mobile.android	8
de.comp.office-pakete.ms-office.excel	5
it.comp.os.linux.ubuntu	4
uk.rec.cycling.moderated	4
de.comp.lang.vbclassic	3
de.comm.provider.telefonie	3
hr.alt.cellular.gsm.iphone	3
sci.physics.acoustics	2
de.comp.lang.php	2
rec.arts.tv.x-factor	2
hr.ponuda.hardver.komponente	2
TOTAL: 19	314

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	2479
EMP (md5)	63
HTML post	9
Attached HTML file	2
TOTAL: 4	2553

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	35130	1878	32016	276	1	0	5%	23:57:52
2	icm	42397	1487	31511	430	0	4	3%	24:07:06
3	nask	29202	237	18359	654	0	0	0%	24:01:14
4	poznan	6957	39	4993	22	0	0	0%	23:52:11
5	okapi	0	0	0	0	0	2865	0%	24:00:02
TOTAL: 5		113686	3641	86879	1382	1	2869	3%	119:58:25

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	83.2 MB	20.6 MB	103.8 MB	1.2 KB/s	55.4 KB	24:07:06
2	nask	18.6 MB	188.6 MB	207.1 MB	2.5 KB/s	238.0 KB	24:01:14
3	panorama	9.6 MB	876.2 KB	10.5 MB	0.1 KB/s	5.0 KB	23:57:52
4	poznan	130.3 KB	99.4 KB	229.7 KB	0.0 KB/s	3.8 KB	23:52:11
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
TOTAL: 5		111.5 MB	210.1 MB	321.6 MB	0.8 KB/s	65.6 KB	119:58:25

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	324	436.6 KB	288	0	00:00:08
2	web.man.lodz.pl	288	94	96.9 KB	44	0	00:00:24
3	router2.cbmm.lodz.pl	1	2	11.9 KB	1	0	00:30:17
4	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 4		580	420	545.4 KB	333	3	01:14:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	324	436.6 KB	288	0	00:00:08
2	*.man.lodz.pl	675	94	96.9 KB	44	3	00:00:29
3	*.cbmm.lodz.pl	1	2	11.9 KB	1	0	00:30:17
4	unresolved	1	0	0.0 KB	0	0	00:01:57
5	*.191.14.62.static.jazztel.es	2	0	0.0 KB	0	0	00:38:20
6	*.adsl.inetia.pl	1	0	0.0 KB	0	0	00:01:00
7	*.centertel.pl	1	0	0.0 KB	0	0	00:01:41
8	*.toya.net.pl	113	0	0.0 KB	0	0	00:00:15
TOTAL: 8		1082	420	545.4 KB	333	3	01:14:11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
42.191.14.62.static.jazztel.es	0.752	1.199	00:38:20
router2.cbmm.lodz.pl	0.006	0.018	00:30:17
194.33.77.50	0.005	0.016	00:01:57
public-gprs515189.centertel.pl	0.032	0.020	00:01:41
87-205-205-74.adsl.inetia.pl	0.033	0.019	00:01:00
web.man.lodz.pl	1.432	4.751	00:00:24
staticline41435.toya.net.pl	0.528	1.686	00:00:15
pc-skrzep2.cm.p.lodz.pl	1.367	4.329	00:00:08
mon.man.lodz.pl	1.287	4.091	00:00:03
david.man.lodz.pl	0.435	1.374	00:00:01
isvcs01.man.lodz.pl	0.021	0.050	00:00:00
TOTAL: 11	5.898	17.553	01:14:11

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
staticline41435.toya.net.pl	113
david.man.lodz.pl	96
42.191.14.62.static.jazztel.es	2
public-gprs515189.centertel.pl	1
87-205-205-74.adsl.inetia.pl	1
194.33.77.50	1
TOTAL: 7	502

NNRP client timeouts [Top 20]:

System	Conn	Peer
router2.cbmm.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	324	77.1%
2	pl	96	22.9%
TOTAL: 2		420	100.0%

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

Newsgroup		Count
1	lodman.info	324
2	pl.comp.pecet	72
3	pl.comp.os.ms-windows.winnt	22
4	pl.sci.chemia	2
TOTAL: 4		420

Daily Usenet report

Aug 26 04:15:02 -- Aug 27 04:15:03