Daily Usenet report: Jan 22 04:15:04

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jan 22 05:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 07:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 09:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 11:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 12:16:24 newsfeed nnrpd[25846]: SERVER perl filter not defined
Jan 22 13:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 14:10:49 newsfeed nnrpd[29902]: SERVER perl filter not defined
Jan 22 15:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 17:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 19:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 21:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 22 23:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 23 01:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 23 03:36:00 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2003202	98.3%	241.0 MB	98.0%
innd	16973	0.8%	2.8 MB	1.1%
nnrpd	11890	0.6%	1.2 MB	0.5%
innfeed	6620	0.3%	1022.8 KB	0.4%
TOTAL: 4	2038685	100.0%	246.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1993349	94.9%
Negative hits	57984	2.8%
Positive hits	46567	2.2%
Cache misses	2338	0.1%
TOTAL: 4	2100238	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:15.104	0.0%	465	0.000	32.482	541.000
article cleanup	00:00:28.647	0.0%	2001435	0.001	0.014	0.032
article logging	00:01:00.591	0.1%	2001626	0.006	0.030	0.415
article parse	00:55:01.137	3.8%	155398370	0.003	0.021	0.060
article write	00:14:56.460	1.0%	1991660	0.154	0.450	1.195
artlog/artcncl	00:00:00.006	0.0%	451	0.000	0.013	1.000
artlog/artparse	00:00:00.001	0.0%	6	0.000	0.167	1.000
data move	00:03:21.684	0.2%	167329175	0.000	0.001	0.003
hisgrep/artcncl	00:00:03.043	0.0%	392	0.000	7.763	92.000
hishave/artcncl	00:00:01.083	0.0%	465	0.000	2.329	218.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	02:07:58.017	8.9%	2100362	0.285	3.656	9.158
history sync	00:00:00.024	0.0%	292	0.000	0.082	1.000
history write	03:39:00.409	15.2%	1993809	0.995	6.591	43.327
hiswrite/artcncl	00:00:00.704	0.0%	73	0.000	9.644	323.000
idle	11:17:47.731	47.1%	113170714	0.156	0.359	1.060
nntp read	00:59:10.815	4.1%	153916409	0.005	0.023	0.040
overview write	00:00:12.634	0.0%	1991660	0.000	0.006	0.017
perl filter	03:51:42.293	16.1%	1993803	2.800	6.973	10.232
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:28.087	0.3%	4029807	0.004	0.067	0.097
TOTAL: 23:59:33.773	23:15:28.470	96.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.189	0.0%	46502	0.000	0.004	0.200
article prepare	00:00:00.005	0.0%	17166	0.000	0.000	0.125
article read	00:00:00.162	0.0%	4227	0.000	0.038	1.000
backlog stats	00:00:00.141	0.0%	226653	0.000	0.001	0.032
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.540	0.0%	142780	0.000	0.011	1.000
data write	00:00:02.664	0.0%	96195	0.000	0.028	0.500
idle	24:00:32.210	100.0%	226653	0.000	381.342	16825.000
status file	00:00:00.345	0.0%	216	0.000	1.597	35.500
TOTAL: 24:00:42.029	24:00:37.256	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	73:21:19.758	100.0%	40918	0.000	6453.877	451323.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.694	0.0%	84712	0.000	0.020	5.111
readart	00:00:01.356	0.0%	634	0.000	2.139	50.429
TOTAL: 73:22:04.808	73:21:22.808	100.0%	-	-	-	-

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	748	1987985	1979016	1901	7068	99%	273:18:31
2	news.task.gda.pl	9	34368	7088	25844	1436	20%	47:27:20
3	news.nask.pl	3	21270	6655	13319	1296	31%	24:00:53
4	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 4		763	2043625	1992761	41064	9800	97%	344:46:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	496.0 GB	272.8 MB	296.4 MB	496.6 GB	99%	262.2 KB
2	news.nask.pl	35.4 MB	4.6 MB	4.7 MB	44.7 MB	79%	5.8 KB
3	news.task.gda.pl	15.1 MB	143.7 KB	4.2 MB	19.4 MB	77%	2.3 KB
4	localhost	3.5 KB	0.0 KB	0.0 KB	3.5 KB	100%	1.8 KB
TOTAL: 4		496.1 GB	277.5 MB	305.3 MB	496.7 GB	99%	260.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 22 04:15:04 - 04:59:59	61946	3.1%	22.98	14.4 GB	2.9%	5581.92
Jan 22 05:00:00 - 05:59:59	73881	3.7%	20.52	16.0 GB	3.2%	4654.75
Jan 22 06:00:00 - 06:59:59	81712	4.1%	22.70	19.2 GB	3.9%	5590.29
Jan 22 07:00:00 - 07:59:59	85758	4.3%	23.82	21.0 GB	4.2%	6121.65
Jan 22 08:00:00 - 08:59:59	79134	4.0%	21.98	19.8 GB	4.0%	5756.91
Jan 22 09:00:00 - 09:59:59	59931	3.0%	16.65	16.2 GB	3.3%	4731.67
Jan 22 10:00:00 - 10:59:59	63883	3.2%	17.75	19.0 GB	3.8%	5544.76
Jan 22 11:00:00 - 11:59:59	68211	3.4%	18.95	18.0 GB	3.6%	5236.77
Jan 22 12:00:00 - 12:59:59	85346	4.3%	23.71	20.3 GB	4.1%	5926.85
Jan 22 13:00:00 - 13:59:59	85336	4.3%	23.70	18.3 GB	3.7%	5339.34
Jan 22 14:00:00 - 14:59:59	115865	5.8%	32.18	28.3 GB	5.7%	8245.48
Jan 22 15:00:00 - 15:59:59	102863	5.2%	28.57	25.2 GB	5.1%	7335.80
Jan 22 16:00:00 - 16:59:59	107875	5.4%	29.97	26.8 GB	5.4%	7819.93
Jan 22 17:00:00 - 17:59:59	85732	4.3%	23.81	21.1 GB	4.2%	6144.27
Jan 22 18:00:00 - 18:59:59	76993	3.9%	21.39	18.2 GB	3.7%	5311.52
Jan 22 19:00:00 - 19:59:59	73682	3.7%	20.47	16.0 GB	3.2%	4654.74
Jan 22 20:00:00 - 20:59:59	67244	3.4%	18.68	15.6 GB	3.1%	4532.12
Jan 22 21:00:00 - 21:59:59	73196	3.7%	20.33	16.4 GB	3.3%	4765.52
Jan 22 22:00:00 - 22:59:59	76555	3.8%	21.27	18.6 GB	3.8%	5423.92
Jan 22 23:00:00 - 23:59:59	74352	3.7%	20.65	18.0 GB	3.6%	5234.27
Jan 23 00:00:00 - 00:59:59	77561	3.9%	21.54	24.2 GB	4.9%	7047.35
Jan 23 01:00:00 - 01:59:59	82207	4.1%	22.84	24.5 GB	4.9%	7136.35
Jan 23 02:00:00 - 02:59:59	112580	5.6%	31.27	30.4 GB	6.1%	8866.75
Jan 23 03:00:00 - 03:59:59	95464	4.8%	26.52	24.5 GB	4.9%	7130.52
Jan 23 04:00:00 - 04:15:04	25465	1.3%	28.17	6.5 GB	1.3%	7496.87
TOTAL: 24:00:00	1992772	100.0%	23.06	496.5 GB	100.0%	6025.60

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	7230	185	6336	0	709
2	news.task.gda.pl	1438	1163	59	0	216
3	news.nask.pl	1311	11	1242	1	57
TOTAL: 3		9979	1359	7637	1	982

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.openbsd.source-changes	114
fr.usenet.abus.nocem	112
mailing.freebsd.svn-ports-all	100
mailing.freebsd.svn-ports-head	94
mailing.freebsd.ports-bugs	93
uk.railway	81
mailing.freebsd.svn-src-all	63
fa.freebsd.cvs-all	63
mozilla.dev.tree-management	42
mailing.gcc.gcc-cvs	38
mailing.freebsd.svn-src-head	34
mozilla.dev.gaia	31
alt.windows7.general	29
gmane.linux.alsa.devel	27
24hoursupport.helpdesk	25
mailing.database.pgsql-general	24
mailing.unix.openssh-dev	20
mailing.openbsd.ports-changes	19
mailing.postfix.users	19
mailing.unix.dovecot	17
TOTAL: 83	1359

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	448
EMP (fsl)	168
Attached HTML file	107
EMP (md5)	51
HTML post	8
Scoring filter (8)	3
TOTAL: 6	785

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	48859	3560	42466	542	1	0	7%	24:01:27
2	task	2886	67	1497	8	0	0	2%	22:43:18
3	poznan	16987	57	13545	23	0	0	0%	23:52:32
4	nask	24411	34	15457	0	0	0	0%	24:00:27
5	okapi	0	0	0	0	0	3021	0%	24:00:02
6	icm	0	0	0	0	0	44729	0%	24:00:04
TOTAL: 6		93143	3718	72965	573	1	47750	3%	142:37:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	21.0 MB	1.6 MB	22.6 MB	0.3 KB/s	5.6 KB	24:01:27
2	nask	328.9 KB	0.0 KB	328.9 KB	0.0 KB/s	9.7 KB	24:00:27
3	poznan	201.4 KB	83.5 KB	284.9 KB	0.0 KB/s	3.6 KB	23:52:32
4	task	137.1 KB	18.9 KB	156.0 KB	0.0 KB/s	2.1 KB	22:43:18
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:02
6	icm	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:04
TOTAL: 6		21.6 MB	1.7 MB	23.4 MB	0.0 KB/s	5.6 KB	142:37:50

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	312	549.4 KB	288	0	00:00:11
2	web.man.lodz.pl	288	150	137.1 KB	62	0	00:00:23
3	212.191.78.190	331	113	249.1 KB	54	0	47:45:54
4	lze200.lze.lodz.pl	6	35	85.9 KB	5	0	01:35:53
5	ip-176.105.135.22.tvsat364.lodz.pl	9	23	42.3 KB	3	0	03:03:25
6	proxy.filmschool.lodz.pl	3	1	3.7 KB	1	0	00:14:08
7	kujawiak.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 7		927	634	1.0 MB	413	2	73:22:03

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	312	549.4 KB	288	0	00:00:11
2	*.man.lodz.pl	674	150	137.1 KB	62	2	00:00:30
3	unresolved	331	113	249.1 KB	54	0	47:45:54
4	*.lze.lodz.pl	6	35	85.9 KB	5	0	01:35:53
5	*.105.135.22.tvsat364.lodz.pl	9	23	42.3 KB	3	0	03:03:25
6	*.filmschool.lodz.pl	3	1	3.7 KB	1	0	00:14:08
7	*.pa.nsw.optusnet.com.au	181	0	0.0 KB	0	0	00:05:00
8	*.cbmm.lodz.pl	2	0	0.0 KB	0	0	00:00:03
9	*.45.14.62.static.jazztel.es	2	0	0.0 KB	0	0	03:20:19
10	*.wroclaw.mm.pl	16	0	0.0 KB	0	0	02:29:36
11	*.4web.pl	90	0	0.0 KB	0	0	14:46:06
12	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	00:00:28
13	*.toya.net.pl	90	0	0.0 KB	0	0	00:00:23
TOTAL: 13		1693	634	1.0 MB	413	2	73:22:03

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
212.191.78.190	0.808	4.476	47:45:54
net133-43.4web.pl	0.196	1.096	14:46:06
254.45.14.62.static.jazztel.es	1.944	2.304	03:20:19
ip-176.105.135.22.tvsat364.lodz.pl	0.020	0.140	03:03:25
host-89-231-50-15.wroclaw.mm.pl	0.032	0.228	02:29:36
lze200.lze.lodz.pl	0.020	0.092	01:35:53
proxy.filmschool.lodz.pl	0.008	0.056	00:14:08
pa49-181-246-238.pa.nsw.optusnet.com.au	0.424	2.472	00:05:00
ecl20.neoplus.adsl.tpnet.pl	0.004	0.012	00:00:28
web.man.lodz.pl	0.632	3.972	00:00:23
staticline41435.toya.net.pl	0.208	1.140	00:00:23
vegas.cm.p.lodz.pl	0.652	3.980	00:00:11
mon.man.lodz.pl	0.540	3.780	00:00:04
router2.cbmm.lodz.pl	0.008	0.028	00:00:03
david.man.lodz.pl	0.160	1.312	00:00:01
kujawiak.man.lodz.pl	0.012	0.036	00:00:00
TOTAL: 16	5.668	25.124	73:22:03

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
pa49-181-246-238.pa.nsw.optusnet.com.au	181
david.man.lodz.pl	96
staticline41435.toya.net.pl	90
net133-43.4web.pl	90
host-89-231-50-15.wroclaw.mm.pl	16
254.45.14.62.static.jazztel.es	2
router2.cbmm.lodz.pl	2
ecl20.neoplus.adsl.tpnet.pl	1
TOTAL: 9	766

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip-176.105.135.22.tvsat364.lodz.pl	4	0
lze200.lze.lodz.pl	2	0
TOTAL: 2	6	2

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	322	50.8%
2	lodman	312	49.2%
TOTAL: 2		634	100.0%

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

Newsgroup		Count
1	lodman.info	312
2	pl.comp.os.ms-windows.winnt	111
3	pl.misc.kolej	61
4	pl.comp.pecet	46
5	pl.soc.prawo	33
6	pl.comp.os.linux	28
7	pl.rec.kuchnia	13
8	pl.internet.polip	12
9	pl.rec.rowery	6
10	pl.regionalne.lodz	4
11	pl.rec.dom	3
12	pl.regionalne.warszawa	2
13	pl.rec.foto.cyfrowa	1
14	pl.soc.dzieci.starsze	1
15	pl.rec.gory	1
TOTAL: 15		634

Daily Usenet report

Jan 22 04:15:04 -- Jan 23 04:15:04