Daily Usenet report: Oct 28 04:15:03

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Oct 28 09:01:22 newsfeed nnrpd[29413]: SERVER perl filter not defined
Oct 28 09:02:35 newsfeed nnrpd[29453]: SERVER perl filter not defined
Oct 28 09:03:52 newsfeed nnrpd[29456]: SERVER perl filter not defined
Oct 28 09:04:56 newsfeed nnrpd[29465]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	1166436	97.8%	133.6 MB	97.3%
innd	12638	1.1%	2.1 MB	1.5%
nnrpd	7072	0.6%	742.4 KB	0.5%
innfeed	6698	0.6%	973.6 KB	0.7%
controlchan	8	0.0%	0.9 KB	0.0%
overchan	4	0.0%	0.7 KB	0.0%
TOTAL: 6	1192856	100.0%	137.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1162740	95.6%
Negative hits	35755	2.9%
Positive hits	17637	1.4%
Cache misses	337	0.0%
TOTAL: 4	1216469	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:07.043	0.0%	259	0.000	27.193	503.000
article cleanup	00:00:20.703	0.0%	1166292	0.000	0.018	0.039
article logging	00:00:32.628	0.0%	1166428	0.000	0.028	1.616
article parse	00:47:32.013	3.3%	102296660	0.007	0.028	0.044
article write	00:10:54.973	0.8%	1162684	0.166	0.563	4.240
artlog/artcncl	00:00:00.003	0.0%	258	0.000	0.012	0.500
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:01:54.939	0.1%	109653948	0.000	0.001	0.014
hisgrep/artcncl	00:00:00.794	0.0%	241	0.000	3.295	309.000
hishave/artcncl	00:00:01.410	0.0%	259	0.000	5.444	265.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	01:32:05.708	6.4%	1217257	0.015	4.539	13.984
history sync	00:00:00.028	0.0%	361	0.000	0.078	3.000
history write	02:13:18.724	9.3%	1163602	0.064	6.874	25.617
hiswrite/artcncl	00:00:00.082	0.0%	18	0.000	4.556	18.667
idle	15:10:36.667	63.2%	71756254	0.360	0.761	6.025
nntp read	00:45:13.035	3.1%	101342947	0.010	0.027	0.042
overview write	00:00:07.714	0.0%	1162684	0.000	0.007	0.025
perl filter	02:44:23.272	11.4%	1163600	3.995	8.477	12.079
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:02:16.486	0.2%	2356134	0.013	0.058	0.126
TOTAL: 24:00:21.447	23:29:26.222	97.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.108	0.0%	30754	0.000	0.004	0.167
article prepare	00:00:00.002	0.0%	14120	0.000	0.000	0.083
article read	00:00:00.412	0.0%	3292	0.000	0.125	30.000
backlog stats	00:00:00.126	0.0%	216862	0.000	0.001	0.031
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.401	0.0%	132893	0.000	0.011	1.000
data write	00:00:03.902	0.0%	108685	0.000	0.036	10.000
idle	23:58:54.257	100.0%	216862	0.000	398.107	21099.000
status file	00:00:02.268	0.0%	260	0.000	8.723	239.500
TOTAL: 23:59:08.125	23:59:02.476	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:45:43.425	99.4%	4143	0.000	662.183	202044.556
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.190	0.0%	9972	0.000	0.019	0.500
readart	00:00:00.518	0.0%	351	0.000	1.476	296.000
TOTAL: 00:46:01.178	00:45:44.133	99.4%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	149
name	2
newgroup	4
pause	2
paused	2
reload	2
reserve	2
TOTAL: 12	194

Newsgroups created:

Group	Mode
alt.binaries.apocalypse	y
alt.binaries.big-pharma	y
alt.binaries.science	y
alt.government.shills	y
TOTAL	4

Control Channel:

Sender	newgroup	DoIt	OK
153fishare@gmail.com	1	1	1
presidentobola@mail.com	3	3	3
TOTAL	4	4	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	626	1162878	1158765	1086	3027	99%	244:45:05
2	news.nask.pl	3	17284	3491	13282	511	20%	23:00:54
3	news.icm.edu.pl	42	278	31	186	61	11%	17:03:12
4	localhost	5	4	4	0	0	100%	00:00:00
TOTAL: 4		676	1180444	1162291	14554	3599	98%	284:49:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	370.8 GB	12.4 MB	87.6 MB	370.9 GB	99%	334.7 KB
2	news.nask.pl	14.4 MB	1.2 MB	1.4 MB	17.1 MB	84%	4.4 KB
3	news.icm.edu.pl	454.3 KB	28.4 KB	867.3 KB	1.3 MB	33%	14.7 KB
4	localhost	5.6 KB	0.0 KB	0.0 KB	5.6 KB	100%	1.4 KB
TOTAL: 4		370.8 GB	13.6 MB	89.9 MB	370.9 GB	99%	333.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 28 04:15:03 - 04:59:59	33088	2.8%	12.27	12.7 GB	3.4%	4925.32
Oct 28 05:00:00 - 05:59:59	48652	4.2%	13.51	18.3 GB	4.9%	5343.34
Oct 28 06:00:00 - 06:59:59	45955	4.0%	12.77	16.2 GB	4.4%	4720.56
Oct 28 07:00:00 - 07:59:59	51268	4.4%	14.24	19.4 GB	5.2%	5645.47
Oct 28 08:00:00 - 08:59:59	54374	4.7%	15.10	19.5 GB	5.3%	5692.30
Oct 28 09:00:00 - 09:59:59	66404	5.7%	18.45	22.0 GB	5.9%	6409.04
Oct 28 10:00:00 - 10:59:59	29160	2.5%	8.10	8.4 GB	2.3%	2460.83
Oct 28 11:00:00 - 11:59:59	12625	1.1%	3.51	2.3 GB	0.6%	674.52
Oct 28 12:00:00 - 12:59:59	11747	1.0%	3.26	2.6 GB	0.7%	752.45
Oct 28 13:00:00 - 13:59:59	10870	0.9%	3.02	2.3 GB	0.6%	655.53
Oct 28 14:00:00 - 14:59:59	37078	3.2%	10.30	10.8 GB	2.9%	3158.01
Oct 28 15:00:00 - 15:59:59	53341	4.6%	14.82	17.6 GB	4.7%	5119.87
Oct 28 16:00:00 - 16:59:59	72948	6.3%	20.26	21.9 GB	5.9%	6364.38
Oct 28 17:00:00 - 17:59:59	50392	4.3%	14.00	15.4 GB	4.1%	4476.59
Oct 28 18:00:00 - 18:59:59	74993	6.5%	20.83	23.4 GB	6.3%	6813.59
Oct 28 19:00:00 - 19:59:59	67863	5.8%	18.85	20.9 GB	5.6%	6094.46
Oct 28 20:00:00 - 20:59:59	66976	5.8%	18.60	21.0 GB	5.7%	6129.92
Oct 28 21:00:00 - 21:59:59	62674	5.4%	17.41	19.8 GB	5.3%	5776.27
Oct 28 22:00:00 - 22:59:59	39929	3.4%	11.09	12.6 GB	3.4%	3671.40
Oct 28 23:00:00 - 23:59:59	12504	1.1%	3.47	2.3 GB	0.6%	657.26
Oct 29 00:00:00 - 00:59:59	52520	4.5%	14.59	15.0 GB	4.0%	4355.71
Oct 29 01:00:00 - 01:59:59	61862	5.3%	17.18	19.2 GB	5.2%	5592.77
Oct 29 02:00:00 - 02:59:59	57069	4.9%	15.85	18.6 GB	5.0%	5415.16
Oct 29 03:00:00 - 03:59:59	72677	6.3%	20.19	23.6 GB	6.4%	6872.42
Oct 29 04:00:00 - 04:15:03	15461	1.3%	17.12	5.0 GB	1.4%	5814.55
TOTAL: 24:00:00	1162430	100.0%	13.45	370.8 GB	100.0%	4500.01

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	3154	239	2220	13	682
2	news.nask.pl	550	44	470	8	28
3	news.icm.edu.pl	44	0	3	0	41
TOTAL: 3		3748	283	2693	21	751

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	82
comp.mobile.ipad	45
comp.sys.raspberry-pi	30
uk.rec.cycling.moderated	28
alt.sex.telephones	23
comp.mobile.android	23
it.comp.os.win.windows8	22
it.tlc.cellulari.android	7
hr.alt.cellular.gsm.android	5
de.comm.software.mailreader	3
de.comp.lang.vbclassic	2
it.comp.os.win.windows7	2
it.discussioni.energia	2
hr.ponuda.hardver.komponente	2
hr.alt.cellular.gsm.iphone	2
de.comp.office-pakete.ms-office.outlook	1
hr.ponuda.hardver.periferije	1
de.comp.office-pakete.ms-office.excel	1
de.comp.lang.perl	1
nl.comp.os.linux.techniek	1
TOTAL: 20	283

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

Groups	Count
pl.sci.matematyka	13
pl.sci.historia	8
TOTAL: 2	21

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	549
EMP (md5)	53
HTML post	6
Too many newsgroups	3
Scoring filter (12)	1
TOTAL: 5	612

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	31609	1477	29043	220	0	4%	24:00:03
2	icm	40833	1170	28116	244	5	2%	23:59:58
3	nask	25339	147	15989	203	2	0%	23:57:33
4	poznan	4834	46	3346	19	0	0%	23:51:09
5	okapi	0	0	0	0	3254	0%	23:48:02
TOTAL: 5		102615	2840	76494	686	3261	2%	119:36:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	193.4 MB	47.7 MB	241.2 MB	2.9 KB/s	174.6 KB	23:59:58
2	panorama	7.3 MB	795.8 KB	8.0 MB	0.1 KB/s	4.8 KB	24:00:03
3	nask	1.4 MB	109.4 MB	110.8 MB	1.3 KB/s	324.1 KB	23:57:33
4	poznan	134.3 KB	58.2 KB	192.5 KB	0.0 KB/s	3.0 KB	23:51:09
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:48:02
TOTAL: 5		202.2 MB	158.0 MB	360.2 MB	0.9 KB/s	104.6 KB	119:36:45

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	pc-skrzep2.cm.p.lodz.pl	288	306	429.4 KB	288	0	00:00:06
2	web.man.lodz.pl	288	40	37.7 KB	16	0	00:00:21
3	ip-176.105.135.22.tvsat364.lodz.pl	2	5	6.1 KB	1	0	00:30:28
4	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 4		582	351	473.2 KB	305	4	00:46:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	306	429.4 KB	288	0	00:00:06
2	*.man.lodz.pl	676	40	37.7 KB	16	4	00:00:27
3	*.105.135.22.tvsat364.lodz.pl	2	5	6.1 KB	1	0	00:30:28
4	*.cbmm.lodz.pl	2	0	0.0 KB	0	0	00:14:51
5	*.toya.net.pl	66	0	0.0 KB	0	0	00:00:06
TOTAL: 5		1034	351	473.2 KB	305	4	00:46:00

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
ip-176.105.135.22.tvsat364.lodz.pl	0.007	0.022	00:30:28
router2.cbmm.lodz.pl	0.012	0.017	00:14:51
web.man.lodz.pl	0.946	3.428	00:00:21
pc-skrzep2.cm.p.lodz.pl	1.032	3.412	00:00:06
staticline41435.toya.net.pl	0.238	0.775	00:00:06
mon.man.lodz.pl	1.059	3.313	00:00:04
david.man.lodz.pl	0.384	1.048	00:00:01
isvcs01.man.lodz.pl	0.029	0.050	00:00:00
TOTAL: 8	3.707	12.065	00:46:00

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	66
router2.cbmm.lodz.pl	2
TOTAL: 4	452

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip-176.105.135.22.tvsat364.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	306	87.2%
2	pl	45	12.8%
TOTAL: 2		351	100.0%

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

Newsgroup		Count
1	lodman.info	306
2	pl.comp.pecet	30
3	pl.comp.os.ms-windows.winnt	10
4	pl.regionalne.lodz	5
TOTAL: 4		351

Daily Usenet report

Oct 28 04:15:03 -- Oct 29 04:15:03