Daily Usenet report: Sep 16 04:15:03

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Sep 16 09:01:35 newsfeed nnrpd[3049]: SERVER perl filter not defined
Sep 16 09:29:22 newsfeed nnrpd[4045]: SERVER perl filter not defined
Sep 16 09:45:19 newsfeed overchan[24221]: input line too long, skipping
Sep 16 17:15:02 newsfeed overchan[24221]: input line too long, skipping
Sep 16 17:56:58 newsfeed overchan[24221]: input line too long, skipping
Sep 16 18:00:08 newsfeed overchan[24221]: input line too long, skipping
Sep 16 19:12:23 newsfeed overchan[24221]: input line too long, skipping
Sep 16 19:19:38 newsfeed overchan[24221]: input line too long, skipping
Sep 17 00:42:50 newsfeed nnrpd[4949]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2836206	97.3%	333.9 MB	97.0%
innfeed	49436	1.7%	5.9 MB	1.7%
innd	23482	0.8%	3.8 MB	1.1%
nnrpd	4778	0.2%	502.7 KB	0.1%
overchan	7	0.0%	0.8 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	2913910	100.0%	344.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2755725	88.3%
Negative hits	292043	9.4%
Positive hits	73946	2.4%
Cache misses	782	0.0%
TOTAL: 4	3122496	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.846	0.0%	201	0.000	19.134	90.000
article cleanup	00:00:46.848	0.1%	2816160	0.013	0.017	0.021
article logging	00:02:00.979	0.1%	2816565	0.032	0.043	0.141
article parse	01:19:35.065	5.6%	150976226	0.018	0.032	0.068
article write	00:26:28.966	1.9%	2770406	0.431	0.574	1.101
artlog/artcncl	00:00:00.004	0.0%	192	0.000	0.021	0.250
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:40.355	0.3%	168065902	0.001	0.001	0.003
hisgrep/artcncl	00:00:00.408	0.0%	191	0.000	2.136	8.333
hishave/artcncl	00:00:00.185	0.0%	201	0.000	0.920	8.800
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:42:31.737	3.0%	3146095	0.034	0.811	7.153
history sync	00:00:00.020	0.0%	288	0.000	0.069	1.000
history write	01:27:19.285	6.1%	2775617	0.294	1.888	10.143
hiswrite/artcncl	00:00:00.011	0.0%	10	0.000	1.100	9.000
idle	11:08:02.449	46.7%	92026320	0.229	0.436	0.743
nntp read	01:23:50.742	5.9%	148742699	0.024	0.034	0.043
overview write	00:00:18.001	0.0%	2770406	0.005	0.006	0.008
perl filter	06:24:36.792	26.9%	2775617	7.384	8.314	9.595
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:02.004	0.4%	5653568	0.039	0.053	0.069
TOTAL: 23:50:01.695	23:04:17.697	96.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.731	0.0%	251164	0.000	0.003	0.012
article prepare	00:00:00.015	0.0%	35608	0.000	0.000	0.028
article read	00:00:45.400	0.1%	8725	0.000	5.203	301.667
backlog stats	00:00:00.490	0.0%	624072	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	4	0.000	0.000	0.000
data read	00:00:07.529	0.0%	398186	0.009	0.019	0.051
data write	00:00:29.475	0.0%	294299	0.013	0.100	0.474
idle	23:51:29.224	99.8%	624072	31.746	137.627	900.870
status file	00:00:17.699	0.0%	16726	0.717	1.058	12.008
TOTAL: 23:53:41.414	23:53:10.563	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:18.107	41.1%	3060	0.000	5.917	39.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.211	0.5%	6806	0.000	0.031	1.000
readart	00:00:00.004	0.0%	62	0.000	0.065	0.500
TOTAL: 00:00:44.047	00:00:18.322	41.6%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	192

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	933	2790684	2741876	7277	41531	98%	407:12:40
2	news.nask.pl	2	79113	46795	27128	5190	59%	24:05:23
3	news.icm.edu.pl	44	287	37	221	29	12%	19:22:13
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		983	2870087	2788711	34626	46750	97%	450:40:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	850.2 GB	12.4 GB	12.6 GB	875.2 GB	97%	329.7 KB
2	news.nask.pl	13.1 GB	341.4 MB	395.6 MB	13.8 GB	94%	278.3 KB
3	news.icm.edu.pl	708.4 KB	18.1 KB	2.2 MB	2.9 MB	23%	45.2 KB
4	localhost	4.2 KB	0.0 KB	0.0 KB	4.2 KB	100%	1.4 KB
TOTAL: 4		863.3 GB	12.7 GB	13.0 GB	889.0 GB	97%	328.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 16 04:15:03 - 04:59:59	94340	3.4%	34.98	30.1 GB	3.5%	11710.58
Sep 16 05:00:00 - 05:59:59	121602	4.4%	33.78	41.1 GB	4.8%	11968.61
Sep 16 06:00:00 - 06:59:59	126724	4.5%	35.20	40.9 GB	4.7%	11916.53
Sep 16 07:00:00 - 07:59:59	135418	4.9%	37.62	42.8 GB	5.0%	12453.86
Sep 16 08:00:00 - 08:59:59	146090	5.2%	40.58	41.5 GB	4.8%	12094.31
Sep 16 09:00:00 - 09:59:59	118915	4.3%	33.03	34.9 GB	4.0%	10153.30
Sep 16 10:00:00 - 10:59:59	133738	4.8%	37.15	39.7 GB	4.6%	11576.88
Sep 16 11:00:00 - 11:59:59	144229	5.2%	40.06	39.8 GB	4.6%	11582.19
Sep 16 12:00:00 - 12:59:59	129973	4.7%	36.10	39.4 GB	4.6%	11479.07
Sep 16 13:00:00 - 13:59:59	115562	4.1%	32.10	37.8 GB	4.4%	11006.03
Sep 16 14:00:00 - 14:59:59	121756	4.4%	33.82	38.8 GB	4.5%	11314.14
Sep 16 15:00:00 - 15:59:59	126541	4.5%	35.15	41.4 GB	4.8%	12065.71
Sep 16 16:00:00 - 16:59:59	117602	4.2%	32.67	38.9 GB	4.5%	11332.19
Sep 16 17:00:00 - 17:59:59	98446	3.5%	27.35	33.6 GB	3.9%	9786.83
Sep 16 18:00:00 - 18:59:59	55133	2.0%	15.31	21.3 GB	2.5%	6216.93
Sep 16 19:00:00 - 19:59:59	52670	1.9%	14.63	19.2 GB	2.2%	5597.85
Sep 16 20:00:00 - 20:59:59	56126	2.0%	15.59	20.2 GB	2.3%	5871.11
Sep 16 21:00:00 - 21:59:59	117782	4.2%	32.72	36.5 GB	4.2%	10635.42
Sep 16 22:00:00 - 22:59:59	134871	4.8%	37.46	41.5 GB	4.8%	12080.17
Sep 16 23:00:00 - 23:59:59	107908	3.9%	29.97	31.6 GB	3.7%	9202.31
Sep 17 00:00:00 - 00:59:59	109235	3.9%	30.34	28.9 GB	3.4%	8424.20
Sep 17 01:00:00 - 01:59:59	145018	5.2%	40.28	39.4 GB	4.6%	11471.71
Sep 17 02:00:00 - 02:59:59	136435	4.9%	37.90	39.3 GB	4.6%	11443.91
Sep 17 03:00:00 - 03:59:59	115638	4.1%	32.12	34.7 GB	4.0%	10105.41
Sep 17 04:00:00 - 04:15:03	27127	1.0%	30.04	8.8 GB	1.0%	10247.63
TOTAL: 24:00:00	2788879	100.0%	32.28	862.2 GB	100.0%	10463.43

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	41819	308	40203	0	1308
2	news.nask.pl	5285	14	1307	5	3959
3	news.icm.edu.pl	31	0	1	0	30
TOTAL: 3		47135	322	41511	5	5297

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	209
it.tlc.cellulari.android	49
it.comp.os.win.windows10	24
comp.mobile.android	21
it.comp.os.win.windows7	11
de.comp.lang.perl	2
de.rec.sf.startrek	2
de.comp.lang.php	2
hr.rec.glazba.hifi	1
it.comp.virtualizzazione	1
TOTAL: 10	322

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

Groups	Count
pl.praca.oferowana	4
bit.listserv.catholic	1
TOTAL: 2	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3434
Binary in non-binary group	1300
Scoring filter (8)	54
EMP (phl)	32
Poison newsgroup	31
Scoring filter (9)	15
Scoring filter (11)	7
Scoring filter (10)	7
HTML post	4
Too many newsgroups	3
Scoring filter (12)	1
Bad X-Cancelled-By	1
TOTAL: 12	4889

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	295
	news.nask.pl	111
	news.icm.edu.pl	2
	TOTAL: 3	408
TOTAL: 1		408

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	nask	83971	5660	55307	7	0	3	6%	23:59:13
2	panorama	143499	992	114421	330	6	137968	0%	23:59:56
3	poznan	13174	225	7853	36	0	0	1%	23:59:50
4	icm	122553	58	112766	1223	0	5	0%	23:59:56
5	okapi	0	0	0	0	0	941	0%	23:57:50
TOTAL: 5		363197	6935	290347	1596	6	138917	1%	119:56:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nask	1.9 GB	2.4 MB	1.9 GB	23.1 KB/s	352.5 KB	23:59:13
2	icm	3.7 MB	560.7 MB	564.4 MB	6.7 KB/s	451.1 KB	23:59:56
3	panorama	3.1 MB	2.3 MB	5.4 MB	0.1 KB/s	4.2 KB	23:59:56
4	poznan	801.4 KB	113.3 KB	914.6 KB	0.0 KB/s	3.5 KB	23:59:50
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		1.9 GB	565.5 MB	2.5 GB	6.0 KB/s	302.7 KB	119:56:45

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	62	53.5 KB	26	0	00:00:29
2	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 2		291	62	53.5 KB	26	3	00:00:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	675	62	53.5 KB	26	3	0	00:00:43
TOTAL: 1		675	62	53.5 KB	26	3	0	00:00:43

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.500	5.696	00:00:29
mon.man.lodz.pl	1.116	5.920	00:00:09
david.man.lodz.pl	0.448	1.808	00:00:03
isvcs01.man.lodz.pl	0.016	0.080	00:00:00
TOTAL: 4	3.080	13.504	00:00:43

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
TOTAL: 2	384

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	60
2	pl.comp.os.ms-windows.winnt	2
TOTAL: 2		62

Daily Usenet report

Sep 16 04:15:03 -- Sep 17 04:15:03