Daily Usenet report: Feb 5 04:15:04

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Feb 5 09:55:27 newsfeed overchan[2172]: input line too long, skipping
Feb 5 10:01:06 newsfeed nnrpd[13886]: SERVER perl filter not defined
Feb 5 10:13:50 newsfeed nnrpd[14261]: SERVER perl filter not defined
Feb 5 10:37:38 newsfeed nnrpd[15011]: SERVER perl filter not defined
Feb 5 10:38:23 newsfeed nnrpd[15154]: SERVER perl filter not defined
Feb 5 12:44:15 newsfeed overchan[2172]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	588156	96.4%	67.2 MB	95.8%
innd	8103	1.3%	1.3 MB	1.9%
nnrpd	7112	1.2%	742.4 KB	1.0%
innfeed	6563	1.1%	914.0 KB	1.3%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 5	609936	100.0%	70.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	560360	95.0%
Positive hits	16986	2.9%
Negative hits	12377	2.1%
Cache misses	154	0.0%
TOTAL: 4	589877	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.461	0.0%	313	0.000	17.447	344.000
article cleanup	00:00:06.979	0.0%	563397	0.000	0.012	0.037
article logging	00:00:14.093	0.0%	588080	0.000	0.024	0.074
article parse	00:16:04.099	1.1%	45503404	0.009	0.021	0.046
article write	00:04:17.224	0.3%	559787	0.096	0.460	7.008
artlog/artcncl	00:00:00.007	0.0%	310	0.000	0.023	1.000
artlog/artparse	00:00:00.001	0.0%	2	0.000	0.500	1.000
data move	00:00:55.808	0.1%	48587146	0.000	0.001	0.003
hisgrep/artcncl	00:00:01.635	0.0%	265	0.000	6.170	38.000
hishave/artcncl	00:00:00.723	0.0%	313	0.000	2.310	145.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:41:28.559	2.9%	590019	0.016	4.218	18.940
history sync	00:00:00.015	0.0%	484	0.000	0.031	1.000
history write	01:01:56.904	4.3%	560750	0.033	6.628	32.171
hiswrite/artcncl	00:00:00.153	0.0%	48	0.000	3.188	4.214
idle	20:23:06.789	84.9%	37649998	0.419	1.949	9.122
nntp read	00:16:15.824	1.1%	45194870	0.012	0.022	0.036
overview write	00:00:03.465	0.0%	559787	0.000	0.006	0.040
perl filter	01:03:24.763	4.4%	560748	2.372	6.785	9.178
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:01:07.049	0.1%	1153673	0.028	0.058	0.112
TOTAL: 24:00:46.394	23:49:09.551	99.2%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.124	0.0%	34097	0.000	0.004	0.143
article prepare	00:00:00.004	0.0%	11208	0.000	0.000	0.125
article read	00:00:00.182	0.0%	2742	0.000	0.066	1.000
backlog stats	00:00:00.103	0.0%	213797	0.000	0.000	0.021
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.210	0.0%	139272	0.000	0.009	1.000
data write	00:00:02.875	0.0%	105751	0.000	0.027	1.333
idle	23:59:34.682	100.0%	213797	0.000	404.003	17254.000
status file	00:00:01.046	0.0%	205	0.000	5.102	210.000
TOTAL: 23:59:44.684	23:59:40.226	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.086	0.0%	17	5.059	5.059	5.059
idle	03:25:21.522	99.8%	16297	0.000	756.061	450460.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.977	0.0%	34394	0.000	0.028	6.667
readart	00:00:00.695	0.0%	416	0.000	1.671	20.885
TOTAL: 03:25:43.313	03:25:23.280	99.8%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	189

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	72	560136	557030	269	2837	99%	88:38:27
2	news.nask.pl	2	16981	2643	13604	734	15%	24:24:16
3	news.icm.edu.pl	49	243	14	195	34	5%	17:28:15
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		128	577364	559691	14068	3605	96%	130:30:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	126.5 GB	10.8 MB	85.8 MB	126.6 GB	99%	237.2 KB
2	news.nask.pl	11.0 MB	2.1 MB	2.1 MB	15.1 MB	72%	4.6 KB
3	news.icm.edu.pl	220.1 KB	0.0 KB	1.9 MB	2.2 MB	9%	46.1 KB
4	localhost	5.9 KB	0.0 KB	0.0 KB	5.9 KB	100%	1.5 KB
TOTAL: 4		126.5 GB	12.9 MB	89.8 MB	126.6 GB	99%	235.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 5 04:15:04 - 04:59:59	11199	2.0%	4.15	2.9 GB	2.3%	1127.98
Feb 5 05:00:00 - 05:59:59	13398	2.4%	3.72	3.0 GB	2.4%	868.79
Feb 5 06:00:00 - 06:59:59	11910	2.1%	3.31	2.4 GB	1.9%	686.63
Feb 5 07:00:00 - 07:59:59	15217	2.7%	4.23	2.6 GB	2.0%	746.33
Feb 5 08:00:00 - 08:59:59	11163	2.0%	3.10	2.0 GB	1.6%	594.17
Feb 5 09:00:00 - 09:59:59	10012	1.8%	2.78	1.5 GB	1.2%	445.99
Feb 5 10:00:00 - 10:59:59	11355	2.0%	3.15	1.7 GB	1.3%	483.21
Feb 5 11:00:00 - 11:59:59	10569	1.9%	2.94	1.4 GB	1.1%	420.10
Feb 5 12:00:00 - 12:59:59	13101	2.3%	3.64	1.6 GB	1.3%	480.10
Feb 5 13:00:00 - 13:59:59	14435	2.6%	4.01	1.9 GB	1.5%	563.97
Feb 5 14:00:00 - 14:59:59	11897	2.1%	3.30	1.8 GB	1.5%	535.41
Feb 5 15:00:00 - 15:59:59	14526	2.6%	4.04	1.8 GB	1.4%	518.44
Feb 5 16:00:00 - 16:59:59	16134	2.9%	4.48	2.0 GB	1.6%	574.30
Feb 5 17:00:00 - 17:59:59	27993	5.0%	7.78	2.2 GB	1.7%	630.52
Feb 5 18:00:00 - 18:59:59	25599	4.6%	7.11	2.0 GB	1.6%	590.79
Feb 5 19:00:00 - 19:59:59	13286	2.4%	3.69	2.1 GB	1.6%	601.57
Feb 5 20:00:00 - 20:59:59	13166	2.4%	3.66	2.0 GB	1.6%	580.59
Feb 5 21:00:00 - 21:59:59	12591	2.3%	3.50	1.5 GB	1.2%	438.07
Feb 5 22:00:00 - 22:59:59	14167	2.5%	3.94	1.9 GB	1.5%	555.67
Feb 5 23:00:00 - 23:59:59	15058	2.7%	4.18	2.0 GB	1.6%	574.04
Feb 6 00:00:00 - 00:59:59	40227	7.2%	11.17	10.7 GB	8.4%	3106.87
Feb 6 01:00:00 - 01:59:59	71850	12.8%	19.96	24.0 GB	18.9%	6982.50
Feb 6 02:00:00 - 02:59:59	83569	14.9%	23.21	27.3 GB	21.6%	7950.67
Feb 6 03:00:00 - 03:59:59	71672	12.8%	19.91	23.0 GB	18.2%	6690.50
Feb 6 04:00:00 - 04:15:01	5459	1.0%	6.06	1.3 GB	1.1%	1547.59
TOTAL: 23:59:57	559553	100.0%	6.48	126.5 GB	100.0%	1535.52

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	27517	214	1925	0	25378
2	news.nask.pl	742	13	723	1	5
3	news.icm.edu.pl	34	0	0	0	34
TOTAL: 3		28293	227	2648	1	25417

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	116
it.tlc.cellulari.android	28
de.rec.sf.startrek	14
uk.rec.cycling.moderated	12
it.comp.os.win.windows7	10
comp.sys.raspberry-pi	9
alt.sex.telephones	9
de.comp.office-pakete.ms-office.excel	5
nl.actueel	4
hr.ponuda.hardver.komponente	4
it.comp.os.win.windows8	4
comp.mobile.android	3
de.comp.office-pakete.ms-office.word	2
hr.alt.cellular.gsm.android	2
it.comp.os.linux.ubuntu	1
de.comm.software.mailreader	1
hr.rec.glazba.hifi	1
it.discussioni.energia	1
hr.alt.cellular.gsm.iphone	1
TOTAL: 19	227

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

Groups	Count
pl.sci.historia	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	715
Attached HTML file	9
EMP (md5)	5
HTML post	2
Scoring filter (9)	1
TOTAL: 5	732

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	34733	1100	32927	124	0	3%	24:08:12
2	icm	44343	468	31578	914	7	1%	23:59:00
3	nask	22372	155	15182	5	0	0%	24:01:05
4	poznan	3165	23	2228	9	0	0%	24:04:28
5	okapi	0	0	0	0	2324	0%	24:00:03
TOTAL: 5		104613	1746	81915	1052	2331	1%	120:12:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	4.6 MB	598.5 KB	5.2 MB	0.1 KB/s	4.4 KB	24:08:12
2	icm	2.5 MB	156.8 MB	159.3 MB	1.9 KB/s	118.0 KB	23:59:00
3	nask	2.2 MB	360.4 KB	2.6 MB	0.0 KB/s	16.4 KB	24:01:05
4	poznan	108.4 KB	14.5 KB	122.9 KB	0.0 KB/s	3.8 KB	24:04:28
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:03
TOTAL: 5		9.5 MB	157.7 MB	167.2 MB	0.4 KB/s	61.2 KB	120:12:48

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	pc-skrzep2.cm.p.lodz.pl	288	326	482.7 KB	288	0	00:00:07
2	web.man.lodz.pl	288	60	67.0 KB	26	0	00:00:17
3	pc-212-51-218-225.p.lodz.pl	9	30	59.9 KB	6	0	02:56:52
4	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 4		589	416	609.6 KB	320	4	03:25:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	326	482.7 KB	288	0	00:00:07
2	*.man.lodz.pl	676	60	67.0 KB	26	4	00:00:23
3	*.p.lodz.pl	9	30	59.9 KB	6	0	02:56:52
4	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:12
5	unresolved	4	0	0.0 KB	0	0	00:27:56
6	*.toya.net.pl	49	0	0.0 KB	0	0	00:00:03
7	*.lze.lodz.pl	2	0	0.0 KB	0	0	00:00:08
TOTAL: 7		1030	416	609.6 KB	320	4	03:25:43

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.036	0.074	02:56:52
89.38.41.61	0.435	0.679	00:27:56
web.man.lodz.pl	1.091	2.397	00:00:17
host227.elsnet.pl	0.011	0.011	00:00:12
lze200.lze.lodz.pl	0.014	0.015	00:00:08
pc-skrzep2.cm.p.lodz.pl	1.044	2.395	00:00:07
mon.man.lodz.pl	1.086	2.131	00:00:04
staticline41435.toya.net.pl	0.150	0.404	00:00:03
david.man.lodz.pl	0.326	0.745	00:00:01
isvcs01.man.lodz.pl	0.029	0.034	00:00:00
TOTAL: 10	4.222	8.885	03:25:43

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	49
89.38.41.61	4
host227.elsnet.pl	2
lze200.lze.lodz.pl	2
TOTAL: 6	441

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	4	0
TOTAL: 1	4	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	326	78.4%
2	pl	90	21.6%
TOTAL: 2		416	100.0%

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

Newsgroup		Count
1	lodman.info	326
2	pl.comp.pecet	54
3	pl.misc.elektronika	25
4	pl.comp.os.ms-windows.winnt	6
5	pl.misc.kolej	5
TOTAL: 5		416

Daily Usenet report

Feb 5 04:15:04 -- Feb 6 04:15:01