Daily Usenet report: Oct 18 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Oct 18 07:49:28 newsfeed overchan[26099]: input line too long, skipping
Oct 18 15:51:08 newsfeed overchan[26099]: input line too long, skipping
Oct 18 16:09:32 newsfeed nnrpd[6997]: SERVER perl filter not defined
Oct 18 19:11:44 newsfeed overchan[26099]: input line too long, skipping
Oct 18 19:37:50 newsfeed overchan[26099]: input line too long, skipping
Oct 18 20:36:12 newsfeed overchan[26099]: input line too long, skipping
Oct 18 21:36:00 newsfeed overchan[26099]: input line too long, skipping
Oct 18 21:37:33 newsfeed overchan[26099]: input line too long, skipping
Oct 18 21:47:25 newsfeed overchan[26099]: input line too long, skipping
Oct 19 01:11:14 newsfeed overchan[26099]: input line too long, skipping
Oct 19 01:12:29 newsfeed overchan[26099]: input line too long, skipping
Oct 19 03:59:14 newsfeed overchan[26099]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	683234	91.9%	74.5 MB	91.0%
innfeed	46220	6.2%	5.4 MB	6.6%
innd	9333	1.3%	1.4 MB	1.8%
nnrpd	4861	0.7%	483.7 KB	0.6%
overchan	12	0.0%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	743661	100.0%	81.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	679923	99.5%
Negative hits	3117	0.5%
Positive hits	264	0.0%
Cache misses	27	0.0%
TOTAL: 4	683331	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.816	0.0%	79	0.000	10.329	126.000
article cleanup	00:00:12.923	0.0%	682760	0.012	0.019	0.026
article logging	00:00:34.927	0.0%	683220	0.038	0.051	0.063
article parse	00:27:25.881	1.9%	75350627	0.012	0.022	0.030
article write	00:09:08.472	0.6%	682500	0.249	0.804	1.098
artlog/artcncl	00:00:00.003	0.0%	79	0.000	0.038	1.000
data move	00:01:00.967	0.1%	80578094	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.372	0.0%	78	0.000	4.769	42.000
hishave/artcncl	00:00:00.016	0.0%	79	0.000	0.203	3.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:10:51.130	0.8%	686070	0.201	0.949	5.400
history sync	00:00:00.028	0.0%	290	0.000	0.097	0.500
history write	00:43:56.396	3.1%	682736	0.643	3.862	15.157
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	19:45:58.582	82.4%	74346950	0.515	0.957	2.098
nntp read	00:52:52.718	3.7%	74938734	0.028	0.042	0.051
overview write	00:00:03.975	0.0%	682500	0.003	0.006	0.009
perl filter	01:20:53.982	5.6%	682736	3.901	7.110	9.317
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:38.958	0.0%	1377933	0.023	0.028	0.034
TOTAL: 24:00:03.459	23:33:40.146	98.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.153	0.0%	48672	0.000	0.003	0.017
article prepare	00:00:00.004	0.0%	5972	0.000	0.001	0.025
article read	00:00:09.536	0.0%	1491	0.000	6.396	29.429
backlog stats	00:00:00.093	0.0%	113511	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:01.032	0.0%	55247	0.000	0.019	0.049
data write	00:00:02.605	0.0%	42461	0.016	0.061	0.095
idle	23:52:17.129	99.9%	113511	494.287	757.082	1420.347
status file	00:01:00.592	0.1%	16805	0.833	3.606	188.264
TOTAL: 23:53:37.223	23:53:31.144	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:38.339	82.3%	3419	0.000	28.763	5046.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.373	0.3%	7644	0.000	0.049	5.333
readart	00:00:00.009	0.0%	44	0.000	0.205	2.000
TOTAL: 00:01:59.442	00:01:38.721	82.7%	-	-	-	-

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	179	682400	682199	0	201	99%	85:43:03
2	news.icm.edu.pl	42	286	44	182	60	15%	16:44:26
3	localhost	1442	1	1	0	0	100%	00:00:00
TOTAL: 3		1663	682687	682244	182	261	99%	102:27:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	310.7 GB	1.2 MB	1.6 MB	310.7 GB	99%	477.5 KB
2	news.icm.edu.pl	1.1 MB	109.9 KB	1.8 MB	3.1 MB	37%	30.6 KB
3	localhost	1.7 KB	0.0 KB	0.0 KB	1.7 KB	100%	1.7 KB
TOTAL: 3		310.7 GB	1.3 MB	3.5 MB	310.7 GB	99%	477.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 18 04:15:02 - 04:59:59	16789	2.5%	6.22	8.6 GB	2.8%	3356.89
Oct 18 05:00:00 - 05:59:59	23829	3.5%	6.62	13.5 GB	4.3%	3923.52
Oct 18 06:00:00 - 06:59:59	23016	3.4%	6.39	12.7 GB	4.1%	3699.22
Oct 18 07:00:00 - 07:59:59	23480	3.4%	6.52	13.0 GB	4.2%	3786.37
Oct 18 08:00:00 - 08:59:59	24564	3.6%	6.82	12.7 GB	4.1%	3687.55
Oct 18 09:00:00 - 09:59:59	25784	3.8%	7.16	13.1 GB	4.2%	3816.82
Oct 18 10:00:00 - 10:59:59	26680	3.9%	7.41	12.8 GB	4.1%	3726.40
Oct 18 11:00:00 - 11:59:59	24474	3.6%	6.80	12.4 GB	4.0%	3597.35
Oct 18 12:00:00 - 12:59:59	27157	4.0%	7.54	13.8 GB	4.4%	4021.02
Oct 18 13:00:00 - 13:59:59	30498	4.5%	8.47	14.6 GB	4.7%	4253.83
Oct 18 14:00:00 - 14:59:59	24578	3.6%	6.83	12.7 GB	4.1%	3708.10
Oct 18 15:00:00 - 15:59:59	23734	3.5%	6.59	11.8 GB	3.8%	3428.91
Oct 18 16:00:00 - 16:59:59	101108	14.8%	28.09	15.6 GB	5.0%	4555.86
Oct 18 17:00:00 - 17:59:59	29112	4.3%	8.09	12.7 GB	4.1%	3689.61
Oct 18 18:00:00 - 18:59:59	27611	4.0%	7.67	13.8 GB	4.4%	4025.52
Oct 18 19:00:00 - 19:59:59	26088	3.8%	7.25	13.7 GB	4.4%	4004.08
Oct 18 20:00:00 - 20:59:59	24666	3.6%	6.85	12.6 GB	4.0%	3655.82
Oct 18 21:00:00 - 21:59:59	27389	4.0%	7.61	13.3 GB	4.3%	3867.41
Oct 18 22:00:00 - 22:59:59	25778	3.8%	7.16	13.1 GB	4.2%	3828.92
Oct 18 23:00:00 - 23:59:59	25178	3.7%	6.99	12.5 GB	4.0%	3641.99
Oct 19 00:00:00 - 00:59:59	24940	3.7%	6.93	11.8 GB	3.8%	3444.40
Oct 19 01:00:00 - 01:59:59	22760	3.3%	6.32	12.0 GB	3.9%	3505.03
Oct 19 02:00:00 - 02:59:59	24911	3.7%	6.92	12.9 GB	4.1%	3762.34
Oct 19 03:00:00 - 03:59:59	22084	3.2%	6.13	12.1 GB	3.9%	3528.37
Oct 19 04:00:00 - 04:15:01	6220	0.9%	6.90	3.6 GB	1.2%	4181.28
TOTAL: 23:59:59	682428	100.0%	7.90	311.5 GB	100.0%	3780.07

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	661	176	23	2	460
2	news.icm.edu.pl	61	0	3	0	58
TOTAL: 2		722	176	26	2	518

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	98
it.tlc.cellulari.android	33
comp.sys.raspberry-pi	18
comp.mobile.android	14
it.comp.os.win.windows10	10
it.comp.os.win.windows7	3
TOTAL: 6	176

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

Groups	Count
pl.sci.matematyka	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	54
Binary in non-binary group	4
TOTAL: 2	58

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	460
	TOTAL: 1	460
TOTAL: 1		460

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	19726	524	12276	30	0	0	2%	23:59:55
2	panorama	39565	369	11200	152	4	37194	0%	23:59:41
3	poznan	40	0	34	0	0	0	0%	03:10:34
4	nask	0	0	0	0	0	8826	0%	23:57:45
5	okapi	0	0	0	0	0	1135	0%	23:57:45
TOTAL: 5		59331	893	23510	182	4	47155	1%	99:05:40

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	1.6 MB	92.6 KB	1.7 MB	3.2 KB	23:59:55
2	panorama	1.0 MB	707.3 KB	1.7 MB	3.4 KB	23:59:41
3	poznan	0.0 KB	0.0 KB	0.0 KB	0	03:10:34
4	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:45
5	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:45
TOTAL: 5		2.7 MB	799.9 KB	3.4 MB	3.3 KB	99:05:40

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	289	42	42.5 KB	20	0	00:00:21
2	109.63.165.59	7	1	1.7 KB	1	0	00:01:01
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		297	43	44.2 KB	21	1	00:01:59

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	578	42	42.5 KB	20	1	00:00:30
2	unresolved	107	1	1.7 KB	1	0	00:01:06
3	*.versanet.de	190	0	0.0 KB	0	0	00:00:10
4	*.20.97.83.ro.ovo.sc	1	0	0.0 KB	0	0	00:00:11
TOTAL: 4		876	43	44.2 KB	21	1	00:01:59

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
109.63.165.59	0.059	0.106	00:01:01
web.man.lodz.pl	1.995	4.500	00:00:21
35.20.97.83.ro.ovo.sc	0.003	0.010	00:00:11
i5c742bd9.versanet.de	0.873	1.758	00:00:10
mon.man.lodz.pl	2.679	5.728	00:00:08
80.111.142.213	0.024	0.046	00:00:03
212.51.192.185	0.530	0.965	00:00:01
isvcs01.man.lodz.pl	0.010	0.021	00:00:00
TOTAL: 8	6.173	13.134	00:01:59

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
i5c742bd9.versanet.de	190
212.51.192.185	96
80.111.142.213	4
35.20.97.83.ro.ovo.sc	1
TOTAL: 5	579

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	42	97.7%
2	lodman	1	2.3%
TOTAL: 2		43	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	24
2	pl.comp.os.ms-windows.winnt	16
3	pl.rec.mineraly	2
4	lodman.info	1
TOTAL: 4		43

Daily Usenet report

Oct 18 04:15:02 -- Oct 19 04:15:01