Daily Usenet report: Nov 11 04:15:03

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Nov 11 18:12:45 newsfeed nnrpd[32281]: SERVER perl filter not defined
Nov 12 00:53:28 newsfeed overchan[32750]: input line too long, skipping
Nov 12 01:00:07 newsfeed overchan[32750]: input line too long, skipping
Nov 12 01:04:39 newsfeed overchan[32750]: input line too long, skipping
Nov 12 03:06:29 newsfeed overchan[32750]: input line too long, skipping
Nov 12 03:39:38 newsfeed overchan[32750]: input line too long, skipping
Nov 12 03:41:14 newsfeed overchan[32750]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3858147	98.3%	435.6 MB	98.0%
innd	37240	0.9%	5.6 MB	1.3%
innfeed	25123	0.6%	3.0 MB	0.7%
nnrpd	4781	0.1%	500.3 KB	0.1%
overchan	7	0.0%	1.3 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	3925299	100.0%	444.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	3793053	96.1%
Negative hits	133047	3.4%
Positive hits	19077	0.5%
Cache misses	115	0.0%
TOTAL: 4	3945292	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.552	0.0%	403	0.000	3.851	265.000
article cleanup	00:00:55.148	0.1%	3868902	0.010	0.014	0.022
article logging	00:02:38.355	0.2%	3869996	0.027	0.041	0.137
article parse	01:02:25.728	4.3%	111464668	0.027	0.034	0.052
article write	00:23:45.291	1.6%	3846261	0.174	0.371	1.648
artlog/artcncl	00:00:00.006	0.0%	399	0.000	0.015	0.091
data move	00:03:26.452	0.2%	128924251	0.001	0.002	0.003
hisgrep/artcncl	00:00:00.243	0.0%	388	0.000	0.626	15.000
hishave/artcncl	00:00:00.074	0.0%	403	0.000	0.184	3.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:33:48.339	2.3%	4013273	0.021	0.505	4.462
history sync	00:00:00.022	0.0%	290	0.000	0.076	0.500
history write	01:54:51.854	8.0%	3860222	0.193	1.785	7.426
hiswrite/artcncl	00:00:00.030	0.0%	15	0.000	2.000	10.000
idle	11:13:42.137	46.8%	79844893	0.279	0.506	1.164
nntp read	01:12:43.459	5.1%	108295652	0.032	0.040	0.070
overview write	00:00:22.458	0.0%	3846261	0.004	0.006	0.009
perl filter	06:53:31.952	28.7%	3860164	5.170	6.428	9.720
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:06:50.555	0.5%	7711658	0.037	0.053	0.080
TOTAL: 24:00:02.800	23:29:03.655	97.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.155	0.0%	42421	0.000	0.004	0.016
article prepare	00:00:00.006	0.0%	14362	0.000	0.000	0.021
article read	00:01:11.804	0.1%	3652	0.000	19.662	1112.000
backlog stats	00:00:00.139	0.0%	142401	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	37	0.000	0.000	0.000
data read	00:00:01.445	0.0%	77230	0.000	0.019	0.079
data write	00:00:04.138	0.0%	58543	0.023	0.071	0.343
idle	23:54:10.415	99.9%	142401	237.177	604.282	1303.141
status file	00:00:07.725	0.0%	8295	0.583	0.931	8.691
TOTAL: 23:55:47.928	23:55:35.827	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:33:38.224	99.1%	3128	0.000	645.212	20824.719
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.612	0.0%	7052	0.000	0.087	1.003
readart	00:00:00.158	0.0%	53	0.000	2.981	12.000
TOTAL: 00:33:56.041	00:33:38.994	99.2%	-	-	-	-

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	874	3843698	3824020	6673	13005	99%	364:51:30
2	news.nask.pl	2	22889	9931	3357	9601	43%	23:53:15
3	news.icm.edu.pl	46	221	7	204	10	3%	16:39:26
4	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 4		924	3866809	3833959	10234	22616	99%	405:24:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	747.8 GB	1.3 GB	2.1 GB	751.3 GB	99%	205.3 KB
2	news.nask.pl	75.0 MB	12.2 MB	1.5 GB	1.5 GB	4%	82.9 KB
3	news.icm.edu.pl	248.4 KB	0.0 KB	715.4 KB	963.8 KB	25%	56.7 KB
4	localhost	1.6 KB	0.0 KB	0.0 KB	1.6 KB	100%	1.6 KB
TOTAL: 4		747.9 GB	1.3 GB	3.6 GB	752.8 GB	99%	204.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 11 04:15:03 - 04:59:59	149805	3.9%	55.55	14.7 GB	2.0%	5700.03
Nov 11 05:00:00 - 05:59:59	139361	3.6%	38.71	20.5 GB	2.7%	5962.74
Nov 11 06:00:00 - 06:59:59	96304	2.5%	26.75	25.8 GB	3.4%	7514.72
Nov 11 07:00:00 - 07:59:59	127357	3.3%	35.38	37.0 GB	4.9%	10789.50
Nov 11 08:00:00 - 08:59:59	100733	2.6%	27.98	30.4 GB	4.1%	8865.12
Nov 11 09:00:00 - 09:59:59	73610	1.9%	20.45	23.0 GB	3.1%	6710.87
Nov 11 10:00:00 - 10:59:59	68745	1.8%	19.10	22.0 GB	2.9%	6417.71
Nov 11 11:00:00 - 11:59:59	56001	1.5%	15.56	17.6 GB	2.4%	5128.80
Nov 11 12:00:00 - 12:59:59	67810	1.8%	18.84	20.7 GB	2.8%	6027.66
Nov 11 13:00:00 - 13:59:59	122262	3.2%	33.96	26.7 GB	3.6%	7777.31
Nov 11 14:00:00 - 14:59:59	109912	2.9%	30.53	31.2 GB	4.2%	9087.16
Nov 11 15:00:00 - 15:59:59	258728	6.7%	71.87	35.0 GB	4.7%	10187.71
Nov 11 16:00:00 - 16:59:59	217370	5.7%	60.38	33.7 GB	4.5%	9817.34
Nov 11 17:00:00 - 17:59:59	219413	5.7%	60.95	33.3 GB	4.5%	9708.46
Nov 11 18:00:00 - 18:59:59	205088	5.3%	56.97	38.7 GB	5.2%	11273.78
Nov 11 19:00:00 - 19:59:59	279638	7.3%	77.68	35.5 GB	4.7%	10332.09
Nov 11 20:00:00 - 20:59:59	216073	5.6%	60.02	34.4 GB	4.6%	10018.62
Nov 11 21:00:00 - 21:59:59	246724	6.4%	68.53	40.2 GB	5.4%	11715.95
Nov 11 22:00:00 - 22:59:59	268119	7.0%	74.48	41.4 GB	5.5%	12047.29
Nov 11 23:00:00 - 23:59:59	256709	6.7%	71.31	41.5 GB	5.5%	12076.51
Nov 12 00:00:00 - 00:59:59	146686	3.8%	40.75	31.5 GB	4.2%	9165.29
Nov 12 01:00:00 - 01:59:59	122584	3.2%	34.05	36.6 GB	4.9%	10650.32
Nov 12 02:00:00 - 02:59:59	122719	3.2%	34.09	37.5 GB	5.0%	10912.40
Nov 12 03:00:00 - 03:59:59	121089	3.2%	33.64	31.6 GB	4.2%	9216.26
Nov 12 04:00:00 - 04:15:03	41188	1.1%	45.61	8.2 GB	1.1%	9500.74
TOTAL: 24:00:00	3834028	100.0%	44.38	748.6 GB	100.0%	9085.71

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	13524	94	8451	7	4972
2	news.nask.pl	10186	23	212	3	9948
3	news.icm.edu.pl	10	0	0	0	10
TOTAL: 3		23720	117	8663	10	14930

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	45
it.tlc.cellulari.android	30
comp.mobile.android	14
it.comp.os.win.windows10	13
comp.mobile.ipad	4
nl.comp.sys.android	3
alt.sex.telephones	3
de.comm.software.mailreader	2
it.comp.os.win.windows7	1
comp.sys.raspberry-pi	1
uk.rec.cycling.moderated	1
TOTAL: 11	117

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

Groups	Count
pl.praca.oferowana	8
comp.sources.acorn	1
bit.listserv.catholic	1
TOTAL: 3	10

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	11272
EMP (md5)	2454
Scoring filter (8)	26
Scoring filter (9)	6
Scoring filter (12)	5
HTML post	4
Scoring filter (10)	3
Too many newsgroups	3
Scoring filter (11)	2
Scoring filter (19)	1
Too many newsgroups (low_xpost)	1
EMP (fsl)	1
Poison newsgroup	1
TOTAL: 13	13779

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.nask.pl	574
	newsfeed.pionier.net.pl	519
	TOTAL: 2	1093
TOTAL: 1		1093

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	24478	1189	9159	272	149	31749	4%	23:59:30
2	icm	23309	807	17605	104	0	0	3%	23:59:57
3	poznan	16129	542	9272	43	2	2	3%	23:59:54
4	nask	3302	5	2398	0	0	0	0%	23:58:04
5	okapi	0	0	0	0	0	990	0%	23:57:50
TOTAL: 5		67218	2543	38434	419	151	32741	3%	119:55:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	141.7 MB	33.4 MB	175.0 MB	2.1 KB/s	196.7 KB	23:59:57
2	panorama	17.3 MB	3.9 MB	21.2 MB	0.3 KB/s	14.8 KB	23:59:30
3	poznan	1.8 MB	183.6 KB	2.0 MB	0.0 KB/s	3.4 KB	23:59:54
4	nask	9.4 KB	0.0 KB	9.4 KB	0.0 KB/s	1.9 KB	23:58:04
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:50
TOTAL: 5		160.7 MB	37.4 MB	198.1 MB	0.5 KB/s	68.5 KB	119:55:15

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	web.man.lodz.pl	288	40	52.7 KB	18	0	00:00:25
2	user-94-254-149-208.play-internet.pl	5	13	18.3 KB	1	0	00:33:23
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		294	53	71.0 KB	19	1	00:33:55

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	673	40	52.7 KB	18	1	00:00:31
2	*.play-internet.pl	5	13	18.3 KB	1	0	00:33:23
TOTAL: 2		678	53	71.0 KB	19	1	00:33:55

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
user-94-254-149-208.play-internet.pl	0.292	0.144	00:33:23
web.man.lodz.pl	1.596	6.012	00:00:25
mon.man.lodz.pl	1.196	4.788	00:00:04
david.man.lodz.pl	0.452	1.644	00:00:01
isvcs01.man.lodz.pl	0.004	0.024	00:00:00
TOTAL: 5	3.540	12.612	00:33:55

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	40	75.5%
2	lodman	13	24.5%
TOTAL: 2		53	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	20
2	pl.comp.os.ms-windows.winnt	20
3	lodman.info	13
TOTAL: 3		53

Daily Usenet report

Nov 11 04:15:03 -- Nov 12 04:15:03