Daily Usenet report: Nov 29 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 29 07:32:55 newsfeed nnrpd[1052]: SERVER perl filter not defined
Nov 29 10:00:19 newsfeed nnrpd[6884]: SERVER perl filter not defined
Nov 29 14:53:54 newsfeed nnrpd[19176]: SERVER perl filter not defined
Nov 29 17:35:08 newsfeed overchan[24028]: input line too long, skipping
Nov 29 17:56:47 newsfeed overchan[24028]: input line too long, skipping
Nov 29 18:07:22 newsfeed overchan[24028]: input line too long, skipping
Nov 29 18:32:54 newsfeed overchan[24028]: input line too long, skipping
Nov 30 00:55:39 newsfeed overchan[24028]: input line too long, skipping
Nov 30 01:08:49 newsfeed overchan[24028]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3395939	98.0%	395.5 MB	97.7%
innfeed	43191	1.2%	5.1 MB	1.3%
innd	22589	0.7%	3.7 MB	0.9%
nnrpd	4788	0.1%	502.7 KB	0.1%
overchan	7	0.0%	1.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3466515	100.0%	404.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3375824	96.8%
Negative hits	99289	2.8%
Positive hits	12188	0.3%
Cache misses	131	0.0%
TOTAL: 4	3487432	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.953	0.0%	227	0.000	35.035	651.250
article cleanup	00:00:45.430	0.1%	3392006	0.009	0.013	0.018
article logging	00:02:12.157	0.2%	3392812	0.028	0.039	0.061
article parse	01:03:17.362	4.4%	127080617	0.016	0.030	0.052
article write	00:23:11.796	1.6%	3386676	0.212	0.411	0.529
artlog/artcncl	00:00:00.005	0.0%	221	0.000	0.023	0.500
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:02:27.000	0.2%	145923481	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.975	0.0%	196	0.000	4.974	54.000
hishave/artcncl	00:00:00.902	0.0%	227	0.000	3.974	118.750
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:50:09.507	7.6%	3503068	0.565	1.887	6.890
history sync	00:00:00.017	0.0%	290	0.000	0.059	1.000
history write	04:44:19.879	19.7%	3390502	1.953	5.032	10.964
hiswrite/artcncl	00:00:00.278	0.0%	31	0.000	8.968	15.625
idle	08:11:52.345	34.2%	85042927	0.219	0.347	0.704
nntp read	01:07:01.993	4.7%	124346581	0.021	0.032	0.048
overview write	00:00:17.812	0.0%	3386676	0.004	0.005	0.007
perl filter	05:55:30.584	24.7%	3390491	4.286	6.291	8.699
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:37.386	0.4%	6796016	0.035	0.050	0.065
TOTAL: 24:00:07.141	23:26:53.381	97.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.182	0.0%	62531	0.000	0.003	0.010
article prepare	00:00:00.003	0.0%	15360	0.000	0.000	0.026
article read	00:02:14.549	0.2%	3888	2.350	34.606	301.950
backlog stats	00:00:00.139	0.0%	178643	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	76	0.000	0.000	0.000
data read	00:00:01.575	0.0%	97200	0.003	0.016	0.030
data write	00:00:04.067	0.0%	75003	0.015	0.054	0.112
idle	23:51:29.324	99.8%	178643	315.175	480.788	869.630
status file	00:00:17.589	0.0%	15389	0.616	1.143	14.217
TOTAL: 23:54:18.467	23:54:07.428	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:19.439	62.1%	3086	0.000	6.299	151.182
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.245	0.8%	6902	0.000	0.035	1.000
readart	00:00:00.003	0.0%	86	0.000	0.035	0.500
TOTAL: 00:00:31.279	00:00:19.687	62.9%	-	-	-	-

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	365	3388389	3377171	9534	1684	99%	539:58:54
2	news.nask.pl	2	16473	11957	899	3617	72%	23:43:27
3	news.icm.edu.pl	38	283	30	249	4	10%	18:10:18
4	localhost	4	3	3	0	0	100%	00:00:00
TOTAL: 4		409	3405148	3389161	10682	5305	99%	581:52:39

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	943.2 GB	24.6 MB	36.0 MB	943.2 GB	99%	292.7 KB
2	news.nask.pl	63.2 MB	469.9 KB	23.6 MB	87.2 MB	72%	5.7 KB
3	news.icm.edu.pl	749.6 KB	79.2 KB	118.4 KB	947.2 KB	79%	27.9 KB
4	localhost	4.7 KB	0.0 KB	0.0 KB	4.7 KB	100%	1.6 KB
TOTAL: 4		943.2 GB	25.1 MB	59.7 MB	943.3 GB	99%	291.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 29 04:15:02 - 04:59:59	81826	2.4%	30.33	24.1 GB	2.6%	9348.14
Nov 29 05:00:00 - 05:59:59	113425	3.3%	31.51	35.1 GB	3.7%	10214.34
Nov 29 06:00:00 - 06:59:59	113446	3.3%	31.51	36.2 GB	3.8%	10530.49
Nov 29 07:00:00 - 07:59:59	131535	3.9%	36.54	40.5 GB	4.3%	11789.33
Nov 29 08:00:00 - 08:59:59	131876	3.9%	36.63	40.6 GB	4.3%	11832.80
Nov 29 09:00:00 - 09:59:59	224458	6.6%	62.35	35.2 GB	3.7%	10266.68
Nov 29 10:00:00 - 10:59:59	132526	3.9%	36.81	41.0 GB	4.4%	11943.53
Nov 29 11:00:00 - 11:59:59	143841	4.2%	39.96	43.1 GB	4.6%	12541.06
Nov 29 12:00:00 - 12:59:59	154998	4.6%	43.05	41.2 GB	4.4%	12013.59
Nov 29 13:00:00 - 13:59:59	138588	4.1%	38.50	42.2 GB	4.5%	12283.57
Nov 29 14:00:00 - 14:59:59	142336	4.2%	39.54	41.9 GB	4.4%	12196.11
Nov 29 15:00:00 - 15:59:59	142637	4.2%	39.62	42.7 GB	4.5%	12440.40
Nov 29 16:00:00 - 16:59:59	140628	4.1%	39.06	41.6 GB	4.4%	12107.62
Nov 29 17:00:00 - 17:59:59	141523	4.2%	39.31	40.5 GB	4.3%	11801.60
Nov 29 18:00:00 - 18:59:59	158132	4.7%	43.93	40.6 GB	4.3%	11823.10
Nov 29 19:00:00 - 19:59:59	145440	4.3%	40.40	41.9 GB	4.5%	12218.44
Nov 29 20:00:00 - 20:59:59	155153	4.6%	43.10	42.9 GB	4.6%	12496.02
Nov 29 21:00:00 - 21:59:59	140564	4.1%	39.05	37.0 GB	3.9%	10767.86
Nov 29 22:00:00 - 22:59:59	164807	4.9%	45.78	39.0 GB	4.1%	11359.13
Nov 29 23:00:00 - 23:59:59	140826	4.2%	39.12	41.1 GB	4.4%	11979.96
Nov 30 00:00:00 - 00:59:59	115239	3.4%	32.01	31.8 GB	3.4%	9276.15
Nov 30 01:00:00 - 01:59:59	142206	4.2%	39.50	40.5 GB	4.3%	11786.48
Nov 30 02:00:00 - 02:59:59	135458	4.0%	37.63	38.4 GB	4.1%	11181.66
Nov 30 03:00:00 - 03:59:59	125087	3.7%	34.75	33.3 GB	3.5%	9685.51
Nov 30 04:00:00 - 04:15:02	33038	1.0%	36.63	9.8 GB	1.0%	11353.32
TOTAL: 24:00:00	3389593	100.0%	39.23	942.0 GB	100.0%	11432.75

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	3939	17	181	17	3724
2	newsfeed.pionier.net.pl	2181	286	1323	6	566
3	news.icm.edu.pl	5	0	1	0	4
TOTAL: 3		6125	303	1505	23	4294

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	218
it.comp.os.win.windows10	40
nl.comp.sys.android	14
it.tlc.cellulari.android	8
comp.mobile.android	5
de.comp.office-pakete.ms-office.outlook	4
de.comp.office-pakete.ms-office.word	3
de.comm.software.mailreader	3
rec.arts.tv.x-factor	3
de.comp.office-pakete.ms-office.excel	1
it.politica.m5s	1
it.comp.os.linux.ubuntu	1
de.comp.lang.vbclassic	1
it.comp.os.win.windows7	1
TOTAL: 14	303

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

Groups	Count
pl.praca.oferowana	16
pl.sci.historia	6
bit.listserv.catholic	1
TOTAL: 3	23

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3104
Binary in non-binary group	207
EMP (phl)	99
Scoring filter (8)	24
Scoring filter (9)	20
Scoring filter (10)	12
Excessively crossposted test article	6
HTML post	2
Scoring filter (13)	1
Scoring filter (17)	1
TOTAL: 10	3476

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	497
	news.nask.pl	309
	news.icm.edu.pl	1
	TOTAL: 3	807
TOTAL: 1		807

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	47152	1557	19434	368	197	41170	3%	23:59:58
2	poznan	18874	580	11440	45	0	0	3%	23:59:52
3	icm	25927	42	21501	141	0	0	0%	23:59:56
4	nask	2938	3	2403	1	0	0	0%	23:58:42
5	okapi	0	0	0	0	0	1461	0%	23:57:51
TOTAL: 5		94891	2182	54778	555	197	42631	2%	119:56:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	15.1 MB	2.8 MB	17.9 MB	0.2 KB/s	9.5 KB	23:59:58
2	icm	4.8 MB	38.0 MB	42.8 MB	0.5 KB/s	239.6 KB	23:59:56
3	poznan	2.3 MB	300.9 KB	2.6 MB	0.0 KB/s	4.3 KB	23:59:52
4	nask	5.6 KB	1.2 KB	6.8 KB	0.0 KB/s	1.7 KB	23:58:42
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:51
TOTAL: 5		22.2 MB	41.2 MB	63.4 MB	0.2 KB/s	23.7 KB	119:56:19

Backlog files shrunk by innfeed:

Server	Size
panorama	976.8 KB
TOTAL: 1	976.8 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	86	72.4 KB	34	0	00:00:25
2	isvcs01.man.lodz.pl	3	0	0.0 KB	0	3	00:00:00
TOTAL: 2		291	86	72.4 KB	34	3	00:00:30

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.man.lodz.pl	675	86	72.4 KB	34	3	0	00:00:30
TOTAL: 1		675	86	72.4 KB	34	3	0	00:00:30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.476	7.664	00:00:25
mon.man.lodz.pl	0.992	6.996	00:00:03
david.man.lodz.pl	0.368	2.384	00:00:01
isvcs01.man.lodz.pl	0.024	0.120	00:00:00
TOTAL: 4	2.860	17.164	00:00:30

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	44
2	pl.comp.pecet	42
TOTAL: 2		86

Daily Usenet report

Nov 29 04:15:02 -- Nov 30 04:15:02