Daily Usenet report: Oct 6 04:15:01

Unknown entries from news log file:

First 23 / 23 lines (100.0%)

Oct 6 08:43:03 newsfeed nnrpd[1046562]: SERVER perl filter not defined
Oct 6 08:45:13 newsfeed nnrpd[1046679]: SERVER perl filter not defined
Oct 6 08:48:38 newsfeed nnrpd[1046851]: SERVER perl filter not defined
Oct 6 08:50:23 newsfeed nnrpd[1046968]: SERVER perl filter not defined
Oct 6 09:33:10 newsfeed overchan[1032429]: input line too long, skipping
Oct 6 09:55:16 newsfeed nnrpd[1049739]: SERVER perl filter not defined
Oct 6 12:26:20 newsfeed innfeed[1445]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Oct 6 12:26:20 newsfeed innfeed[1445]: SM: storage method 'cnfs' failed initialization
Oct 6 12:26:20 newsfeed innfeed[1445]: SM: one or more storage methods failed initialization
Oct 6 12:26:20 newsfeed innfeed[1445]: Storage manager initialization failed -- it is OK after a change in storage methods
Oct 6 12:26:20 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Oct 6 12:26:20 newsfeed innd: SM: storage method 'cnfs' failed initialization
Oct 6 12:26:20 newsfeed innd: SM: one or more storage methods failed initialization
Oct 6 12:58:42 newsfeed overchan[1446]: input line too long, skipping
Oct 6 12:58:59 newsfeed overchan[1446]: input line too long, skipping
Oct 6 14:21:59 newsfeed overchan[1446]: input line too long, skipping
Oct 6 14:27:06 newsfeed overchan[1446]: input line too long, skipping
Oct 6 16:00:13 newsfeed nnrpd[10968]: SERVER perl filter not defined
Oct 6 16:36:55 newsfeed nnrpd[12567]: SERVER perl filter not defined
Oct 6 17:45:46 newsfeed nnrpd[15518]: SERVER perl filter not defined
Oct 6 18:15:17 newsfeed nnrpd[16817]: SERVER perl filter not defined
Oct 6 21:42:18 newsfeed overchan[1446]: input line too long, skipping
Oct 7 02:15:02 newsfeed overchan[1446]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	8281	33.5%	1.0 MB	36.1%
innd	8252	33.4%	1001.2 KB	35.2%
nnrpd	6820	27.6%	675.6 KB	23.8%
innfeed	1336	5.4%	137.9 KB	4.9%
overchan	9	0.0%	1.0 KB	0.0%
controlchan	3	0.0%	0.2 KB	0.0%
TOTAL: 6	24701	100.0%	2.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	8240	50.0%
Negative hits	8240	50.0%
Cache misses	1	0.0%
Positive hits	0	0.0%
TOTAL: 4	16481	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.045	0.0%	1	45.000	45.000	45.000
article cleanup	00:00:00.071	0.0%	8261	0.000	0.009	0.056
article logging	00:00:00.188	0.0%	8261	0.000	0.023	0.125
article parse	00:00:00.410	0.0%	70083	0.000	0.006	0.020
article write	00:00:03.248	0.0%	836	0.000	3.885	15.667
artlog/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.078	0.0%	61805	0.000	0.001	0.012
hisgrep/artcncl	00:00:00.005	0.0%	1	5.000	5.000	5.000
hishave/artcncl	00:00:00.011	0.0%	1	11.000	11.000	11.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:21.902	0.1%	16522	3.120	4.957	10.838
history sync	00:00:00.016	0.0%	414	0.000	0.039	0.667
history write	00:01:07.414	0.1%	8261	6.146	8.161	19.075
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:38:26.839	99.8%	82483	582.609	1031.811	4882.829
nntp read	00:00:00.779	0.0%	78213	0.000	0.010	0.029
overview write	00:00:00.007	0.0%	836	0.000	0.008	0.500
perl filter	00:00:04.706	0.0%	8261	0.312	0.570	1.474
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.053	0.0%	2499	0.000	0.021	0.333
TOTAL: 23:41:10.752	23:41:05.772	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.002	0.0%	824	0.000	0.002	0.333
article prepare	00:00:00.000	0.0%	0	0.000	0.000	0.000
article read	00:00:00.000	0.0%	0	0.000	0.000	0.000
backlog stats	00:00:00.016	0.0%	5529	0.000	0.003	0.057
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.009	0.0%	834	0.000	0.011	1.000
data write	00:00:00.000	0.0%	292	0.000	0.000	0.000
idle	23:30:31.295	100.0%	5529	7791.818	15306.800	20017.300
status file	00:00:00.178	0.0%	396	0.000	0.449	1.000
TOTAL: 23:30:32.116	23:30:31.500	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:08.923	25.8%	3917	0.000	2.278	70.833
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.115	0.3%	9250	0.000	0.012	0.500
TOTAL: 00:00:34.604	00:00:09.038	26.1%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Reject	%Accpt	Elapsed
1	news.icm.edu.pl	2	8128	810	7318	9%	23:21:54
2	localhost	10	9	9	0	100%	00:00:00
TOTAL: 2		12	8137	819	7318	10%	23:21:54

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.icm.edu.pl	17.6 MB	110.4 MB	128.0 MB	13%	16.1 KB
2	localhost	14.1 KB	0.0 KB	14.1 KB	100%	1.6 KB
TOTAL: 2		17.6 MB	110.4 MB	128.0 MB	13%	16.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 6 04:15:01 - 04:59:59	5	0.6%	0.00	65.8 KB	0.4%	0.02
Oct 6 05:00:00 - 05:59:59	10	1.2%	0.00	124.9 KB	0.7%	0.03
Oct 6 06:00:00 - 06:59:59	8	1.0%	0.00	96.2 KB	0.5%	0.03
Oct 6 07:00:00 - 07:59:59	10	1.2%	0.00	183.3 KB	1.0%	0.05
Oct 6 08:00:00 - 08:59:59	38	4.5%	0.01	637.6 KB	3.5%	0.18
Oct 6 09:00:00 - 09:59:59	51	6.1%	0.01	1.1 MB	6.0%	0.31
Oct 6 10:00:00 - 10:59:59	36	4.3%	0.01	1.1 MB	6.2%	0.31
Oct 6 11:00:00 - 11:59:59	14	1.7%	0.00	275.2 KB	1.5%	0.08
Oct 6 12:00:00 - 12:59:59	26	3.1%	0.01	634.3 KB	3.5%	0.18
Oct 6 13:00:00 - 13:59:59	20	2.4%	0.01	450.7 KB	2.5%	0.13
Oct 6 14:00:00 - 14:59:59	51	6.1%	0.01	1.1 MB	6.2%	0.31
Oct 6 15:00:00 - 15:59:59	32	3.8%	0.01	686.6 KB	3.7%	0.19
Oct 6 16:00:00 - 16:59:59	23	2.7%	0.01	462.5 KB	2.5%	0.13
Oct 6 17:00:00 - 17:59:59	28	3.3%	0.01	719.9 KB	3.9%	0.20
Oct 6 18:00:00 - 18:59:59	17	2.0%	0.00	226.9 KB	1.2%	0.06
Oct 6 19:00:00 - 19:59:59	52	6.2%	0.01	1.2 MB	6.6%	0.34
Oct 6 20:00:00 - 20:59:59	108	12.9%	0.03	2.5 MB	13.7%	0.70
Oct 6 21:00:00 - 21:59:59	31	3.7%	0.01	481.3 KB	2.6%	0.13
Oct 6 22:00:00 - 22:59:59	41	4.9%	0.01	667.3 KB	3.6%	0.19
Oct 6 23:00:00 - 23:59:59	75	8.9%	0.02	1.5 MB	8.6%	0.44
Oct 7 00:00:00 - 00:59:59	71	8.5%	0.02	1.6 MB	8.9%	0.45
Oct 7 01:00:00 - 01:59:59	29	3.5%	0.01	823.2 KB	4.5%	0.23
Oct 7 02:00:00 - 02:59:59	22	2.6%	0.01	997.6 KB	5.4%	0.28
Oct 7 03:00:00 - 03:59:59	33	3.9%	0.01	404.6 KB	2.2%	0.11
Oct 7 04:00:00 - 04:15:01	8	1.0%	0.01	120.5 KB	0.7%	0.13
TOTAL: 24:00:00	839	100.0%	0.01	17.9 MB	100.0%	0.21

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	news.icm.edu.pl	7441	1	0	0	0	0	0	0	7440
TOTAL: 1		7441	1	0	0	0	0	0	0	7440

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.android	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	7412
Scoring filter (8)	20
Scoring filter (9)	8
TOTAL: 3	7440

Outgoing Feeds (innfeed) by Articles:

Server		Spool	%Took	Elapsed
1	icm	0	0%	00:20:00
2	nask	827	0%	23:32:05
3	okapi	6	0%	23:32:05
4	panorama	827	0%	23:32:05
5	poznan	827	0%	23:34:16
TOTAL: 5		2487	0%	94:30:31

Outgoing Feeds (innfeed) by Volume:

Server		Elapsed
1	icm	00:20:00
2	nask	23:32:05
3	okapi	23:32:05
4	panorama	23:32:05
5	poznan	23:34:16
TOTAL: 5		94:30:31

NNRP readership statistics:

System		Conn	Post	Elapsed
1	nms1.man.lodz.pl	1172	0	00:00:12
2	194.165.16.76	1	0	00:00:10
3	80.111.142.213	4	0	00:00:02
4	212.51.192.185	95	0	00:00:01
5	isvcs01.man.lodz.pl	9	9	00:00:00
6	web.man.lodz.pl	284	0	00:00:08
TOTAL: 6		1565	9	00:00:34

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	unresolved	100	0	00:00:13
2	*.man.lodz.pl	1465	9	00:00:21
TOTAL: 2		1565	9	00:00:34

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms1.man.lodz.pl	3.677	5.188	00:00:12
194.165.16.76	0.001	0.005	00:00:10
web.man.lodz.pl	0.923	1.207	00:00:08
80.111.142.213	0.016	0.023	00:00:02
212.51.192.185	0.330	0.463	00:00:01
isvcs01.man.lodz.pl	0.053	0.066	00:00:00
TOTAL: 6	5.000	6.952	00:00:34

NNRP unrecognized commands (by host):

System	Conn
194.165.16.76	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
#003	1
TOTAL: 1	1

Daily Usenet report

Oct 6 04:15:01 -- Oct 7 04:15:01