Daily Usenet report: Jun 6 04:15:03

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jun 6 06:16:56 newsfeed nnrpd[28428]: SERVER perl filter not defined
Jun 6 07:35:02 newsfeed nnrpd[13857]: SERVER perl filter not defined
Jun 6 10:03:35 newsfeed nnrpd[18717]: SERVER perl filter not defined
Jun 6 10:39:32 newsfeed nnrpd[19981]: SERVER perl filter not defined
Jun 6 10:44:01 newsfeed nnrpd[20072]: SERVER perl filter not defined
Jun 6 13:15:33 newsfeed nnrpd[25556]: SERVER perl filter not defined
Jun 6 14:20:17 newsfeed nnrpd[27671]: SERVER perl filter not defined
Jun 6 15:14:02 newsfeed innd: getaddrinfo failed: Name or service not known

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1445865	97.9%	162.8 MB	97.4%
innd	14122	1.0%	2.3 MB	1.4%
nnrpd	9660	0.7%	1.1 MB	0.6%
innfeed	7001	0.5%	1.0 MB	0.6%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	1476649	100.0%	167.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1439201	94.8%
Negative hits	41569	2.7%
Positive hits	37393	2.5%
Cache misses	251	0.0%
TOTAL: 4	1518414	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.970	0.0%	300	0.000	19.900	318.000
article cleanup	00:00:23.368	0.0%	1444519	0.003	0.016	0.033
article logging	00:00:47.502	0.1%	1444639	0.011	0.033	0.982
article parse	00:58:51.011	4.1%	190182397	0.006	0.019	0.067
article write	00:14:30.167	1.0%	1439189	0.322	0.605	2.198
artlog/artcncl	00:00:00.010	0.0%	298	0.000	0.034	1.000
artlog/artparse	00:00:00.001	0.0%	4	0.000	0.250	0.333
data move	00:03:03.396	0.2%	200501481	0.000	0.001	0.013
hisgrep/artcncl	00:00:01.059	0.0%	221	0.000	4.792	30.000
hishave/artcncl	00:00:00.917	0.0%	300	0.000	3.057	279.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:07:54.441	8.9%	1520533	0.010	5.047	13.579
history sync	00:00:00.012	0.0%	292	0.000	0.041	1.000
history write	03:29:52.447	14.6%	1441136	0.613	8.738	25.204
hiswrite/artcncl	00:00:00.590	0.0%	79	0.000	7.468	180.000
idle	11:40:59.879	48.7%	147534546	0.136	0.285	13.450
nntp read	01:03:13.722	4.4%	189177098	0.009	0.020	0.045
overview write	00:00:09.018	0.0%	1439189	0.000	0.006	0.028
perl filter	03:36:50.875	15.1%	1441132	6.132	9.028	11.397
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:55.858	0.2%	2915984	0.021	0.060	0.100
TOTAL: 23:58:30.824	23:19:40.243	97.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.137	0.0%	37637	0.000	0.004	0.143
article prepare	00:00:00.012	0.0%	36282	0.000	0.000	0.062
article read	00:00:01.407	0.0%	8740	0.000	0.161	7.429
backlog stats	00:00:00.178	0.0%	292545	0.000	0.001	0.024
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.778	0.0%	164513	0.000	0.011	0.077
data write	00:00:06.143	0.0%	146483	0.000	0.042	0.190
idle	23:58:39.570	100.0%	292545	0.000	295.064	14068.000
status file	00:00:00.777	0.0%	271	0.000	2.867	38.000
TOTAL: 23:58:56.622	23:58:50.002	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	17:22:00.399	99.9%	6523	0.000	9584.608	210037.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:11.623	0.0%	15425	0.000	0.754	512.545
readart	00:00:00.446	0.0%	412	0.000	1.083	141.000
TOTAL: 17:22:47.984	17:22:12.468	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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	737	1435029	1430925	912	3192	99%	241:01:29
2	news.task.gda.pl	19	26010	4311	20275	1424	16%	44:04:38
3	news.nask.pl	4	16458	3941	11872	645	23%	23:48:28
4	news.icm.edu.pl	49	235	7	197	31	2%	16:01:27
5	localhost	8	7	7	0	0	100%	00:00:00
TOTAL: 5		817	1477739	1439191	33256	5292	97%	324:56:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	522.7 GB	9.4 MB	27.0 MB	522.8 GB	99%	382.2 KB
2	news.nask.pl	12.8 MB	1.8 MB	1.9 MB	16.5 MB	77%	3.7 KB
3	news.task.gda.pl	9.8 MB	69.7 KB	4.2 MB	14.0 MB	69%	2.5 KB
4	news.icm.edu.pl	80.3 KB	0.0 KB	410.9 KB	491.1 KB	16%	12.9 KB
5	localhost	9.2 KB	0.0 KB	0.0 KB	9.2 KB	100%	1.3 KB
TOTAL: 5		522.7 GB	11.3 MB	33.4 MB	522.8 GB	99%	379.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 6 04:15:03 - 04:59:59	58969	4.1%	21.86	22.7 GB	4.4%	8842.22
Jun 6 05:00:00 - 05:59:59	78660	5.5%	21.85	29.1 GB	5.6%	8461.57
Jun 6 06:00:00 - 06:59:59	63430	4.4%	17.62	25.2 GB	4.8%	7326.26
Jun 6 07:00:00 - 07:59:59	49706	3.5%	13.81	19.8 GB	3.8%	5765.96
Jun 6 08:00:00 - 08:59:59	38098	2.6%	10.58	16.4 GB	3.1%	4763.77
Jun 6 09:00:00 - 09:59:59	40553	2.8%	11.26	15.0 GB	2.9%	4383.34
Jun 6 10:00:00 - 10:59:59	35931	2.5%	9.98	14.2 GB	2.7%	4143.24
Jun 6 11:00:00 - 11:59:59	38160	2.6%	10.60	14.5 GB	2.8%	4226.84
Jun 6 12:00:00 - 12:59:59	46675	3.2%	12.97	14.6 GB	2.8%	4244.23
Jun 6 13:00:00 - 13:59:59	51194	3.6%	14.22	15.8 GB	3.0%	4606.27
Jun 6 14:00:00 - 14:59:59	66763	4.6%	18.55	19.9 GB	3.8%	5793.23
Jun 6 15:00:00 - 15:59:59	60690	4.2%	16.86	19.0 GB	3.6%	5533.29
Jun 6 16:00:00 - 16:59:59	86271	6.0%	23.96	29.7 GB	5.7%	8662.86
Jun 6 17:00:00 - 17:59:59	83128	5.8%	23.09	30.4 GB	5.8%	8854.55
Jun 6 18:00:00 - 18:59:59	85659	5.9%	23.79	30.3 GB	5.8%	8833.23
Jun 6 19:00:00 - 19:59:59	55935	3.9%	15.54	22.0 GB	4.2%	6410.99
Jun 6 20:00:00 - 20:59:59	54989	3.8%	15.27	21.5 GB	4.1%	6267.93
Jun 6 21:00:00 - 21:59:59	36398	2.5%	10.11	14.6 GB	2.8%	4250.60
Jun 6 22:00:00 - 22:59:59	35495	2.5%	9.86	11.9 GB	2.3%	3457.37
Jun 6 23:00:00 - 23:59:59	39586	2.7%	11.00	15.4 GB	2.9%	4471.18
Jun 7 00:00:00 - 00:59:59	70152	4.9%	19.49	25.2 GB	4.8%	7340.88
Jun 7 01:00:00 - 01:59:59	78350	5.4%	21.76	27.5 GB	5.3%	8021.69
Jun 7 02:00:00 - 02:59:59	86531	6.0%	24.04	30.9 GB	5.9%	9010.32
Jun 7 03:00:00 - 03:59:59	79082	5.5%	21.97	29.6 GB	5.7%	8610.18
Jun 7 04:00:00 - 04:15:03	19703	1.4%	21.82	7.4 GB	1.4%	8568.91
TOTAL: 24:00:00	1440108	100.0%	16.67	522.6 GB	100.0%	6342.23

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3302	171	2734	1	396
2	news.task.gda.pl	1469	1272	33	0	164
3	news.nask.pl	657	7	623	2	25
4	news.icm.edu.pl	31	0	0	0	31
TOTAL: 4		5459	1450	3390	3	616

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.svn-ports-all	138
mailing.freebsd.svn-ports-head	135
mailing.freebsd.ports-bugs	131
uk.railway	72
mailing.freebsd.ports	55
mailing.freebsd.svn-src-all	53
24hoursupport.helpdesk	53
fa.freebsd.cvs-all	52
mozilla.dev.platform	48
mailing.freebsd.svn-src-head	43
mailing.gcc.gcc-cvs	42
alt.windows7.general	39
it.tlc.cellulari.android	37
mailing.openssl.dev	35
mailing.openbsd.misc	35
mailing.unix.samba	34
mailing.unix.spamassassin-talk	32
mailing.database.pgsql-general	27
mozilla.dev.gaia	26
mailing.gcc.libstdc++	25
TOTAL: 71	1450

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	264
EMP (fsl)	146
EMP (md5)	51
Attached HTML file	17
HTML post	12
Scoring filter (8)	1
Scoring filter (12)	1
TOTAL: 7	492

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	52602	3216	27089	3536	11	11	6%	23:54:45
2	panorama	42501	1797	35579	311	0	0	4%	24:03:49
3	nask	21666	90	13654	4	0	0	0%	23:58:59
4	poznan	10044	34	8339	9	0	0	0%	24:00:00
5	task	1468	13	767	11	0	0	0%	21:42:50
6	okapi	0	0	0	0	0	2222	0%	23:50:03
TOTAL: 6		128281	5150	85428	3871	11	2233	4%	141:30:26

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	73.0 MB	1.1 GB	1.1 GB	13.8 KB/s	176.4 KB	23:54:45
2	panorama	6.5 MB	1.1 MB	7.7 MB	0.1 KB/s	3.7 KB	24:03:49
3	nask	603.1 KB	1.9 MB	2.5 MB	0.0 KB/s	26.8 KB	23:58:59
4	poznan	96.8 KB	24.5 KB	121.4 KB	0.0 KB/s	2.8 KB	24:00:00
5	task	33.2 KB	26.6 KB	59.8 KB	0.0 KB/s	2.5 KB	21:42:50
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:03
TOTAL: 6		80.2 MB	1.1 GB	1.1 GB	2.4 KB/s	133.2 KB	141:30:26

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	pc-skrzep2.cm.p.lodz.pl	288	372	498.9 KB	288	0	0	00:00:08
2	web.man.lodz.pl	288	34	37.6 KB	16	0	0	00:00:25
3	188.117.146.126	5	3	3.7 KB	3	0	0	00:00:13
4	router2.cbmm.lodz.pl	2	2	3.9 KB	2	0	0	00:00:57
5	ip-176.105.135.22.tvsat364.lodz.pl	7	1	1.6 KB	1	0	0	00:17:02
6	isvcs01.man.lodz.pl	7	0	0.0 KB	0	7	0	00:00:02
7	cpc6-shef10-2-0-cust236.barn.cable.virginm.net	1	0	0.0 KB	0	0	1	00:00:00
TOTAL: 7		598	412	545.6 KB	310	7	1	17:22:46

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cm.p.lodz.pl	288	372	498.9 KB	288	0	0	00:00:08
2	*.man.lodz.pl	679	34	37.6 KB	16	7	0	00:00:35
3	unresolved	5	3	3.7 KB	3	0	0	00:00:13
4	*.cbmm.lodz.pl	2	2	3.9 KB	2	0	0	00:00:57
5	*.105.135.22.tvsat364.lodz.pl	7	1	1.6 KB	1	0	0	00:17:02
6	*.pa.nsw.optusnet.com.au	468	0	0.0 KB	0	0	0	00:14:01
7	*.filmschool.lodz.pl	1	0	0.0 KB	0	0	0	00:02:19
8	*.wroclaw.mm.pl	104	0	0.0 KB	0	0	0	16:47:06
9	*.barn.cable.virginm.net	1	0	0.0 KB	0	0	1	00:00:00
10	*.toya.net.pl	91	0	0.0 KB	0	0	0	00:00:21
TOTAL: 10		1646	412	545.6 KB	310	7	1	17:22:46

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
host-89-231-50-15.wroclaw.mm.pl	0.328	1.228	16:47:06
ip-176.105.135.22.tvsat364.lodz.pl	0.020	0.092	00:17:02
pa49-181-247-110.pa.nsw.optusnet.com.au	1.200	4.176	00:14:01
proxy.filmschool.lodz.pl	0.000	0.020	00:02:19
router2.cbmm.lodz.pl	0.004	0.032	00:00:57
web.man.lodz.pl	0.672	3.500	00:00:25
staticline41435.toya.net.pl	0.248	0.896	00:00:21
188.117.146.126	0.056	0.104	00:00:13
pc-skrzep2.cm.p.lodz.pl	0.640	3.284	00:00:08
mon.man.lodz.pl	0.568	3.240	00:00:06
isvcs01.man.lodz.pl	0.028	0.108	00:00:02
david.man.lodz.pl	0.164	1.048	00:00:01
cpc6-shef10-2-0-cust236.barn.cable.virginm.net	0.000	0.012	00:00:00
TOTAL: 13	3.928	17.740	17:22:46

Curious NNRP server explorers [Top 20]:

System	Conn
pa49-181-247-110.pa.nsw.optusnet.com.au	468
mon.man.lodz.pl	288
host-89-231-50-15.wroclaw.mm.pl	104
david.man.lodz.pl	96
staticline41435.toya.net.pl	91
proxy.filmschool.lodz.pl	1
TOTAL: 6	1048

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	375	91.0%
2	pl	37	9.0%
TOTAL: 2		412	100.0%

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

Newsgroup		Count
1	lodman.info	375
2	pl.comp.pecet	18
3	pl.comp.os.ms-windows.winnt	16
4	pl.regionalne.lodz	2
5	pl.sci.chemia	1
TOTAL: 5		412

Daily Usenet report

Jun 6 04:15:03 -- Jun 7 04:15:03