Daily Usenet report: Mar 11 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Mar 11 08:42:29 newsfeed nnrpd[7553]: SERVER perl filter not defined
Mar 11 08:44:54 newsfeed nnrpd[7587]: SERVER perl filter not defined
Mar 11 08:47:59 newsfeed nnrpd[7800]: SERVER perl filter not defined
Mar 11 08:52:35 newsfeed nnrpd[7898]: SERVER perl filter not defined
Mar 11 13:02:01 newsfeed nnrpd[16543]: SERVER perl filter not defined
Mar 11 14:29:37 newsfeed nnrpd[19596]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2518328	97.7%	289.7 MB	97.3%
innfeed	34464	1.3%	4.1 MB	1.4%
innd	20174	0.8%	3.5 MB	1.2%
nnrpd	4982	0.2%	530.5 KB	0.2%
TOTAL: 4	2577948	100.0%	297.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2511808	98.2%
Negative hits	29849	1.2%
Positive hits	15871	0.6%
Cache misses	99	0.0%
TOTAL: 4	2557627	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.909	0.0%	263	0.000	7.259	163.000
article cleanup	00:00:37.684	0.0%	2517085	0.005	0.015	0.025
article logging	00:01:21.631	0.1%	2518475	0.017	0.032	0.605
article parse	01:18:48.041	5.5%	183585956	0.012	0.026	0.076
article write	00:26:45.822	1.9%	2513175	0.342	0.639	4.231
artlog/artcncl	00:00:00.006	0.0%	262	0.000	0.023	1.000
artlog/artparse	00:00:00.000	0.0%	4	0.000	0.000	0.000
data move	00:05:21.175	0.4%	199827652	0.001	0.002	0.008
hisgrep/artcncl	00:00:00.186	0.0%	138	0.000	1.348	13.000
hishave/artcncl	00:00:00.096	0.0%	263	0.000	0.365	15.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:33:22.909	2.3%	2559505	0.160	0.783	19.090
history sync	00:00:00.021	0.0%	290	0.000	0.072	1.000
history write	00:48:02.584	3.3%	2513527	0.238	1.147	40.112
hiswrite/artcncl	00:00:00.045	0.0%	125	0.000	0.360	5.000
idle	12:16:31.796	51.1%	133925502	0.095	0.330	1.000
nntp read	01:32:15.680	6.4%	181575262	0.018	0.030	0.046
overview write	00:00:16.040	0.0%	2513175	0.001	0.006	0.016
perl filter	05:56:27.535	24.7%	2513523	6.156	8.509	11.064
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:46.970	0.3%	5079818	0.036	0.056	0.124
TOTAL: 24:00:15.069	23:04:40.130	96.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.280	0.0%	113363	0.000	0.002	0.081
article prepare	00:00:00.024	0.0%	101706	0.000	0.000	0.250
article read	00:00:46.965	0.1%	25420	0.000	1.848	570.333
backlog stats	00:00:00.255	0.0%	291661	0.000	0.001	0.032
callbacks	00:00:00.000	0.0%	9	0.000	0.000	0.000
data read	00:00:02.111	0.0%	158031	0.000	0.013	0.122
data write	00:00:14.767	0.0%	118104	0.000	0.125	2.549
idle	23:58:20.872	99.9%	291661	13.082	295.894	1672.611
status file	00:00:10.134	0.0%	11474	0.000	0.883	110.667
TOTAL: 23:59:47.377	23:59:35.408	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:01:56.700	99.8%	10704	0.000	1019.871	450201.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.532	0.0%	22658	0.000	0.023	0.526
readart	00:00:02.028	0.0%	334	0.000	6.072	11.000
TOTAL: 03:02:16.634	03:01:59.260	99.8%	-	-	-	-

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	1046	2512693	2508506	613	3574	99%	307:17:21
2	news.nask.pl	1	16063	4181	11550	332	26%	23:57:15
3	news.icm.edu.pl	46	279	136	135	8	48%	16:18:12
4	localhost	7	6	6	0	0	100%	00:00:00
TOTAL: 4		1100	2529041	2512829	12298	3914	99%	347:32:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	811.3 GB	17.9 MB	19.2 MB	811.4 GB	99%	338.7 KB
2	news.nask.pl	17.1 MB	1.1 MB	1.2 MB	19.5 MB	87%	4.4 KB
3	news.icm.edu.pl	4.0 MB	47.0 KB	162.6 KB	4.2 MB	95%	30.1 KB
4	localhost	8.3 KB	0.0 KB	0.0 KB	8.3 KB	100%	1.4 KB
TOTAL: 4		811.3 GB	19.1 MB	20.6 MB	811.4 GB	99%	338.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 11 04:15:02 - 04:59:59	55208	2.2%	20.46	20.8 GB	2.6%	8102.49
Mar 11 05:00:00 - 05:59:59	90482	3.6%	25.13	35.0 GB	4.3%	10193.47
Mar 11 06:00:00 - 06:59:59	86429	3.4%	24.01	34.2 GB	4.2%	9947.39
Mar 11 07:00:00 - 07:59:59	93468	3.7%	25.96	35.2 GB	4.3%	10253.91
Mar 11 08:00:00 - 08:59:59	80638	3.2%	22.40	30.4 GB	3.8%	8855.93
Mar 11 09:00:00 - 09:59:59	112469	4.5%	31.24	37.3 GB	4.6%	10853.97
Mar 11 10:00:00 - 10:59:59	104468	4.2%	29.02	33.9 GB	4.2%	9866.99
Mar 11 11:00:00 - 11:59:59	107639	4.3%	29.90	36.0 GB	4.4%	10483.03
Mar 11 12:00:00 - 12:59:59	103110	4.1%	28.64	35.5 GB	4.4%	10345.70
Mar 11 13:00:00 - 13:59:59	111125	4.4%	30.87	35.3 GB	4.4%	10286.79
Mar 11 14:00:00 - 14:59:59	114521	4.6%	31.81	36.4 GB	4.5%	10609.36
Mar 11 15:00:00 - 15:59:59	129291	5.1%	35.91	38.8 GB	4.8%	11313.19
Mar 11 16:00:00 - 16:59:59	106659	4.2%	29.63	35.2 GB	4.3%	10246.48
Mar 11 17:00:00 - 17:59:59	111233	4.4%	30.90	35.8 GB	4.4%	10438.42
Mar 11 18:00:00 - 18:59:59	119257	4.7%	33.13	36.5 GB	4.5%	10624.40
Mar 11 19:00:00 - 19:59:59	74721	3.0%	20.76	25.7 GB	3.2%	7487.49
Mar 11 20:00:00 - 20:59:59	96029	3.8%	26.67	30.9 GB	3.8%	8992.25
Mar 11 21:00:00 - 21:59:59	108706	4.3%	30.20	33.2 GB	4.1%	9678.78
Mar 11 22:00:00 - 22:59:59	115707	4.6%	32.14	34.7 GB	4.3%	10111.80
Mar 11 23:00:00 - 23:59:59	137089	5.5%	38.08	38.1 GB	4.7%	11105.13
Mar 12 00:00:00 - 00:59:59	108145	4.3%	30.04	29.2 GB	3.6%	8495.31
Mar 12 01:00:00 - 01:59:59	128700	5.1%	35.75	36.5 GB	4.5%	10627.06
Mar 12 02:00:00 - 02:59:59	102864	4.1%	28.57	31.1 GB	3.8%	9067.74
Mar 12 03:00:00 - 03:59:59	92219	3.7%	25.62	27.6 GB	3.4%	8045.93
Mar 12 04:00:00 - 04:15:02	22588	0.9%	25.04	6.9 GB	0.9%	8051.55
TOTAL: 24:00:00	2512765	100.0%	29.08	810.3 GB	100.0%	9834.18

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	4871	210	3259	1	1401
2	news.nask.pl	416	21	299	3	93
3	news.icm.edu.pl	14	0	2	0	12
TOTAL: 3		5301	231	3560	4	1506

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	100
comp.sys.raspberry-pi	34
comp.mobile.android	22
it.tlc.cellulari.android	20
it.comp.os.win.windows10	18
it.comp.os.win.windows7	12
hr.alt.cellular.gsm.android	9
comp.mobile.ipad	6
de.rec.sf.startrek	3
de.comp.lang.php	3
it.comp.os.linux.ubuntu	1
hr.alt.cellular.gsm.iphone	1
alt.sex.telephones	1
de.comp.os.os2	1
TOTAL: 14	231

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

Groups	Count
pl.sci.historia	1
bit.listserv.catholic	1
pl.praca.oferowana	1
pl.sci.matematyka	1
TOTAL: 4	4

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	93
EMP (md5)	16
EMP (fsl)	2
Scoring filter (10)	1
HTML post	1
TOTAL: 5	113

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	57990	19143	23185	4014	0	111	33%	23:56:34
2	panorama	63166	1026	42659	522	21	69023	1%	23:59:41
3	poznan	6738	166	4113	6	0	0	2%	24:02:24
4	okapi	0	0	0	0	0	2281	0%	24:00:00
5	nask	0	0	0	0	0	12207	0%	24:00:00
TOTAL: 5		127894	20335	69957	4542	21	83622	15%	119:58:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	3.5 GB	869.3 MB	4.4 GB	53.2 KB/s	197.9 KB	23:56:34
2	panorama	3.7 MB	3.5 MB	7.2 MB	0.1 KB/s	4.8 KB	23:59:41
3	poznan	564.4 KB	25.6 KB	590.0 KB	0.0 KB/s	3.4 KB	24:02:24
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		3.5 GB	872.8 MB	4.4 GB	10.6 KB/s	184.6 KB	119:58:39

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-212-51-218-225.p.lodz.pl	8	202	438.8 KB	3	0	02:37:20
2	web.man.lodz.pl	288	132	142.6 KB	53	0	00:00:31
3	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 3		302	334	581.4 KB	56	6	03:02:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.p.lodz.pl	8	202	438.8 KB	3	0	02:37:20
2	*.man.lodz.pl	678	132	142.6 KB	53	6	00:00:36
3	*.toya.net.pl	14	0	0.0 KB	0	0	00:00:01
4	unresolved	2	0	0.0 KB	0	0	00:23:29
5	*.dsl.klmzmi.ameritech.net	1	0	0.0 KB	0	0	00:00:03
6	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:45
TOTAL: 6		705	334	581.4 KB	56	6	03:02:16

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.042	0.184	02:37:20
89.38.40.100	0.425	0.641	00:23:29
host227.elsnet.pl	0.012	0.016	00:00:45
web.man.lodz.pl	0.985	4.672	00:00:31
mon.man.lodz.pl	1.058	4.429	00:00:03
ppp-69-214-1-45.dsl.klmzmi.ameritech.net	0.006	0.012	00:00:03
staticline41435.toya.net.pl	0.030	0.240	00:00:01
david.man.lodz.pl	0.358	1.317	00:00:01
isvcs01.man.lodz.pl	0.029	0.115	00:00:00
TOTAL: 9	2.945	11.626	03:02:16

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	14
89.38.40.100	2
host227.elsnet.pl	2
ppp-69-214-1-45.dsl.klmzmi.ameritech.net	1
TOTAL: 6	403

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	3	0
89.38.40.100	1	1
TOTAL: 2	4	1

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	334	100.0%
TOTAL: 1		334	100.0%

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

Newsgroup		Count
1	pl.misc.elektronika	188
2	pl.comp.pecet	106
3	pl.comp.os.ms-windows.winnt	26
4	pl.misc.kolej	14
TOTAL: 4		334

Daily Usenet report

Mar 11 04:15:02 -- Mar 12 04:15:02