Daily Usenet report: Aug 20 04:15:03

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Aug 20 09:40:16 newsfeed nnrpd[10417]: SERVER perl filter not defined
Aug 20 09:42:30 newsfeed nnrpd[10425]: SERVER perl filter not defined
Aug 20 09:44:06 newsfeed nnrpd[10458]: SERVER perl filter not defined
Aug 20 12:09:20 newsfeed innfeed[2302]: task:0 connect: Network is unreachable
Aug 20 12:09:21 newsfeed innfeed[2302]: nask:0 connect: Network is unreachable
Aug 20 12:09:21 newsfeed innfeed[2302]: icm:0 connect: Network is unreachable
Aug 20 20:59:02 newsfeed nnrpd[19945]: SERVER perl filter not defined
Aug 20 21:00:07 newsfeed nnrpd[20157]: SERVER perl filter not defined
Aug 21 04:15:03 newsfeed nnrpd[1463]: web.man.lodz.pl rejected Flushing log and syslog files
Aug 21 04:15:03 newsfeed nnrpd[1471]: web.man.lodz.pl rejected Flushing log and syslog files
Aug 21 04:15:03 newsfeed nnrpd[1472]: web.man.lodz.pl rejected Flushing log and syslog files
Aug 21 04:15:03 newsfeed nnrpd[1473]: web.man.lodz.pl rejected Flushing log and syslog files
Aug 21 04:15:03 newsfeed nnrpd[1474]: web.man.lodz.pl rejected Flushing log and syslog files
Aug 21 04:15:03 newsfeed nnrpd[1476]: web.man.lodz.pl rejected Flushing log and syslog files

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2419244	98.6%	275.0 MB	98.2%
innd	18934	0.8%	3.1 MB	1.1%
nnrpd	7406	0.3%	781.9 KB	0.3%
innfeed	7122	0.3%	1.0 MB	0.4%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	2452707	100.0%	279.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2412723	94.6%
Negative hits	97219	3.8%
Positive hits	38577	1.5%
Cache misses	1009	0.0%
TOTAL: 4	2549528	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.340	0.0%	309	0.000	26.990	547.000
article cleanup	00:00:31.970	0.0%	2415826	0.003	0.013	0.024
article logging	00:00:57.588	0.1%	2416031	0.012	0.024	0.243
article parse	01:25:27.590	5.9%	96880326	0.016	0.053	0.094
article write	00:24:19.075	1.7%	2411676	0.373	0.605	2.175
artlog/artcncl	00:00:00.004	0.0%	295	0.000	0.014	1.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:03:05.883	0.2%	111706739	0.000	0.002	0.009
hisgrep/artcncl	00:00:02.057	0.0%	295	0.000	6.973	153.000
hishave/artcncl	00:00:01.284	0.0%	309	0.000	4.155	292.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	03:07:20.494	13.0%	2550325	0.337	4.407	14.205
history sync	00:00:00.011	0.0%	291	0.000	0.038	1.000
history write	04:22:58.717	18.3%	2413614	1.679	6.537	22.532
hiswrite/artcncl	00:00:00.110	0.0%	14	0.000	7.857	59.000
idle	06:57:00.251	29.0%	55432071	0.150	0.451	5.246
nntp read	00:46:57.666	3.3%	94907408	0.012	0.030	0.043
overview write	00:00:14.295	0.0%	2411676	0.000	0.006	0.015
perl filter	06:24:04.814	26.7%	2413614	5.863	9.548	12.189
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:03:51.185	0.3%	4862570	0.027	0.048	0.187
TOTAL: 23:57:44.347	23:37:01.334	98.6%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.155	0.0%	39331	0.000	0.004	0.167
article prepare	00:00:00.006	0.0%	42430	0.000	0.000	0.042
article read	00:00:00.291	0.0%	9964	0.000	0.029	0.667
backlog stats	00:00:00.196	0.0%	281363	0.000	0.001	0.015
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.854	0.0%	174161	0.000	0.011	1.000
data write	00:00:03.514	0.0%	137905	0.000	0.025	0.667
idle	23:58:16.545	100.0%	281363	0.000	306.709	18495.000
status file	00:00:01.861	0.0%	278	0.000	6.694	354.000
TOTAL: 23:58:30.370	23:58:24.422	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:38:47.367	99.7%	47625	0.000	275.640	238462.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.412	0.0%	97143	0.000	0.015	1.000
readart	00:00:00.420	0.0%	415	0.000	1.012	15.000
TOTAL: 03:39:26.518	03:38:49.199	99.7%	-	-	-	-

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	701	2407879	2399961	5318	2600	99%	418:05:03
2	news.nask.pl	3	15554	6714	8396	444	43%	23:12:39
3	news.task.gda.pl	18	27892	5639	21255	998	20%	42:39:59
4	news.icm.edu.pl	36	284	11	230	43	3%	18:03:42
5	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 5		764	2451614	2412330	35199	4085	98%	502:01:23

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	879.0 GB	11.0 MB	51.3 MB	879.0 GB	99%	383.7 KB
2	news.nask.pl	23.4 MB	1.0 MB	1.1 MB	25.5 MB	91%	3.7 KB
3	news.task.gda.pl	11.8 MB	20.4 KB	3.0 MB	14.8 MB	79%	2.3 KB
4	news.icm.edu.pl	450.0 KB	0.0 KB	959.7 KB	1.4 MB	31%	26.1 KB
5	localhost	10.5 KB	0.0 KB	0.0 KB	10.5 KB	100%	2.1 KB
TOTAL: 5		879.0 GB	12.0 MB	56.4 MB	879.1 GB	99%	381.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 20 04:15:03 - 04:59:59	67480	2.8%	25.02	24.4 GB	2.8%	9495.74
Aug 20 05:00:00 - 05:59:59	89725	3.7%	24.92	34.4 GB	3.9%	10027.61
Aug 20 06:00:00 - 06:59:59	89066	3.7%	24.74	34.6 GB	3.9%	10070.26
Aug 20 07:00:00 - 07:59:59	80224	3.3%	22.28	29.5 GB	3.4%	8607.04
Aug 20 08:00:00 - 08:59:59	80353	3.3%	22.32	33.3 GB	3.8%	9702.41
Aug 20 09:00:00 - 09:59:59	101277	4.2%	28.13	39.1 GB	4.4%	11395.25
Aug 20 10:00:00 - 10:59:59	111351	4.6%	30.93	38.6 GB	4.4%	11248.25
Aug 20 11:00:00 - 11:59:59	122519	5.1%	34.03	38.4 GB	4.4%	11190.03
Aug 20 12:00:00 - 12:59:59	95378	4.0%	26.49	35.5 GB	4.0%	10341.82
Aug 20 13:00:00 - 13:59:59	97091	4.0%	26.97	37.0 GB	4.2%	10776.81
Aug 20 14:00:00 - 14:59:59	99552	4.1%	27.65	37.5 GB	4.3%	10920.58
Aug 20 15:00:00 - 15:59:59	109795	4.5%	30.50	37.9 GB	4.3%	11039.55
Aug 20 16:00:00 - 16:59:59	122852	5.1%	34.13	38.9 GB	4.4%	11317.07
Aug 20 17:00:00 - 17:59:59	97575	4.0%	27.10	33.9 GB	3.9%	9881.86
Aug 20 18:00:00 - 18:59:59	113966	4.7%	31.66	36.9 GB	4.2%	10749.76
Aug 20 19:00:00 - 19:59:59	120460	5.0%	33.46	39.4 GB	4.5%	11487.16
Aug 20 20:00:00 - 20:59:59	93863	3.9%	26.07	35.0 GB	4.0%	10192.96
Aug 20 21:00:00 - 21:59:59	100932	4.2%	28.04	39.4 GB	4.5%	11467.40
Aug 20 22:00:00 - 22:59:59	96843	4.0%	26.90	38.0 GB	4.3%	11064.75
Aug 20 23:00:00 - 23:59:59	104987	4.3%	29.16	38.8 GB	4.4%	11312.87
Aug 21 00:00:00 - 00:59:59	82034	3.4%	22.79	32.8 GB	3.7%	9565.00
Aug 21 01:00:00 - 01:59:59	105869	4.4%	29.41	40.0 GB	4.5%	11645.62
Aug 21 02:00:00 - 02:59:59	105996	4.4%	29.44	39.3 GB	4.5%	11458.47
Aug 21 03:00:00 - 03:59:59	100866	4.2%	28.02	37.4 GB	4.3%	10890.22
Aug 21 04:00:00 - 04:15:03	24535	1.0%	27.17	9.0 GB	1.0%	10431.09
TOTAL: 24:00:00	2414589	100.0%	27.95	879.2 GB	100.0%	10670.13

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	2740	259	1793	1	687
2	news.task.gda.pl	1045	876	13	0	156
3	news.nask.pl	532	31	410	0	91
4	news.icm.edu.pl	43	0	0	0	43
TOTAL: 4		4360	1166	2216	1	977

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	127
mailing.freebsd.svn-ports-all	62
mailing.freebsd.svn-ports-head	62
mailing.www.horde-bugs	57
mailing.freebsd.ports-bugs	54
mailing.postfix.users	39
mozilla.dev.identity	37
mailing.unix.dovecot	35
mailing.freebsd.svn-src-all	35
fa.freebsd.cvs-all	35
mozilla.dev.tree-management	33
fr.usenet.abus.nocem	31
alt.windows7.general	30
alt.politics.scorched-earth	29
mailing.gcc.gcc-cvs	27
comp.sys.raspberry-pi	27
mailing.openbsd.source-changes	22
mailing.freebsd.svn-src-head	22
gmane.linux.alsa.devel	20
de.comm.provider.telefonie	18
TOTAL: 81	1166

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	519
EMP (fsl)	133
EMP (md5)	63
Attached HTML file	39
HTML post	10
Scoring filter (8)	5
Scoring filter (12)	1
Scoring filter (10)	1
Scoring filter (9)	1
TOTAL: 9	772

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	53791	3792	29450	1773	11	61	7%	23:51:01
2	panorama	40273	3711	34335	940	0	0	9%	23:50:02
3	task	2187	196	1039	11	0	3	8%	22:20:01
4	poznan	15025	87	12368	51	0	0	0%	23:49:24
5	nask	17789	3	12808	0	0	8	0%	24:00:32
6	okapi	0	0	0	0	0	2957	0%	24:00:00
TOTAL: 6		129065	7789	90000	2775	11	3029	6%	141:51:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	20.2 MB	17.5 MB	37.7 MB	0.4 KB/s	6.9 KB	23:51:01
2	panorama	11.5 MB	3.3 MB	14.8 MB	0.2 KB/s	3.3 KB	23:50:02
3	task	433.6 KB	21.5 KB	455.2 KB	0.0 KB/s	2.2 KB	22:20:01
4	poznan	254.9 KB	93.4 KB	348.3 KB	0.0 KB/s	2.5 KB	23:49:24
5	nask	6.7 KB	0.0 KB	6.7 KB	0.0 KB/s	2.2 KB	24:00:32
6	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 6		32.3 MB	21.0 MB	53.3 MB	0.1 KB/s	5.2 KB	141:51:00

Backlog files shrunk by innfeed:

Server	Size
okapi	488.4 KB
TOTAL: 1	488.4 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	vegas.cm.p.lodz.pl	288	318	553.1 KB	288	0	00:00:14
2	web.man.lodz.pl	294	62	70.3 KB	28	0	00:00:24
3	lze200.lze.lodz.pl	6	35	82.3 KB	6	0	00:59:56
4	kujawiak.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 4		593	415	705.7 KB	322	5	03:39:26

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	318	553.1 KB	288	0	00:00:14
2	*.man.lodz.pl	683	62	70.3 KB	28	5	00:00:37
3	*.lze.lodz.pl	6	35	82.3 KB	6	0	00:59:56
4	*.207.15.62.static.jazztel.es	6	0	0.0 KB	0	0	01:42:32
5	*.cbmm.lodz.pl	10	0	0.0 KB	0	0	00:51:38
6	unresolved	1	0	0.0 KB	0	0	00:00:12
7	*.neoplus.adsl.tpnet.pl	1	0	0.0 KB	0	0	00:00:57
8	*.105.135.22.tvsat364.lodz.pl	1	0	0.0 KB	0	0	00:03:09
9	*.toya.net.pl	90	0	0.0 KB	0	0	00:00:06
TOTAL: 9		1086	415	705.7 KB	322	5	03:39:26

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
200.207.15.62.static.jazztel.es	2.304	3.616	01:42:32
lze200.lze.lodz.pl	0.016	0.108	00:59:56
router2.cbmm.lodz.pl	0.020	0.136	00:51:38
ip-176.105.135.22.tvsat364.lodz.pl	0.000	0.012	00:03:09
ecd246.neoplus.adsl.tpnet.pl	0.000	0.016	00:00:57
web.man.lodz.pl	0.732	3.624	00:00:24
vegas.cm.p.lodz.pl	0.672	3.644	00:00:14
84.39.175.67	0.028	0.016	00:00:12
f-oper-v100.man.lodz.pl	0.696	3.748	00:00:09
staticline-31-183-3-34.toya.net.pl	0.208	0.968	00:00:06
david.man.lodz.pl	0.244	1.208	00:00:02
kujawiak.man.lodz.pl	0.032	0.080	00:00:00
TOTAL: 12	4.952	17.176	03:39:26

Curious NNRP server explorers [Top 20]:

System	Conn
f-oper-v100.man.lodz.pl	288
david.man.lodz.pl	96
staticline-31-183-3-34.toya.net.pl	90
router2.cbmm.lodz.pl	10
200.207.15.62.static.jazztel.es	6
ip-176.105.135.22.tvsat364.lodz.pl	1
84.39.175.67	1
ecd246.neoplus.adsl.tpnet.pl	1
TOTAL: 8	493

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	6	0
TOTAL: 1	6	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	318	76.6%
2	pl	97	23.4%
TOTAL: 2		415	100.0%

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

Newsgroup		Count
1	lodman.info	318
2	pl.comp.pecet	54
3	pl.rec.dom	25
4	pl.comp.os.ms-windows.winnt	15
5	pl.comp.os.linux	3
TOTAL: 5		415

Daily Usenet report

Aug 20 04:15:03 -- Aug 21 04:15:03