Daily Usenet report: Nov 27 04:15:02

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Nov 27 06:39:41 newsfeed overchan[13226]: input line too long, skipping
Nov 27 10:13:23 newsfeed nnrpd[4183]: SERVER perl filter not defined
Nov 27 15:14:23 newsfeed nnrpd[18408]: SERVER perl filter not defined
Nov 27 15:35:56 newsfeed overchan[13226]: input line too long, skipping
Nov 27 16:01:07 newsfeed overchan[13226]: input line too long, skipping
Nov 27 16:35:51 newsfeed nnrpd[30963]: SERVER perl filter not defined
Nov 27 17:08:55 newsfeed overchan[13226]: input line too long, skipping
Nov 27 18:07:03 newsfeed overchan[13226]: input line too long, skipping
Nov 27 18:43:29 newsfeed overchan[13226]: input line too long, skipping
Nov 27 18:58:46 newsfeed nnrpd[20420]: SERVER perl filter not defined
Nov 27 19:23:34 newsfeed overchan[13226]: input line too long, skipping
Nov 27 20:11:56 newsfeed nnrpd[31743]: SERVER perl filter not defined
Nov 27 21:46:54 newsfeed nnrpd[13839]: SERVER perl filter not defined
Nov 27 21:47:16 newsfeed nnrpd[13945]: SERVER perl filter not defined
Nov 27 21:47:26 newsfeed nnrpd[13951]: SERVER perl filter not defined
Nov 27 21:48:54 newsfeed nnrpd[14085]: SERVER perl filter not defined
Nov 27 22:53:17 newsfeed overchan[13226]: input line too long, skipping
Nov 28 01:01:23 newsfeed overchan[13226]: input line too long, skipping
Nov 28 02:18:23 newsfeed overchan[13226]: input line too long, skipping
Nov 28 02:41:01 newsfeed overchan[13226]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	592535	90.3%	65.1 MB	89.3%
innfeed	50602	7.7%	6.0 MB	8.2%
innd	8695	1.3%	1.4 MB	1.9%
nnrpd	4239	0.6%	428.0 KB	0.6%
overchan	12	0.0%	2.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	656084	100.0%	72.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	586794	99.7%
Negative hits	1836	0.3%
Positive hits	187	0.0%
Cache misses	27	0.0%
TOTAL: 4	588844	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.420	0.0%	60	0.000	23.667	147.000
article cleanup	00:00:08.884	0.0%	592538	0.009	0.015	0.021
article logging	00:00:30.116	0.0%	592959	0.038	0.051	0.063
article parse	00:17:08.192	1.2%	69185034	0.010	0.015	0.018
article write	00:07:01.360	0.5%	592278	0.384	0.711	1.006
artlog/artcncl	00:00:00.001	0.0%	59	0.000	0.017	0.100
data move	00:00:51.914	0.1%	73530915	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.261	0.0%	57	0.000	4.579	23.000
hishave/artcncl	00:00:00.019	0.0%	60	0.000	0.317	3.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:04:54.197	0.3%	594821	0.285	0.495	4.532
history sync	00:00:00.021	0.0%	290	0.000	0.072	1.000
history write	00:22:56.758	1.6%	592524	0.414	2.324	16.248
hiswrite/artcncl	00:00:00.001	0.0%	3	0.333	0.333	0.333
idle	21:04:08.792	87.8%	68974087	0.713	1.100	1.565
nntp read	00:39:01.888	2.7%	68925235	0.024	0.034	0.039
overview write	00:00:03.591	0.0%	592278	0.003	0.006	0.009
perl filter	01:02:53.724	4.4%	592524	3.500	6.369	7.954
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:33.889	0.0%	1198051	0.020	0.028	0.035
TOTAL: 24:00:06.706	23:40:15.028	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.134	0.0%	52336	0.000	0.003	0.012
article prepare	00:00:00.000	0.0%	5732	0.000	0.000	0.000
article read	00:00:14.405	0.0%	1427	0.000	10.095	132.000
backlog stats	00:00:00.130	0.0%	119755	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.106	0.0%	57816	0.004	0.019	0.040
data write	00:00:02.805	0.0%	44401	0.022	0.063	0.109
idle	23:53:01.678	99.9%	119755	364.364	717.980	1150.278
status file	00:00:56.378	0.1%	16920	0.713	3.332	181.248
TOTAL: 23:54:24.028	23:54:16.636	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:20.550	59.4%	3113	0.000	6.601	195.833
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.251	0.7%	6842	0.000	0.037	0.947
readart	00:00:00.002	0.0%	42	0.000	0.048	0.500
TOTAL: 00:00:34.604	00:00:20.803	60.1%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	132	591797	591554	0	243	99%	78:58:16
2	news.icm.edu.pl	55	170	17	137	16	10%	14:09:30
3	localhost	1450	9	9	0	0	100%	00:00:00
TOTAL: 3		1637	591976	591580	137	259	99%	93:07:46

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	256.5 GB	600.3 KB	1.2 MB	256.5 GB	99%	454.5 KB
2	news.icm.edu.pl	603.2 KB	9.0 KB	511.5 KB	1.1 MB	53%	34.1 KB
3	localhost	14.6 KB	0.0 KB	0.0 KB	14.6 KB	100%	1.6 KB
TOTAL: 3		256.5 GB	609.3 KB	1.7 MB	256.5 GB	99%	454.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 27 04:15:02 - 04:59:59	15563	2.6%	5.77	7.7 GB	3.0%	2985.45
Nov 27 05:00:00 - 05:59:59	20654	3.5%	5.74	11.4 GB	4.4%	3319.22
Nov 27 06:00:00 - 06:59:59	19715	3.3%	5.48	10.4 GB	4.0%	3023.31
Nov 27 07:00:00 - 07:59:59	20097	3.4%	5.58	10.1 GB	3.9%	2935.69
Nov 27 08:00:00 - 08:59:59	19877	3.4%	5.52	10.0 GB	3.9%	2905.71
Nov 27 09:00:00 - 09:59:59	22621	3.8%	6.28	11.2 GB	4.4%	3273.96
Nov 27 10:00:00 - 10:59:59	25511	4.3%	7.09	9.6 GB	3.7%	2804.47
Nov 27 11:00:00 - 11:59:59	21319	3.6%	5.92	9.6 GB	3.7%	2796.82
Nov 27 12:00:00 - 12:59:59	19086	3.2%	5.30	9.6 GB	3.7%	2797.30
Nov 27 13:00:00 - 13:59:59	20912	3.5%	5.81	9.4 GB	3.7%	2740.79
Nov 27 14:00:00 - 14:59:59	21402	3.6%	5.95	10.1 GB	3.9%	2929.10
Nov 27 15:00:00 - 15:59:59	20914	3.5%	5.81	10.3 GB	4.0%	3002.59
Nov 27 16:00:00 - 16:59:59	21958	3.7%	6.10	10.7 GB	4.2%	3127.84
Nov 27 17:00:00 - 17:59:59	22920	3.9%	6.37	11.0 GB	4.3%	3197.29
Nov 27 18:00:00 - 18:59:59	28588	4.8%	7.94	11.2 GB	4.4%	3265.61
Nov 27 19:00:00 - 19:59:59	27073	4.6%	7.52	11.5 GB	4.5%	3348.86
Nov 27 20:00:00 - 20:59:59	24541	4.1%	6.82	11.3 GB	4.4%	3288.65
Nov 27 21:00:00 - 21:59:59	29498	5.0%	8.19	12.0 GB	4.7%	3495.35
Nov 27 22:00:00 - 22:59:59	34056	5.8%	9.46	11.7 GB	4.5%	3407.11
Nov 27 23:00:00 - 23:59:59	30897	5.2%	8.58	11.6 GB	4.5%	3364.59
Nov 28 00:00:00 - 00:59:59	30132	5.1%	8.37	11.8 GB	4.6%	3432.42
Nov 28 01:00:00 - 01:59:59	28099	4.7%	7.81	11.3 GB	4.4%	3289.18
Nov 28 02:00:00 - 02:59:59	29282	4.9%	8.13	10.9 GB	4.2%	3180.88
Nov 28 03:00:00 - 03:59:59	29775	5.0%	8.27	10.4 GB	4.1%	3039.94
Nov 28 04:00:00 - 04:15:02	7306	1.2%	8.10	2.5 GB	1.0%	2924.28
TOTAL: 24:00:00	591796	100.0%	6.85	257.3 GB	100.0%	3122.37

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	662	218	13	10	421
2	news.icm.edu.pl	18	0	1	0	17
TOTAL: 2		680	218	14	10	438

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	149
it.comp.os.win.windows10	28
it.tlc.cellulari.android	15
comp.sys.raspberry-pi	10
comp.mobile.ipad	7
comp.mobile.android	4
it.comp.os.win.windows7	2
it.discussioni.energia	1
de.comp.lang.vbclassic	1
it.comp.os.linux.ubuntu	1
TOTAL: 10	218

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

Groups	Count
pl.praca.oferowana	10
TOTAL: 1	10

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14
Binary in non-binary group	3
Too many newsgroups	1
TOTAL: 3	18

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	419
	news.icm.edu.pl	1
	TOTAL: 2	420
TOTAL: 1		420

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	21746	473	12777	21	215	2%	23:57:26
2	panorama	40073	297	11594	143	40315	0%	24:00:18
3	poznan	23	0	21	0	0	0%	02:14:36
4	okapi	0	0	0	0	976	0%	23:57:48
5	nask	0	0	0	0	8513	0%	23:57:49
TOTAL: 5		61842	770	24392	164	50019	1%	98:07:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	1.4 MB	69.0 KB	1.4 MB	0.0 KB/s	3.0 KB	23:57:26
2	panorama	1011.6 KB	4.3 MB	5.3 MB	0.1 KB/s	12.3 KB	24:00:18
3	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	02:14:36
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:48
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:49
TOTAL: 5		2.3 MB	4.3 MB	6.7 MB	0.0 KB/s	7.3 KB	98:07:57

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	42	32.9 KB	18	0	00:00:22
2	isvcs01.man.lodz.pl	9	0	0.0 KB	0	9	00:00:00
TOTAL: 2		297	42	32.9 KB	18	9	00:00:34

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	585	42	32.9 KB	18	9	00:00:27
2	unresolved	99	0	0.0 KB	0	0	00:00:07
TOTAL: 2		684	42	32.9 KB	18	9	00:00:34

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.505	3.555	00:00:22
80.111.142.213	0.032	0.040	00:00:04
mon.man.lodz.pl	1.441	3.124	00:00:03
212.51.192.185	0.469	0.922	00:00:02
isvcs01.man.lodz.pl	0.073	0.174	00:00:00
TOTAL: 5	3.520	7.815	00:00:34

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	95
80.111.142.213	4
TOTAL: 3	387

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Nov 27 04:15:02 -- Nov 28 04:15:02