Daily Usenet report: Feb 24 04:15:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Feb 24 13:41:30 newsfeed nnrpd[18235]: SERVER perl filter not defined
Feb 24 13:43:20 newsfeed nnrpd[18277]: SERVER perl filter not defined
Feb 24 13:58:30 newsfeed nnrpd[18835]: SERVER perl filter not defined
Feb 24 15:55:54 newsfeed nnrpd[22754]: SERVER perl filter not defined
Feb 24 15:59:30 newsfeed nnrpd[22802]: SERVER perl filter not defined
Feb 24 17:22:48 newsfeed nnrpd[25542]: SERVER perl filter not defined
Feb 24 17:23:19 newsfeed nnrpd[25548]: SERVER perl filter not defined
Feb 24 17:37:56 newsfeed nnrpd[26102]: SERVER perl filter not defined
Feb 24 20:13:43 newsfeed nnrpd[31220]: SERVER perl filter not defined
Feb 24 20:20:38 newsfeed nnrpd[31513]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	364355	94.2%	41.2 MB	93.3%
innd	7970	2.1%	1.2 MB	2.8%
nnrpd	7201	1.9%	729.2 KB	1.6%
innfeed	7062	1.8%	1008.6 KB	2.2%
controlchan	8	0.0%	0.9 KB	0.0%
overchan	4	0.0%	0.7 KB	0.0%
TOTAL: 6	386600	100.0%	44.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	361504	92.8%
Positive hits	18205	4.7%
Negative hits	9715	2.5%
Cache misses	116	0.0%
TOTAL: 4	389540	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.374	0.0%	315	0.000	10.711	561.000
article cleanup	00:00:04.195	0.0%	364204	0.000	0.012	0.056
article logging	00:00:09.036	0.0%	364313	0.000	0.025	0.124
article parse	00:07:58.794	0.6%	29586095	0.008	0.016	0.033
article write	00:03:03.990	0.2%	361301	0.135	0.509	6.830
artlog/artcncl	00:00:00.007	0.0%	305	0.000	0.023	1.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:29.115	0.0%	31505884	0.000	0.001	0.010
hisgrep/artcncl	00:00:00.747	0.0%	303	0.000	2.465	288.000
hishave/artcncl	00:00:00.298	0.0%	315	0.000	0.946	15.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:28:08.334	2.0%	389831	0.034	4.331	17.769
history sync	00:00:00.031	0.0%	604	0.000	0.051	1.000
history write	00:45:26.070	3.2%	362084	1.869	7.529	33.064
hiswrite/artcncl	00:00:00.014	0.0%	12	0.000	1.167	3.500
idle	21:36:16.407	90.0%	27621527	0.568	2.816	17.618
nntp read	00:09:59.913	0.7%	29460978	0.012	0.020	0.033
overview write	00:00:02.119	0.0%	361301	0.000	0.006	0.044
perl filter	00:38:17.098	2.7%	362082	3.216	6.344	9.517
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:50.773	0.1%	760939	0.026	0.067	0.156
TOTAL: 24:00:03.968	23:50:50.315	99.4%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.128	0.0%	38316	0.000	0.003	1.000
article prepare	00:00:00.004	0.0%	12756	0.000	0.000	0.083
article read	00:00:00.126	0.0%	3136	0.000	0.040	1.000
backlog stats	00:00:00.141	0.0%	265014	0.000	0.001	0.018
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.456	0.0%	165430	0.000	0.009	1.000
data write	00:00:03.267	0.0%	127409	0.000	0.026	0.947
idle	23:58:12.611	100.0%	265014	0.000	325.615	19133.000
status file	00:00:01.682	0.0%	271	0.000	6.207	226.500
TOTAL: 23:58:24.725	23:58:19.415	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.389	0.0%	92	1.055	4.228	8.946
idle	06:18:33.469	99.9%	7541	0.000	3011.997	450237.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.451	0.0%	17194	0.000	0.026	0.778
readart	00:00:02.356	0.0%	592	0.000	3.980	35.706
TOTAL: 06:18:53.692	06:18:36.665	99.9%	-	-	-	-

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.multimedia.canada	y
alt.binaries.multimedia.terrorism.false-flag	y
alt.binaries.multimedia.united-states	y
alt.binaries.news	y
TOTAL	4

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
presidentobola@mail.com	4	0	0	0	4	4
TOTAL	4	0	0	0	4	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	194	361268	358789	99	2380	99%	82:50:21
2	news.nask.pl	2	18036	2096	15446	494	11%	23:38:33
3	news.icm.edu.pl	49	277	22	245	10	7%	18:00:07
4	localhost	11	10	10	0	0	100%	00:00:00
TOTAL: 4		256	379591	360917	15790	2884	95%	124:29:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	63.3 GB	7.3 MB	35.6 MB	63.3 GB	99%	183.9 KB
2	news.nask.pl	7.6 MB	1.4 MB	1.5 MB	10.4 MB	72%	4.1 KB
3	news.icm.edu.pl	590.1 KB	23.3 KB	448.1 KB	1.0 MB	55%	33.2 KB
4	localhost	15.2 KB	0.0 KB	0.0 KB	15.2 KB	100%	1.5 KB
TOTAL: 4		63.3 GB	8.7 MB	37.5 MB	63.3 GB	99%	182.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 24 04:15:01 - 04:59:59	11787	3.3%	4.37	2.4 GB	3.9%	948.62
Feb 24 05:00:00 - 05:59:59	9703	2.7%	2.70	1.2 GB	1.9%	344.92
Feb 24 06:00:00 - 06:59:59	9504	2.6%	2.64	1.3 GB	2.1%	378.48
Feb 24 07:00:00 - 07:59:59	10990	3.0%	3.05	1.5 GB	2.3%	431.10
Feb 24 08:00:00 - 08:59:59	11366	3.1%	3.16	1.3 GB	2.1%	385.63
Feb 24 09:00:00 - 09:59:59	12723	3.5%	3.53	1.2 GB	1.9%	355.34
Feb 24 10:00:00 - 10:59:59	12641	3.5%	3.51	1020.3 MB	1.6%	290.21
Feb 24 11:00:00 - 11:59:59	8903	2.5%	2.47	887.0 MB	1.4%	252.31
Feb 24 12:00:00 - 12:59:59	9636	2.7%	2.68	955.4 MB	1.5%	271.77
Feb 24 13:00:00 - 13:59:59	13415	3.7%	3.73	1.2 GB	1.9%	352.14
Feb 24 14:00:00 - 14:59:59	17569	4.9%	4.88	1.4 GB	2.2%	401.91
Feb 24 15:00:00 - 15:59:59	14450	4.0%	4.01	1.5 GB	2.4%	447.44
Feb 24 16:00:00 - 16:59:59	14576	4.0%	4.05	1.6 GB	2.4%	452.18
Feb 24 17:00:00 - 17:59:59	13816	3.8%	3.84	1.6 GB	2.5%	464.48
Feb 24 18:00:00 - 18:59:59	10463	2.9%	2.91	1.1 GB	1.8%	334.27
Feb 24 19:00:00 - 19:59:59	12893	3.6%	3.58	1.4 GB	2.2%	408.10
Feb 24 20:00:00 - 20:59:59	12173	3.4%	3.38	1.3 GB	2.1%	387.01
Feb 24 21:00:00 - 21:59:59	9373	2.6%	2.60	1.0 GB	1.6%	295.25
Feb 24 22:00:00 - 22:59:59	7862	2.2%	2.18	859.5 MB	1.3%	244.48
Feb 24 23:00:00 - 23:59:59	8121	2.2%	2.26	744.2 MB	1.1%	211.69
Feb 25 00:00:00 - 00:59:59	27521	7.6%	7.64	7.7 GB	12.1%	2233.23
Feb 25 01:00:00 - 01:59:59	28582	7.9%	7.94	7.1 GB	11.2%	2071.18
Feb 25 02:00:00 - 02:59:59	35909	9.9%	9.97	11.6 GB	18.2%	3366.62
Feb 25 03:00:00 - 03:59:59	32922	9.1%	9.14	10.6 GB	16.7%	3087.97
Feb 25 04:00:00 - 04:15:02	4139	1.1%	4.59	976.6 MB	1.5%	1108.66
TOTAL: 24:00:01	361037	100.0%	4.18	63.4 GB	100.0%	769.02

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	2483	273	1628	13	569
2	news.nask.pl	520	9	492	11	8
3	news.icm.edu.pl	10	0	1	0	9
TOTAL: 3		3013	282	2121	24	586

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	92
comp.sys.raspberry-pi	34
it.comp.os.linux.ubuntu	29
it.comp.os.win.windows8	23
nl.actueel	16
it.comp.os.win.windows7	15
it.tlc.cellulari.android	12
hr.alt.cellular.gsm.android	12
comp.mobile.android	11
comp.mobile.ipad	10
hr.alt.cellular.gsm.iphone	8
de.comp.lang.vbclassic	4
it.discussioni.energia	4
hr.ponuda.hardver.komponente	4
de.comp.office-pakete.ms-office.outlook	3
de.rec.sf.startrek	2
alt.sex.telephones	2
hr.ponuda.hardver.konfiguracije	1
TOTAL: 18	282

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

Groups	Count
pl.praca.oferowana	13
pl.sci.historia	11
TOTAL: 2	24

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	405
HTML post	56
EMP (md5)	13
Attached HTML file	1
TOTAL: 4	475

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	panorama	42521	1011	37082	142	0	2%	23:54:18
2	icm	55020	953	35812	908	27	1%	23:55:09
3	nask	25803	158	16358	2	1	0%	23:53:23
4	poznan	2731	7	1881	1	0	0%	23:54:04
5	okapi	0	0	0	0	2448	0%	23:44:42
TOTAL: 5		126075	2129	91133	1053	2476	1%	119:21:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	13.5 MB	13.7 MB	27.1 MB	0.3 KB/s	14.9 KB	23:55:09
2	panorama	4.1 MB	440.3 KB	4.5 MB	0.1 KB/s	4.0 KB	23:54:18
3	nask	964.1 KB	13.7 KB	977.8 KB	0.0 KB/s	6.1 KB	23:53:23
4	poznan	139.7 KB	1.3 KB	141.0 KB	0.0 KB/s	17.6 KB	23:54:04
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:44:42
TOTAL: 5		18.6 MB	14.1 MB	32.7 MB	0.1 KB/s	10.5 KB	119:21:36

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	398	599.2 KB	288	0	00:00:07
2	pc-212-51-218-225.p.lodz.pl	8	78	180.8 KB	7	0	02:47:07
3	lze200.lze.lodz.pl	10	65	124.3 KB	11	0	02:32:30
4	web.man.lodz.pl	289	50	45.1 KB	24	0	00:00:16
5	212.51.203.199	2	1	3.8 KB	1	0	00:04:22
6	isvcs01.man.lodz.pl	10	0	0.0 KB	0	10	00:00:00
TOTAL: 6		607	592	953.2 KB	331	10	06:18:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cm.p.lodz.pl	288	398	599.2 KB	288	0	00:00:07
2	*.p.lodz.pl	8	78	180.8 KB	7	0	02:47:07
3	*.lze.lodz.pl	10	65	124.3 KB	11	0	02:32:30
4	*.man.lodz.pl	683	50	45.1 KB	24	10	00:00:22
5	unresolved	8	1	3.8 KB	1	0	00:58:17
6	*.elsnet.pl	2	0	0.0 KB	0	0	00:00:12
7	*.toya.net.pl	28	0	0.0 KB	0	0	00:00:15
TOTAL: 7		1027	592	953.2 KB	331	10	06:18:53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.049	0.112	02:47:07
lze200.lze.lodz.pl	0.031	0.162	02:32:30
89.38.40.181	0.103	0.238	00:37:23
212.191.87.58	0.008	0.028	00:16:31
212.51.203.199	0.021	0.025	00:04:22
web.man.lodz.pl	0.989	3.754	00:00:16
staticline41435.toya.net.pl	0.105	0.360	00:00:15
host227.elsnet.pl	0.005	0.027	00:00:12
pc-skrzep2.cm.p.lodz.pl	1.051	3.748	00:00:07
mon.man.lodz.pl	0.938	3.620	00:00:03
david.man.lodz.pl	0.300	1.200	00:00:01
isvcs01.man.lodz.pl	0.071	0.135	00:00:00
?	0.004	0.009	00:00:00
TOTAL: 13	3.675	13.418	06:18:53

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	28
89.38.40.181	4
host227.elsnet.pl	2
212.191.87.58	2
TOTAL: 6	420

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
lze200.lze.lodz.pl	6	0
pc-212-51-218-225.p.lodz.pl	5	0
89.38.40.181	1	0
TOTAL: 3	12	0

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	398	67.2%
2	pl	194	32.8%
TOTAL: 2		592	100.0%

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

Newsgroup		Count
1	lodman.info	398
2	pl.comp.pecet	51
3	pl.misc.kolej	41
4	pl.misc.elektronika	37
5	pl.comp.os.ms-windows.winnt	20
6	pl.misc.telefonia.gsm	15
7	pl.rec.dom	10
8	pl.comp.os.linux	10
9	pl.rec.kuchnia	9
10	pl.rec.radio.amatorskie	1
TOTAL: 10		592

Daily Usenet report

Feb 24 04:15:01 -- Feb 25 04:15:02