Daily Usenet report: Jan 9 04:15:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jan 9 12:58:09 newsfeed overchan[12244]: input line too long, skipping
Jan 9 13:23:00 newsfeed nnrpd[31187]: SERVER perl filter not defined
Jan 9 13:26:20 newsfeed overchan[12244]: input line too long, skipping
Jan 9 16:31:30 newsfeed overchan[12244]: input line too long, skipping
Jan 9 17:07:48 newsfeed nnrpd[6526]: SERVER perl filter not defined
Jan 9 18:19:51 newsfeed nnrpd[17542]: SERVER perl filter not defined
Jan 9 18:20:34 newsfeed nnrpd[17588]: SERVER perl filter not defined
Jan 9 22:58:18 newsfeed overchan[1197]: input line too long, skipping
Jan 10 00:01:08 newsfeed overchan[1197]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1998444	97.7%	233.6 MB	97.4%
innfeed	27003	1.3%	3.2 MB	1.3%
innd	14722	0.7%	2.3 MB	1.0%
nnrpd	5785	0.3%	611.3 KB	0.2%
overchan	7	0.0%	1.1 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	2045963	100.0%	239.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1981769	98.2%
Negative hits	31307	1.6%
Positive hits	4655	0.2%
Cache misses	36	0.0%
TOTAL: 4	2017767	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.864	0.0%	57	0.000	32.702	89.667
article cleanup	00:00:29.399	0.0%	1992718	0.011	0.015	0.021
article logging	00:01:34.330	0.1%	1993220	0.036	0.047	0.067
article parse	00:32:45.172	2.3%	72031738	0.018	0.027	0.040
article write	00:12:05.685	0.8%	1989438	0.189	0.365	0.551
artlog/artcncl	00:00:00.000	0.0%	57	0.000	0.000	0.000
data move	00:01:25.375	0.1%	82433181	0.001	0.001	0.002
hisgrep/artcncl	00:00:00.910	0.0%	46	0.000	19.783	77.100
hishave/artcncl	00:00:00.024	0.0%	57	0.000	0.421	14.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:49:12.805	3.4%	2026655	0.090	1.457	6.368
history sync	00:00:00.021	0.0%	290	0.000	0.072	1.000
history write	01:21:53.217	5.7%	1990573	0.689	2.468	12.422
hiswrite/artcncl	00:00:00.009	0.0%	11	0.000	0.818	5.000
idle	16:29:24.333	68.7%	58136275	0.587	1.021	3.053
nntp read	00:55:04.284	3.8%	70328202	0.036	0.047	0.064
overview write	00:00:10.711	0.0%	1989438	0.004	0.005	0.008
perl filter	03:11:30.822	13.3%	1990573	3.920	5.773	7.264
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:32.426	0.3%	3992593	0.053	0.068	0.084
TOTAL: 24:00:01.628	23:40:11.387	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.127	0.0%	37038	0.000	0.003	0.110
article prepare	00:00:00.013	0.0%	37840	0.000	0.000	0.010
article read	00:01:59.552	0.1%	9006	0.049	13.275	87.671
backlog stats	00:00:00.090	0.0%	114477	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	3	0.000	0.000	0.000
data read	00:00:01.466	0.0%	63768	0.006	0.023	0.127
data write	00:00:03.257	0.0%	50199	0.027	0.065	0.147
idle	23:53:40.550	99.8%	114477	225.311	751.422	1494.769
status file	00:00:14.229	0.0%	10560	0.633	1.347	97.438
TOTAL: 23:56:12.914	23:55:59.284	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:43.363	83.8%	3505	0.000	29.490	12978.800
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.434	0.4%	8283	0.000	0.052	4.333
readart	00:00:00.028	0.0%	166	0.000	0.169	6.500
TOTAL: 00:02:03.342	00:01:43.825	84.2%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
mode	150
name	3
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	195

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	748	1987218	1986428	63	727	99%	238:02:51
2	news.nask.pl	2	12045	7287	2227	2531	60%	23:48:16
3	news.icm.edu.pl	37	257	57	196	4	22%	17:06:25
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		792	1999524	1993776	2486	3262	99%	278:57:32

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	455.7 GB	8.6 MB	8.8 MB	455.7 GB	99%	240.5 KB
2	news.nask.pl	32.9 MB	7.8 MB	18.7 MB	59.3 MB	55%	6.2 KB
3	news.icm.edu.pl	1.5 MB	25.4 KB	109.4 KB	1.6 MB	91%	27.0 KB
4	localhost	6.1 KB	0.0 KB	0.0 KB	6.1 KB	100%	1.5 KB
TOTAL: 4		455.7 GB	16.4 MB	27.6 MB	455.7 GB	99%	239.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 9 04:15:02 - 04:59:59	38809	1.9%	14.38	11.1 GB	2.4%	4319.59
Jan 9 05:00:00 - 05:59:59	57774	2.9%	16.05	16.4 GB	3.6%	4768.06
Jan 9 06:00:00 - 06:59:59	44602	2.2%	12.39	13.1 GB	2.9%	3815.98
Jan 9 07:00:00 - 07:59:59	64869	3.3%	18.02	16.9 GB	3.7%	4932.16
Jan 9 08:00:00 - 08:59:59	67650	3.4%	18.79	20.3 GB	4.5%	5923.42
Jan 9 09:00:00 - 09:59:59	135367	6.8%	37.60	20.6 GB	4.5%	5999.45
Jan 9 10:00:00 - 10:59:59	58306	2.9%	16.20	11.5 GB	2.5%	3337.02
Jan 9 11:00:00 - 11:59:59	68358	3.4%	18.99	21.4 GB	4.7%	6221.52
Jan 9 12:00:00 - 12:59:59	97250	4.9%	27.01	24.8 GB	5.4%	7226.46
Jan 9 13:00:00 - 13:59:59	92081	4.6%	25.58	21.4 GB	4.7%	6233.03
Jan 9 14:00:00 - 14:59:59	150148	7.5%	41.71	21.1 GB	4.6%	6152.42
Jan 9 15:00:00 - 15:59:59	119421	6.0%	33.17	17.5 GB	3.8%	5108.69
Jan 9 16:00:00 - 16:59:59	70455	3.5%	19.57	18.4 GB	4.0%	5354.59
Jan 9 17:00:00 - 17:59:59	100582	5.0%	27.94	20.7 GB	4.5%	6023.53
Jan 9 18:00:00 - 18:59:59	57624	2.9%	16.01	13.1 GB	2.9%	3821.45
Jan 9 19:00:00 - 19:59:59	110738	5.6%	30.76	23.9 GB	5.2%	6963.19
Jan 9 20:00:00 - 20:59:59	98316	4.9%	27.31	21.2 GB	4.6%	6173.61
Jan 9 21:00:00 - 21:59:59	93312	4.7%	25.92	21.4 GB	4.7%	6226.89
Jan 9 22:00:00 - 22:59:59	78589	3.9%	21.83	20.8 GB	4.6%	6065.83
Jan 9 23:00:00 - 23:59:59	92936	4.7%	25.82	24.0 GB	5.3%	6986.00
Jan 10 00:00:00 - 00:59:59	56440	2.8%	15.68	14.8 GB	3.2%	4315.43
Jan 10 01:00:00 - 01:59:59	88501	4.4%	24.58	24.3 GB	5.3%	7078.76
Jan 10 02:00:00 - 02:59:59	89440	4.5%	24.84	22.1 GB	4.8%	6435.59
Jan 10 03:00:00 - 03:59:59	43939	2.2%	12.21	10.2 GB	2.2%	2976.81
Jan 10 04:00:00 - 04:15:01	19098	1.0%	21.20	5.0 GB	1.1%	5781.35
TOTAL: 23:59:59	1994605	100.0%	23.09	456.0 GB	100.0%	5534.40

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nask.pl	2567	31	1483	3	1050
2	newsfeed.pionier.net.pl	1213	69	656	2	486
3	news.icm.edu.pl	4	0	2	0	2
TOTAL: 3		3784	100	2141	5	1538

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	55
comp.sys.raspberry-pi	21
comp.mobile.android	13
it.tlc.cellulari.android	4
it.comp.os.win.windows10	2
comp.mobile.ipad	1
de.comp.lang.vbclassic	1
it.comp.virtualizzazione	1
nl.comp.os.linux.techniek	1
alt.fr.rec.tv.internet	1
TOTAL: 10	100

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

Groups	Count
pl.praca.oferowana	3
bit.listserv.catholic	1
pl.sci.matematyka	1
TOTAL: 3	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	911
Binary in non-binary group	72
Too many newsgroups	14
Scoring filter (8)	14
EMP (phl)	11
Scoring filter (16)	6
Scoring filter (9)	3
Scoring filter (18)	3
Scoring filter (13)	2
TOTAL: 9	1036

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	486
	news.nask.pl	16
	TOTAL: 2	502
TOTAL: 1		502

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	32770	5534	9104	661	10	21790	16%	23:59:07
2	icm	15933	75	13400	4	0	0	0%	23:58:43
3	poznan	7949	14	7411	1	0	0	0%	23:55:04
4	nask	3796	2	3271	0	0	0	0%	24:04:09
5	okapi	0	0	0	0	0	1399	0%	23:52:55
TOTAL: 5		60448	5625	33186	666	10	23189	9%	119:49:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	19.1 MB	2.6 MB	21.7 MB	0.3 KB/s	3.6 KB	23:59:07
2	icm	268.2 KB	63.5 KB	331.7 KB	0.0 KB/s	4.2 KB	23:58:43
3	poznan	83.5 KB	40.0 KB	123.5 KB	0.0 KB/s	8.2 KB	23:55:04
4	nask	3.2 KB	0.0 KB	3.2 KB	0.0 KB/s	1.6 KB	24:04:09
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:52:55
TOTAL: 5		19.4 MB	2.7 MB	22.2 MB	0.1 KB/s	3.6 KB	119:49:58

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	287	166	161.0 KB	69	0	00:00:19
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 2		291	166	161.0 KB	69	4	00:02:02

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	579	166	161.0 KB	69	4	00:00:27
2	unresolved	96	0	0.0 KB	0	0	00:00:01
3	*.versanet.de	190	0	0.0 KB	0	0	00:00:12
4	*.finemedia.pl	14	0	0.0 KB	0	0	00:00:15
5	*.toya.net.pl	1	0	0.0 KB	0	0	00:01:05
TOTAL: 5		880	166	161.0 KB	69	4	00:02:02

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
staticline58082.toya.net.pl	0.008	0.000	00:01:05
web.man.lodz.pl	1.632	4.636	00:00:19
host-188-122-1-13.finemedia.pl	0.400	0.160	00:00:15
i59f67ebc.versanet.de	0.684	1.304	00:00:12
mon.man.lodz.pl	2.176	6.340	00:00:07
212.51.192.185	0.448	1.388	00:00:01
isvcs01.man.lodz.pl	0.060	0.056	00:00:00
TOTAL: 7	5.408	13.884	00:02:02

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
i59f67ebc.versanet.de	190
212.51.192.185	96
host-188-122-1-13.finemedia.pl	14
staticline58082.toya.net.pl	1
TOTAL: 5	589

NNRP unrecognized commands (by host):

System	Conn
host-188-122-1-13.finemedia.pl	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
lidt	1
TOTAL: 1	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	144
2	pl.comp.pecet	22
TOTAL: 2		166

Daily Usenet report

Jan 9 04:15:02 -- Jan 10 04:15:01