Daily Usenet report: Dec 19 04:15:03

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Dec 19 14:05:31 newsfeed controlchan[2644]: skipping newgroup shqip.politike y ymer@mulakaj.com (would be created): Empty description
Dec 19 14:22:20 newsfeed controlchan[2644]: skipping newgroup shqip.test y ymer@mulakaj.com (would be created): Empty description
Dec 19 14:25:45 newsfeed controlchan[2644]: skipping newgroup shqip.muzike y ymer@mulakaj.com (would be created): Empty description
Dec 19 14:32:29 newsfeed controlchan[2644]: skipping newgroup shqip.sport y ymer@mulakaj.com (would be created): Empty description

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3000810	97.6%	343.2 MB	97.2%
innfeed	43919	1.4%	5.2 MB	1.5%
innd	23752	0.8%	4.1 MB	1.2%
nnrpd	5073	0.2%	538.0 KB	0.1%
controlchan	8	0.0%	1.5 KB	0.0%
TOTAL: 5	3073562	100.0%	353.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2984446	94.3%
Negative hits	145909	4.6%
Positive hits	33658	1.1%
Cache misses	151	0.0%
TOTAL: 4	3164164	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.574	0.0%	252	0.000	22.119	1829.000
article cleanup	00:00:46.504	0.1%	3000979	0.006	0.015	0.027
article logging	00:01:18.728	0.1%	3001558	0.014	0.026	0.179
article parse	01:27:01.217	6.0%	279968341	0.008	0.019	0.093
article write	00:26:31.301	1.8%	2985009	0.300	0.533	2.371
artlog/artcncl	00:00:00.007	0.0%	173	0.000	0.040	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:06:07.440	0.4%	299082754	0.000	0.001	0.010
hisgrep/artcncl	00:00:00.949	0.0%	228	0.000	4.162	240.333
hishave/artcncl	00:00:00.094	0.0%	252	0.000	0.373	16.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:42:43.564	3.0%	3165581	0.050	0.810	30.683
history sync	00:00:00.010	0.0%	290	0.000	0.034	1.000
history write	01:01:45.024	4.3%	2985604	0.161	1.241	48.533
hiswrite/artcncl	00:00:00.049	0.0%	24	0.000	2.042	13.000
idle	11:28:48.918	47.8%	184242768	0.101	0.224	0.345
nntp read	01:33:45.210	6.5%	277565092	0.009	0.020	0.046
overview write	00:00:16.896	0.0%	2985009	0.000	0.006	0.014
perl filter	06:03:31.041	25.2%	2985603	4.984	7.305	10.838
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:05:41.361	0.4%	6004539	0.029	0.057	0.091
TOTAL: 24:00:14.979	22:58:23.887	95.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.227	0.0%	100865	0.000	0.002	0.125
article prepare	00:00:00.007	0.0%	26496	0.000	0.000	0.250
article read	00:02:07.480	0.1%	6613	0.000	19.277	1719.000
backlog stats	00:00:00.147	0.0%	218775	0.000	0.001	0.019
callbacks	00:00:00.000	0.0%	12	0.000	0.000	0.000
data read	00:00:01.271	0.0%	117965	0.000	0.011	0.158
data write	00:00:03.627	0.0%	84595	0.000	0.043	1.167
idle	23:57:28.587	99.8%	218775	106.875	394.234	2076.069
status file	00:00:12.723	0.0%	15402	0.000	0.826	52.083
TOTAL: 24:00:04.959	23:59:54.069	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	03:18:16.445	99.8%	32719	0.000	363.594	470106.250
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.067	0.0%	66445	0.000	0.016	6.091
readart	00:00:00.156	0.0%	37	0.000	4.216	21.000
TOTAL: 03:18:35.494	03:18:17.668	99.9%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
ymer@mulakaj.com	4	0	0	0	0	4
TOTAL	4	0	0	0	0	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	1267	3003421	2979591	8290	15540	99%	348:02:34
2	news.nask.pl	2	14678	4569	9757	352	31%	23:43:23
3	news.icm.edu.pl	47	268	41	146	81	15%	16:12:02
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		1317	3018367	2984201	18193	15973	98%	387:57:59

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	892.4 GB	2.7 GB	2.8 GB	898.0 GB	99%	314.4 KB
2	news.nask.pl	20.4 MB	1.0 MB	1.1 MB	22.5 MB	90%	4.7 KB
3	news.icm.edu.pl	963.1 KB	50.6 KB	3.1 MB	4.0 MB	23%	33.9 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		892.5 GB	2.7 GB	2.8 GB	898.0 GB	99%	313.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 19 04:15:03 - 04:59:59	65521	2.2%	24.29	21.1 GB	2.4%	8205.59
Dec 19 05:00:00 - 05:59:59	102672	3.4%	28.52	34.0 GB	3.8%	9894.06
Dec 19 06:00:00 - 06:59:59	113009	3.8%	31.39	37.2 GB	4.2%	10843.78
Dec 19 07:00:00 - 07:59:59	123902	4.2%	34.42	39.3 GB	4.4%	11446.19
Dec 19 08:00:00 - 08:59:59	139743	4.7%	38.82	40.1 GB	4.5%	11683.81
Dec 19 09:00:00 - 09:59:59	130463	4.4%	36.24	39.7 GB	4.5%	11558.02
Dec 19 10:00:00 - 10:59:59	122723	4.1%	34.09	37.6 GB	4.2%	10941.96
Dec 19 11:00:00 - 11:59:59	132278	4.4%	36.74	37.2 GB	4.2%	10833.86
Dec 19 12:00:00 - 12:59:59	121797	4.1%	33.83	36.4 GB	4.1%	10595.84
Dec 19 13:00:00 - 13:59:59	102555	3.4%	28.49	31.0 GB	3.5%	9030.91
Dec 19 14:00:00 - 14:59:59	126597	4.2%	35.17	36.0 GB	4.0%	10498.22
Dec 19 15:00:00 - 15:59:59	123435	4.1%	34.29	36.3 GB	4.1%	10558.90
Dec 19 16:00:00 - 16:59:59	123299	4.1%	34.25	36.6 GB	4.1%	10673.60
Dec 19 17:00:00 - 17:59:59	129030	4.3%	35.84	38.9 GB	4.4%	11326.15
Dec 19 18:00:00 - 18:59:59	133081	4.5%	36.97	39.2 GB	4.4%	11416.40
Dec 19 19:00:00 - 19:59:59	140005	4.7%	38.89	39.9 GB	4.5%	11627.38
Dec 19 20:00:00 - 20:59:59	142980	4.8%	39.72	39.3 GB	4.4%	11458.14
Dec 19 21:00:00 - 21:59:59	128348	4.3%	35.65	40.2 GB	4.5%	11721.12
Dec 19 22:00:00 - 22:59:59	130315	4.4%	36.20	39.7 GB	4.5%	11553.47
Dec 19 23:00:00 - 23:59:59	135470	4.5%	37.63	39.4 GB	4.4%	11462.09
Dec 20 00:00:00 - 00:59:59	105018	3.5%	29.17	32.1 GB	3.6%	9344.70
Dec 20 01:00:00 - 01:59:59	143901	4.8%	39.97	40.4 GB	4.5%	11775.65
Dec 20 02:00:00 - 02:59:59	138783	4.7%	38.55	39.7 GB	4.5%	11567.12
Dec 20 03:00:00 - 03:59:59	109534	3.7%	30.43	33.1 GB	3.7%	9648.70
Dec 20 04:00:00 - 04:15:02	19628	0.7%	21.76	6.1 GB	0.7%	7108.87
TOTAL: 23:59:59	2984087	100.0%	34.54	890.5 GB	100.0%	10807.98

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	16036	183	15045	1	807
2	news.nask.pl	433	8	329	3	93
3	news.icm.edu.pl	81	0	2	0	79
TOTAL: 3		16550	191	15376	4	979

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	94
it.comp.os.win.windows10	39
it.tlc.cellulari.android	30
comp.mobile.android	16
de.rec.sf.startrek	2
it.comp.os.linux.ubuntu	2
hr.ponuda.hardver.komponente	2
nl.comp.os.linux.techniek	1
alt.sex.telephones	1
de.comp.lang.php	1
comp.sys.raspberry-pi	1
hr.alt.cellular.gsm.android	1
comp.mobile.ipad	1
TOTAL: 13	191

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

Groups	Count
pl.praca.oferowana	2
bit.listserv.catholic	1
pl.sci.historia	1
TOTAL: 3	4

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	288
EMP (md5)	89
EMP (fsl)	19
Scoring filter (8)	1
Angle-bracket bot	1
Too many newsgroups	1
TOTAL: 6	399

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	74542	2137	46197	654	36	51828	2%	24:00:03
2	icm	34833	942	20828	1759	0	5	2%	24:07:52
3	poznan	6418	55	4457	37	0	0	0%	23:56:31
4	okapi	0	0	0	0	0	1493	0%	24:00:01
5	nask	0	0	0	0	0	10492	0%	24:00:01
TOTAL: 5		115793	3134	71482	2450	36	63818	2%	120:04:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	13.8 MB	4.2 MB	17.9 MB	0.2 KB/s	6.6 KB	24:00:03
2	icm	3.0 MB	361.8 MB	364.8 MB	4.3 KB/s	138.3 KB	24:07:52
3	poznan	207.9 KB	78.2 KB	286.1 KB	0.0 KB/s	3.1 KB	23:56:31
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:01
TOTAL: 5		17.0 MB	366.1 MB	383.0 MB	0.9 KB/s	70.2 KB	120:04:28

Backlog files shrunk by innfeed:

Server	Size
panorama	488.4 KB
okapi	488.3 KB
TOTAL: 2	976.7 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Rej	Elapsed
1	web.man.lodz.pl	288	26	22.7 KB	11	0	00:00:32
2	ip-5-172-247-203.free.aero2.net.pl	6	7	6.1 KB	2	3	00:38:12
3	staticline-31-183-142-87.toya.net.pl	1	4	3.1 KB	1	1	00:03:23
4	ip-5-172-247-245.free.aero2.net.pl	3	0	0.0 KB	0	1	00:02:31
TOTAL: 4		298	37	31.9 KB	14	5	03:18:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Rej	Elapsed
1	*.man.lodz.pl	672	26	22.7 KB	11	0	00:00:36
2	*.free.aero2.net.pl	10	7	6.1 KB	2	4	01:12:04
3	*.toya.net.pl	62	4	3.1 KB	1	1	00:03:27
4	unresolved	5	0	0.0 KB	0	0	01:35:53
5	*.ics.p.lodz.pl	1	0	0.0 KB	0	0	00:26:33
TOTAL: 5		750	37	31.9 KB	14	5	03:18:35

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
185.48.193.134	1.674	1.793	01:35:50
ip-5-172-247-203.free.aero2.net.pl	0.055	0.104	00:38:12
ip-5-172-247-230.free.aero2.net.pl	0.034	0.017	00:31:20
wireless.ics.p.lodz.pl	0.010	0.007	00:26:33
staticline-31-183-142-87.toya.net.pl	0.030	0.015	00:03:23
ip-5-172-247-245.free.aero2.net.pl	0.043	0.041	00:02:31
web.man.lodz.pl	0.848	3.941	00:00:32
staticline41435.toya.net.pl	0.208	0.772	00:00:04
mon.man.lodz.pl	0.980	3.534	00:00:03
194.247.62.73	0.008	0.008	00:00:02
71.94.21.184	0.007	0.016	00:00:01
david.man.lodz.pl	0.325	1.226	00:00:00
TOTAL: 12	4.222	11.474	03:18:35

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
staticline41435.toya.net.pl	61
71.94.21.184	2
185.48.193.134	2
194.247.62.73	1
wireless.ics.p.lodz.pl	1
ip-5-172-247-230.free.aero2.net.pl	1
TOTAL: 8	452

NNRP unrecognized commands (by host):

System	Conn
ip-5-172-247-245.free.aero2.net.pl	2
TOTAL: 1	2

NNRP unrecognized commands (by command):

Command	Count
Hello hi	1
Helo hi	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip-5-172-247-203.free.aero2.net.pl	1	0
185.48.193.134	1	0
ip-5-172-247-230.free.aero2.net.pl	1	0
TOTAL: 3	3	0

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	26	70.3%
2	lodz	11	29.7%
TOTAL: 2		37	100.0%

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

Newsgroup		Count
1	pl.comp.pecet	16
2	lodz.test	11
3	pl.comp.os.ms-windows.winnt	10
TOTAL: 3		37

Daily Usenet report

Dec 19 04:15:03 -- Dec 20 04:15:02