Daily Usenet report: Nov 13 04:15:02

Unknown entries from news log file:

First 28 / 28 lines (100.0%)

Nov 13 07:53:19 newsfeed nnrpd[21229]: SERVER perl filter not defined
Nov 13 10:31:48 newsfeed nnrpd[27141]: SERVER perl filter not defined
Nov 13 11:00:26 newsfeed nnrpd[28110]: SERVER perl filter not defined
Nov 13 11:01:13 newsfeed nnrpd[28111]: SERVER perl filter not defined
Nov 13 11:01:23 newsfeed nnrpd[28112]: SERVER perl filter not defined
Nov 13 11:06:08 newsfeed nnrpd[28373]: SERVER perl filter not defined
Nov 13 11:37:59 newsfeed nnrpd[30674]: SERVER perl filter not defined
Nov 13 12:08:50 newsfeed nnrpd[31818]: SERVER perl filter not defined
Nov 13 12:21:02 newsfeed nnrpd[32281]: SERVER perl filter not defined
Nov 13 12:26:38 newsfeed nnrpd[32543]: SERVER perl filter not defined
Nov 13 14:39:43 newsfeed overchan[12445]: input line too long, skipping
Nov 13 14:44:34 newsfeed overchan[12445]: input line too long, skipping
Nov 13 15:02:16 newsfeed overchan[12445]: input line too long, skipping
Nov 13 15:33:31 newsfeed nnrpd[7247]: SERVER perl filter not defined
Nov 13 15:34:16 newsfeed nnrpd[7269]: SERVER perl filter not defined
Nov 13 15:34:47 newsfeed nnrpd[7286]: SERVER perl filter not defined
Nov 13 15:36:01 newsfeed nnrpd[7335]: SERVER perl filter not defined
Nov 13 16:48:33 newsfeed overchan[12445]: input line too long, skipping
Nov 13 17:11:22 newsfeed overchan[12445]: input line too long, skipping
Nov 13 19:01:34 newsfeed overchan[12445]: input line too long, skipping
Nov 13 19:16:29 newsfeed overchan[12445]: input line too long, skipping
Nov 13 22:53:12 newsfeed overchan[12445]: input line too long, skipping
Nov 13 22:58:48 newsfeed overchan[12445]: input line too long, skipping
Nov 13 23:09:25 newsfeed overchan[12445]: input line too long, skipping
Nov 13 23:49:49 newsfeed nnrpd[25638]: SERVER perl filter not defined
Nov 13 23:52:46 newsfeed nnrpd[25851]: SERVER perl filter not defined
Nov 14 00:44:15 newsfeed overchan[12445]: input line too long, skipping
Nov 14 01:16:50 newsfeed overchan[12445]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3094623	97.8%	353.2 MB	97.5%
innd	36619	1.2%	5.3 MB	1.5%
innfeed	27329	0.9%	3.2 MB	0.9%
nnrpd	4882	0.2%	510.2 KB	0.1%
overchan	14	0.0%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3163468	100.0%	362.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3064056	94.4%
Negative hits	160424	4.9%
Positive hits	20957	0.6%
Cache misses	141	0.0%
TOTAL: 4	3245578	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.515	0.0%	217	0.000	11.590	115.000
article cleanup	00:00:39.363	0.0%	3096224	0.010	0.013	0.017
article logging	00:02:02.425	0.1%	3097090	0.026	0.040	0.109
article parse	00:51:05.789	3.5%	91228266	0.018	0.034	0.042
article write	00:20:35.174	1.4%	3071996	0.172	0.402	0.705
artlog/artcncl	00:00:00.006	0.0%	207	0.000	0.029	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:02:05.561	0.1%	107548418	0.001	0.001	0.003
hisgrep/artcncl	00:00:00.602	0.0%	215	0.000	2.800	28.250
hishave/artcncl	00:00:00.171	0.0%	217	0.000	0.788	5.667
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:08:10.006	4.7%	3270744	0.074	1.250	5.312
history sync	00:00:00.013	0.0%	291	0.000	0.045	0.500
history write	02:24:04.206	10.0%	3088176	0.295	2.799	12.308
hiswrite/artcncl	00:00:00.014	0.0%	2	0.000	7.000	14.000
idle	12:48:42.865	53.4%	67297944	0.402	0.685	1.283
nntp read	00:48:21.795	3.4%	88891214	0.022	0.033	0.040
overview write	00:00:15.836	0.0%	3071996	0.004	0.005	0.007
perl filter	05:01:26.397	20.9%	3088171	3.496	5.857	7.514
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:54.378	0.3%	6166028	0.034	0.048	0.067
TOTAL: 24:00:05.036	23:32:27.116	98.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.129	0.0%	42974	0.000	0.003	0.015
article prepare	00:00:00.003	0.0%	9144	0.000	0.000	0.036
article read	00:01:22.238	0.1%	2287	0.000	35.959	285.071
backlog stats	00:00:00.130	0.0%	153184	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	9	0.000	0.000	0.000
data read	00:00:01.200	0.0%	84390	0.003	0.014	0.031
data write	00:00:02.975	0.0%	62568	0.019	0.048	0.094
idle	23:53:39.475	99.9%	153184	327.264	561.543	980.124
status file	00:00:08.597	0.0%	9454	0.433	0.909	8.130
TOTAL: 23:55:23.079	23:55:14.747	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:16.988	51.1%	3166	0.000	5.366	42.111
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.202	0.6%	6960	0.000	0.029	0.667
readart	00:00:00.021	0.1%	68	0.000	0.309	9.500
TOTAL: 00:00:33.234	00:00:17.211	51.8%	-	-	-	-

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	1145	3080197	3057578	9777	12842	99%	452:29:57
2	news.nask.pl	2	25984	11747	2895	11342	45%	23:38:47
3	localhost	17	16	16	0	0	100%	00:00:02
4	news.icm.edu.pl	45	230	15	211	4	6%	17:24:05
TOTAL: 4		1209	3106427	3069356	12883	24188	98%	493:32:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	754.9 GB	1.2 GB	2.1 GB	758.2 GB	99%	258.9 KB
2	news.nask.pl	87.3 MB	30.2 MB	1.4 GB	1.5 GB	5%	67.5 KB
3	news.icm.edu.pl	446.4 KB	30.2 KB	234.4 KB	711.0 KB	62%	37.4 KB
4	localhost	24.1 KB	0.0 KB	0.0 KB	24.1 KB	100%	1.5 KB
TOTAL: 4		754.9 GB	1.2 GB	3.5 GB	759.7 GB	99%	257.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 13 04:15:02 - 04:59:59	62423	2.0%	23.14	16.6 GB	2.2%	6454.70
Nov 13 05:00:00 - 05:59:59	69987	2.3%	19.44	20.5 GB	2.7%	5983.09
Nov 13 06:00:00 - 06:59:59	70339	2.3%	19.54	18.6 GB	2.5%	5425.37
Nov 13 07:00:00 - 07:59:59	78602	2.6%	21.83	19.9 GB	2.6%	5796.06
Nov 13 08:00:00 - 08:59:59	81165	2.6%	22.55	21.1 GB	2.8%	6155.76
Nov 13 09:00:00 - 09:59:59	63065	2.1%	17.52	18.4 GB	2.4%	5346.26
Nov 13 10:00:00 - 10:59:59	79609	2.6%	22.11	20.4 GB	2.7%	5955.34
Nov 13 11:00:00 - 11:59:59	96058	3.1%	26.68	21.7 GB	2.9%	6312.66
Nov 13 12:00:00 - 12:59:59	123126	4.0%	34.20	28.2 GB	3.7%	8222.91
Nov 13 13:00:00 - 13:59:59	146858	4.8%	40.79	32.6 GB	4.3%	9492.53
Nov 13 14:00:00 - 14:59:59	132603	4.3%	36.83	38.2 GB	5.1%	11136.45
Nov 13 15:00:00 - 15:59:59	110960	3.6%	30.82	32.5 GB	4.3%	9468.34
Nov 13 16:00:00 - 16:59:59	128553	4.2%	35.71	36.0 GB	4.8%	10496.82
Nov 13 17:00:00 - 17:59:59	138930	4.5%	38.59	40.2 GB	5.3%	11721.73
Nov 13 18:00:00 - 18:59:59	142590	4.6%	39.61	38.5 GB	5.1%	11218.83
Nov 13 19:00:00 - 19:59:59	133916	4.4%	37.20	42.7 GB	5.7%	12426.41
Nov 13 20:00:00 - 20:59:59	142696	4.6%	39.64	42.1 GB	5.6%	12262.50
Nov 13 21:00:00 - 21:59:59	160719	5.2%	44.64	36.7 GB	4.9%	10692.69
Nov 13 22:00:00 - 22:59:59	242722	7.9%	67.42	38.6 GB	5.1%	11240.22
Nov 13 23:00:00 - 23:59:59	276505	9.0%	76.81	34.7 GB	4.6%	10117.65
Nov 14 00:00:00 - 00:59:59	175685	5.7%	48.80	31.2 GB	4.1%	9080.48
Nov 14 01:00:00 - 01:59:59	137006	4.5%	38.06	38.2 GB	5.1%	11124.79
Nov 14 02:00:00 - 02:59:59	137154	4.5%	38.10	41.7 GB	5.5%	12153.69
Nov 14 03:00:00 - 03:59:59	108921	3.5%	30.26	36.0 GB	4.8%	10497.54
Nov 14 04:00:00 - 04:15:02	29143	0.9%	32.31	9.1 GB	1.2%	10580.92
TOTAL: 24:00:00	3069335	100.0%	35.52	754.7 GB	100.0%	9159.03

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	13228	239	7585	1	5403
2	news.nask.pl	11849	20	462	2	11365
3	news.icm.edu.pl	4	0	1	0	3
TOTAL: 3		25081	259	8048	3	16771

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	183
it.comp.os.win.windows10	26
it.tlc.cellulari.android	17
comp.mobile.android	14
comp.sys.raspberry-pi	12
de.comp.lang.vbclassic	2
hr.sci.med	1
alt.sex.telephones	1
it.comp.os.linux.ubuntu	1
it.politica.m5s	1
alt.sex.telephone.alt.sex	1
TOTAL: 11	259

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	12141
EMP (md5)	3408
Scoring filter (9)	136
Scoring filter (12)	66
EMP (phl)	60
Scoring filter (8)	42
Scoring filter (10)	20
HTML post	8
Scoring filter (11)	7
Poison newsgroup	6
Attached HTML file	1
Scoring filter (19)	1
Scoring filter (13)	1
Too many newsgroups	1
Excessively crossposted test article	1
TOTAL: 15	15899

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.nask.pl	481
	newsfeed.pionier.net.pl	386
	TOTAL: 2	867
TOTAL: 1		867

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	23371	742	6776	169	24	34976	3%	23:59:57
2	poznan	19070	584	11203	57	0	0	3%	23:59:56
3	icm	26368	41	21127	7	0	0	0%	23:59:50
4	nask	3103	5	2258	8	0	0	0%	23:56:41
5	okapi	0	0	0	0	0	1393	0%	23:57:49
TOTAL: 5		71912	1372	41364	241	24	36369	1%	119:54:13

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	4.1 MB	1.8 MB	5.9 MB	0.1 KB/s	6.6 KB	23:59:57
2	icm	3.3 MB	1.2 MB	4.5 MB	0.1 KB/s	96.4 KB	23:59:50
3	poznan	1.9 MB	913.5 KB	2.8 MB	0.0 KB/s	4.4 KB	23:59:56
4	nask	174.9 KB	2.0 MB	2.2 MB	0.0 KB/s	173.6 KB	23:56:41
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		9.5 MB	5.9 MB	15.4 MB	0.0 KB/s	9.8 KB	119:54:13

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	68	64.4 KB	25	0	00:00:21
2	isvcs01.man.lodz.pl	16	0	0.0 KB	0	16	00:00:07
TOTAL: 2		304	68	64.4 KB	25	16	00:00:32

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	688	68	64.4 KB	25	16	0	00:00:32
TOTAL: 1		688	68	64.4 KB	25	16	0	00:00:32

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.308	4.480	00:00:21
isvcs01.man.lodz.pl	0.080	0.260	00:00:07
mon.man.lodz.pl	1.140	4.564	00:00:03
david.man.lodz.pl	0.348	1.496	00:00:00
TOTAL: 4	2.876	10.800	00:00:32

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	68	100.0%
TOTAL: 1		68	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	68
TOTAL: 1		68

Daily Usenet report

Nov 13 04:15:02 -- Nov 14 04:15:02