Daily Usenet report: Nov 7 04:15:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Nov 7 10:26:20 newsfeed nnrpd[14759]: SERVER perl filter not defined
Nov 7 11:43:56 newsfeed nnrpd[17430]: SERVER perl filter not defined
Nov 7 12:36:12 newsfeed nnrpd[19228]: SERVER perl filter not defined
Nov 7 19:16:20 newsfeed nnrpd[557]: SERVER perl filter not defined
Nov 8 04:15:02 newsfeed nnrpd[19327]: web.man.lodz.pl rejected Flushing log and syslog files
Nov 8 04:15:02 newsfeed nnrpd[19332]: web.man.lodz.pl rejected Flushing log and syslog files
Nov 8 04:15:02 newsfeed nnrpd[19334]: web.man.lodz.pl rejected Flushing log and syslog files
Nov 8 04:15:02 newsfeed nnrpd[19336]: web.man.lodz.pl rejected Flushing log and syslog files

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2752036	98.5%	320.3 MB	98.2%
innd	33284	1.2%	4.7 MB	1.4%
nnrpd	4923	0.2%	500.7 KB	0.1%
innfeed	4817	0.2%	677.2 KB	0.2%
TOTAL: 4	2795060	100.0%	326.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2745553	96.1%
Negative hits	94163	3.3%
Positive hits	15375	0.5%
Cache misses	752	0.0%
TOTAL: 4	2855843	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.733	0.0%	220	0.000	3.332	60.000
article cleanup	00:00:46.209	0.1%	2751501	0.008	0.017	0.035
article logging	00:01:33.805	0.1%	2752127	0.018	0.034	0.674
article parse	01:23:47.829	5.8%	169737207	0.013	0.030	0.070
article write	00:27:31.291	1.9%	2733981	0.262	0.604	4.414
artlog/artcncl	00:00:00.004	0.0%	217	0.000	0.018	1.000
artlog/artparse	00:00:00.001	0.0%	3	0.000	0.333	1.000
data move	00:03:09.640	0.2%	186265246	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.150	0.0%	205	0.000	0.732	16.000
hishave/artcncl	00:00:00.033	0.0%	220	0.000	0.150	7.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:24:09.749	1.7%	2857411	0.054	0.507	9.194
history sync	00:00:00.023	0.0%	290	0.000	0.079	2.000
history write	00:36:58.637	2.6%	2747125	0.164	0.808	11.011
hiswrite/artcncl	00:00:00.004	0.0%	15	0.000	0.267	1.000
idle	13:21:48.422	55.7%	102430904	0.329	0.470	1.030
nntp read	01:07:22.758	4.7%	167416949	0.015	0.024	0.054
overview write	00:00:17.274	0.0%	2733981	0.000	0.006	0.018
perl filter	05:56:48.777	24.8%	2747122	4.438	7.793	11.305
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:11.466	0.4%	5511281	0.036	0.057	0.098
TOTAL: 24:00:10.529	23:29:26.805	97.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.181	0.0%	48669	0.000	0.004	0.222
article prepare	00:00:00.021	0.0%	69962	0.000	0.000	0.062
article read	00:00:12.226	0.0%	17489	0.000	0.699	1584.000
backlog stats	00:00:00.233	0.0%	276179	0.000	0.001	0.045
callbacks	00:00:00.000	0.0%	3	0.000	0.000	0.000
data read	00:00:01.822	0.0%	138828	0.000	0.013	0.143
data write	00:00:13.249	0.0%	136146	0.000	0.097	0.226
idle	23:58:55.371	100.0%	276179	24.963	312.607	8624.000
status file	00:00:00.758	0.0%	971	0.000	0.781	3.500
TOTAL: 23:59:31.853	23:59:23.861	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	14:57:43.859	99.9%	329965	0.000	163.241	450058.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:13.059	0.0%	660663	0.000	0.020	0.667
readart	00:00:00.431	0.0%	90	0.000	4.789	14.429
TOTAL: 14:58:28.493	14:57:57.349	99.9%	-	-	-	-

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	821	2734122	2722197	6971	4954	99%	379:46:29
2	news.nask.pl	2	28963	12222	4191	12550	42%	24:20:33
3	news.icm.edu.pl	35	428	10	402	16	2%	16:52:36
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		863	2763517	2734433	11564	17520	98%	420:59:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	844.2 GB	117.5 MB	263.1 MB	844.5 GB	99%	324.7 KB
2	news.nask.pl	83.1 MB	1.5 MB	261.5 MB	346.1 MB	24%	14.3 KB
3	news.icm.edu.pl	307.3 KB	30.9 KB	230.6 KB	568.8 KB	54%	21.9 KB
4	localhost	6.9 KB	0.0 KB	0.0 KB	6.9 KB	100%	1.7 KB
TOTAL: 4		844.2 GB	119.0 MB	524.8 MB	844.9 GB	99%	321.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 7 04:15:02 - 04:59:59	78861	2.9%	29.23	28.2 GB	3.3%	10967.93
Nov 7 05:00:00 - 05:59:59	112201	4.1%	31.17	38.9 GB	4.6%	11322.25
Nov 7 06:00:00 - 06:59:59	104807	3.8%	29.11	35.1 GB	4.2%	10238.03
Nov 7 07:00:00 - 07:59:59	106622	3.9%	29.62	34.5 GB	4.1%	10047.52
Nov 7 08:00:00 - 08:59:59	111284	4.1%	30.91	34.9 GB	4.1%	10153.89
Nov 7 09:00:00 - 09:59:59	136297	5.0%	37.86	40.3 GB	4.8%	11732.81
Nov 7 10:00:00 - 10:59:59	140359	5.1%	38.99	39.9 GB	4.7%	11621.27
Nov 7 11:00:00 - 11:59:59	125801	4.6%	34.94	37.8 GB	4.5%	11001.81
Nov 7 12:00:00 - 12:59:59	117465	4.3%	32.63	37.9 GB	4.5%	11040.54
Nov 7 13:00:00 - 13:59:59	101566	3.7%	28.21	31.7 GB	3.8%	9222.58
Nov 7 14:00:00 - 14:59:59	97652	3.6%	27.13	27.7 GB	3.3%	8059.66
Nov 7 15:00:00 - 15:59:59	135386	5.0%	37.61	37.6 GB	4.5%	10953.63
Nov 7 16:00:00 - 16:59:59	123841	4.5%	34.40	39.0 GB	4.6%	11353.31
Nov 7 17:00:00 - 17:59:59	127191	4.7%	35.33	37.9 GB	4.5%	11049.68
Nov 7 18:00:00 - 18:59:59	124644	4.6%	34.62	39.3 GB	4.7%	11450.80
Nov 7 19:00:00 - 19:59:59	110100	4.0%	30.58	35.5 GB	4.2%	10351.34
Nov 7 20:00:00 - 20:59:59	117744	4.3%	32.71	35.7 GB	4.2%	10410.72
Nov 7 21:00:00 - 21:59:59	139427	5.1%	38.73	37.5 GB	4.4%	10921.29
Nov 7 22:00:00 - 22:59:59	115257	4.2%	32.02	35.0 GB	4.2%	10190.47
Nov 7 23:00:00 - 23:59:59	114223	4.2%	31.73	34.8 GB	4.1%	10138.02
Nov 8 00:00:00 - 00:59:59	79498	2.9%	22.08	23.4 GB	2.8%	6812.35
Nov 8 01:00:00 - 01:59:59	107589	3.9%	29.89	33.0 GB	3.9%	9601.95
Nov 8 02:00:00 - 02:59:59	108372	4.0%	30.10	33.4 GB	4.0%	9742.43
Nov 8 03:00:00 - 03:59:59	79506	2.9%	22.09	27.9 GB	3.3%	8123.04
Nov 8 04:00:00 - 04:15:02	17977	0.7%	19.93	6.0 GB	0.7%	6995.44
TOTAL: 24:00:00	2733670	100.0%	31.64	842.9 GB	100.0%	10229.67

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	12788	25	433	2	12328
2	newsfeed.pionier.net.pl	5345	139	3944	0	1262
3	news.icm.edu.pl	16	0	2	0	14
TOTAL: 3		18149	164	4379	2	13604

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	91
it.tlc.cellulari.android	14
comp.mobile.android	13
it.comp.os.win.windows10	11
de.rec.sf.startrek	6
it.comp.os.win.windows7	5
hr.alt.cellular.gsm.android	5
nl.comp.os.linux.techniek	4
de.comp.lang.vbclassic	3
comp.sys.raspberry-pi	3
de.comp.office-pakete.ms-office.word	2
de.comp.office-pakete.ms-office.outlook	2
comp.sys.mac.vintage	2
uk.rec.cycling.moderated	1
it.comp.os.win.windows8	1
alt.sex.telephones	1
TOTAL: 16	164

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11278
Binary in non-binary group	1460
Scoring filter (8)	127
Scoring filter (9)	49
EMP (phl)	19
Scoring filter (13)	16
Scoring filter (10)	13
Scoring filter (11)	6
Scoring filter (18)	2
EMP (fsl)	2
HTML post	2
Attached HTML file	1
TOTAL: 12	12975

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	54123	136	25497	17023	0	0	0%	23:57:49
2	panorama	8727	101	7032	62	6	41269	1%	24:02:03
3	poznan	16623	78	11971	18	0	0	0%	23:54:06
4	nask	8991	35	6337	21	1	0	0%	23:54:56
5	okapi	0	0	0	0	0	2293	0%	24:00:03
TOTAL: 5		88464	350	50837	17124	7	43562	0%	119:48:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	2.8 MB	4.0 GB	4.0 GB	49.0 KB/s	246.4 KB	23:57:49
2	poznan	559.0 KB	66.4 KB	625.4 KB	0.0 KB/s	6.5 KB	23:54:06
3	panorama	382.6 KB	183.6 KB	566.2 KB	0.0 KB/s	3.5 KB	24:02:03
4	nask	185.8 KB	9.0 MB	9.2 MB	0.1 KB/s	167.8 KB	23:54:56
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		3.9 MB	4.0 GB	4.0 GB	9.8 KB/s	242.5 KB	119:48:57

Backlog files shrunk by innfeed:

Server	Size
panorama	3.3 MB
okapi	488.3 KB
TOTAL: 2	3.8 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	lze200.lze.lodz.pl	13	45	154.5 KB	8	0	01:02:18
2	web.man.lodz.pl	291	40	41.1 KB	18	0	00:00:21
3	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 3		308	85	195.6 KB	26	4	14:58:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.lze.lodz.pl	13	45	154.5 KB	8	0	01:02:18
2	*.man.lodz.pl	680	40	41.1 KB	18	4	00:30:27
3	unresolved	1	0	0.0 KB	0	0	13:25:40
4	*.16-87-r.retail.telecomitalia.it	1	0	0.0 KB	0	0	00:00:01
TOTAL: 4		695	85	195.6 KB	26	4	14:58:28

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.174	16.474	27.562	13:25:40
lze200.lze.lodz.pl	0.052	0.223	01:02:18
pc-vicki.man.lodz.pl	0.000	0.022	00:30:00
web.man.lodz.pl	1.008	4.580	00:00:21
mon.man.lodz.pl	0.894	4.456	00:00:03
host19-51-dynamic.16-87-r.retail.telecomitalia.it	0.000	0.022	00:00:01
david.man.lodz.pl	0.342	1.367	00:00:01
isvcs01.man.lodz.pl	0.017	0.075	00:00:00
TOTAL: 8	18.787	38.307	14:58:28

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
185.48.193.174	1
pc-vicki.man.lodz.pl	1
host19-51-dynamic.16-87-r.retail.telecomitalia.it	1
TOTAL: 5	387

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-vicki.man.lodz.pl	1	0
185.48.193.174	1	1
lze200.lze.lodz.pl	1	2
TOTAL: 3	3	3

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	37
2	pl.rec.kuchnia	15
3	pl.comp.os.ms-windows.winnt	14
4	pl.misc.telefonia.gsm	10
5	pl.internet.polip	7
6	pl.rec.dom	2
TOTAL: 6		85

Daily Usenet report

Nov 7 04:15:02 -- Nov 8 04:15:02