Daily Usenet report: Jul 13 04:15:01

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jul 13 05:03:42 newsfeed nnrpd[111801]: SERVER perl filter not defined
Jul 13 09:25:28 newsfeed nnrpd[125306]: SERVER perl filter not defined
Jul 13 09:40:42 newsfeed nnrpd[125877]: SERVER perl filter not defined
Jul 13 09:42:15 newsfeed nnrpd[125902]: SERVER perl filter not defined
Jul 13 09:43:04 newsfeed nnrpd[125910]: SERVER perl filter not defined
Jul 13 22:40:01 newsfeed nnrpd[159723]: SERVER perl filter not defined
Jul 13 23:12:10 newsfeed nnrpd[161149]: SERVER perl filter not defined
Jul 14 00:39:55 newsfeed nnrpd[165078]: SERVER perl filter not defined
Jul 14 03:14:30 newsfeed nnrpd[171924]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	137758	92.5%	15.8 MB	93.3%
nnrpd	7724	5.2%	769.3 KB	4.4%
innd	2183	1.5%	244.6 KB	1.4%
innfeed	1311	0.9%	147.3 KB	0.9%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	148977	100.0%	16.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	137000	99.4%
Negative hits	707	0.5%
Positive hits	115	0.1%
Cache misses	14	0.0%
TOTAL: 4	137836	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.770	0.0%	32	0.000	24.062	185.000
article cleanup	00:00:00.740	0.0%	137620	0.000	0.005	0.014
article logging	00:00:02.862	0.0%	137712	0.004	0.021	0.036
article parse	00:00:04.012	0.0%	447551	0.004	0.009	0.014
article write	00:00:16.416	0.0%	137427	0.040	0.119	0.844
artlog/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
data move	00:00:00.639	0.0%	583204	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.297	0.0%	32	0.000	9.281	30.000
hishave/artcncl	00:00:00.144	0.0%	32	0.000	4.500	16.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:29:32.336	2.1%	138417	9.300	12.804	22.235
history sync	00:00:00.022	0.0%	331	0.000	0.066	1.000
history write	00:28:02.363	1.9%	137613	8.335	12.225	20.290
idle	22:59:53.230	95.8%	441992	85.867	187.318	428.111
nntp read	00:00:05.937	0.0%	387166	0.008	0.015	0.024
overview write	00:00:00.396	0.0%	137427	0.000	0.003	0.012
perl filter	00:02:06.578	0.1%	137613	0.647	0.920	1.399
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:04.392	0.0%	309569	0.007	0.014	0.022
TOTAL: 24:00:33.842	24:00:11.134	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.053	0.0%	34646	0.000	0.002	0.030
article prepare	00:00:00.000	0.0%	64	0.000	0.000	0.000
article read	00:00:00.000	0.0%	16	0.000	0.000	0.000
backlog stats	00:00:00.032	0.0%	54964	0.000	0.001	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.404	0.0%	42001	0.000	0.010	0.029
data write	00:00:00.323	0.0%	7534	0.000	0.043	0.132
idle	23:57:57.978	100.0%	54964	370.102	1569.718	4924.410
status file	00:00:00.189	0.0%	341	0.000	0.554	11.000
TOTAL: 23:58:00.466	23:57:58.979	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:20.935	63.8%	4261	0.000	18.994	10019.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.187	0.1%	10354	0.000	0.018	0.500
readart	00:00:27.384	21.6%	5450	0.000	5.025	5.043
TOTAL: 00:02:06.928	00:01:48.506	85.5%	-	-	-	-

Control commands to INND:

Command	Number
flush	27
flushlogs	2
go	2
logmode	2
lowmark	1
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	193

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	102	137481	137398	0	83	99%	39:12:08
2	news.icm.edu.pl	36	207	10	87	110	4%	09:09:33
3	localhost	10	9	9	0	0	100%	00:00:00
TOTAL: 3		148	137697	137417	87	193	99%	48:21:41

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	1.3 GB	114.0 KB	296.4 KB	1.3 GB	99%	10.2 KB
2	news.icm.edu.pl	161.9 KB	13.8 KB	1.5 MB	1.6 MB	9%	13.9 KB
3	localhost	12.7 KB	0.0 KB	0.0 KB	12.7 KB	100%	1.4 KB
TOTAL: 3		1.3 GB	127.8 KB	1.7 MB	1.3 GB	99%	10.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 13 04:15:01 - 04:59:59	3152	2.3%	1.17	37.4 MB	2.7%	14.18
Jul 13 05:00:00 - 05:59:59	3415	2.5%	0.95	32.5 MB	2.4%	9.26
Jul 13 06:00:00 - 06:59:59	4665	3.4%	1.30	45.6 MB	3.3%	12.96
Jul 13 07:00:00 - 07:59:59	5868	4.3%	1.63	61.5 MB	4.5%	17.50
Jul 13 08:00:00 - 08:59:59	4920	3.6%	1.37	56.6 MB	4.1%	16.09
Jul 13 09:00:00 - 09:59:59	5202	3.8%	1.45	59.7 MB	4.4%	16.99
Jul 13 10:00:00 - 10:59:59	6561	4.8%	1.82	70.9 MB	5.2%	20.17
Jul 13 11:00:00 - 11:59:59	5071	3.7%	1.41	54.5 MB	4.0%	15.50
Jul 13 12:00:00 - 12:59:59	6253	4.5%	1.74	50.6 MB	3.7%	14.41
Jul 13 13:00:00 - 13:59:59	5921	4.3%	1.64	56.8 MB	4.2%	16.15
Jul 13 14:00:00 - 14:59:59	6841	5.0%	1.90	54.1 MB	4.0%	15.39
Jul 13 15:00:00 - 15:59:59	7866	5.7%	2.19	61.0 MB	4.5%	17.35
Jul 13 16:00:00 - 16:59:59	7090	5.2%	1.97	65.4 MB	4.8%	18.61
Jul 13 17:00:00 - 17:59:59	10367	7.5%	2.88	85.9 MB	6.3%	24.44
Jul 13 18:00:00 - 18:59:59	5483	4.0%	1.52	58.5 MB	4.3%	16.65
Jul 13 19:00:00 - 19:59:59	6861	5.0%	1.91	66.7 MB	4.9%	18.97
Jul 13 20:00:00 - 20:59:59	6129	4.5%	1.70	69.5 MB	5.1%	19.76
Jul 13 21:00:00 - 21:59:59	4604	3.3%	1.28	49.8 MB	3.6%	14.16
Jul 13 22:00:00 - 22:59:59	4361	3.2%	1.21	48.3 MB	3.5%	13.73
Jul 13 23:00:00 - 23:59:59	4411	3.2%	1.23	48.3 MB	3.5%	13.74
Jul 14 00:00:00 - 00:59:59	4346	3.2%	1.21	44.0 MB	3.2%	12.50
Jul 14 01:00:00 - 01:59:59	6933	5.0%	1.93	74.5 MB	5.5%	21.20
Jul 14 02:00:00 - 02:59:59	5163	3.8%	1.43	53.1 MB	3.9%	15.09
Jul 14 03:00:00 - 03:59:59	4836	3.5%	1.34	50.5 MB	3.7%	14.35
Jul 14 04:00:00 - 04:15:02	1122	0.8%	1.24	11.1 MB	0.8%	12.62
TOTAL: 24:00:01	137441	100.0%	1.59	1.3 GB	100.0%	16.20

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	175	76	6	1	92
2	news.icm.edu.pl	110	0	1	0	109
TOTAL: 2		285	76	7	1	201

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	30
rocksolid.nodes.help	11
eternal-september.test	7
comp.sys.raspberry-pi	4
alt.comp.software.firefox	3
comp.mobile.android	3
eternal-september.talk	3
it.comp.os.win.windows10	2
alt.comp.software.seamonkey	2
eternal-september.grouprequests	2
uk.radio.amateur.moderated	1
fido7.ru.microchip	1
fido7.r50.crisis	1
grisbi.test	1
it.tlc.cellulari.android	1
fr.comp.os.android	1
fido7.english-tutor	1
aioe.news.helpdesk	1
fr.rec.loisirs-creatifs	1
TOTAL: 19	76

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

Groups	Count
pl.sci.historia	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	106
Binary in non-binary group	3
TOTAL: 2	109

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	92
	TOTAL: 1	92
TOTAL: 1		92

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	7313	15	6639	1	0	0%	24:02:56
2	poznan	11	0	10	0	0	0%	01:40:07
3	panorama	0	0	0	0	34502	0%	23:57:48
4	nask	0	0	0	0	31840	0%	23:57:48
5	okapi	0	0	0	0	588	0%	24:05:36
TOTAL: 5		7324	15	6649	1	66930	0%	97:44:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	55.2 KB	1.3 KB	56.5 KB	3.5 KB	24:02:56
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	01:40:07
3	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
4	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
5	okapi	0.0 KB	0.0 KB	0.0 KB	0	24:05:36
TOTAL: 5		55.2 KB	1.3 KB	56.5 KB	3.5 KB	97:44:15

Backlog files shrunk by innfeed:

Server	Size
panorama	2.9 MB
TOTAL: 1	2.9 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	20	21.2 KB	9	0	00:00:10
2	isvcs01.man.lodz.pl	9	0	0.0 KB	0	9	00:00:00
TOTAL: 2		297	20	21.2 KB	9	9	00:02:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	1736	20	21.2 KB	9	9	00:00:24
2	*.stretchoid.com	1	0	0.0 KB	0	0	00:00:09
3	*.nycmny.fios.verizon.net	1	0	0.0 KB	0	0	00:00:31
4	*.79.44.78.socradar-curiosity-wide-scan-project.socradar.com	1	0	0.0 KB	0	0	00:00:10
5	unresolved	105	0	0.0 KB	0	0	00:00:51
TOTAL: 5		1844	20	21.2 KB	9	9	00:02:07

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
80.111.142.213	0.016	0.026	00:00:38
pool-100-38-239-226.nycmny.fios.verizon.net	0.076	0.198	00:00:31
nms1.man.lodz.pl	4.356	6.561	00:00:12
167.94.138.57	0.010	0.027	00:00:11
web.man.lodz.pl	0.983	1.333	00:00:10
45.79.44.78.socradar-curiosity-wide-scan-project.socradar.com	0.010	0.000	00:00:10
azpdcsb56.stretchoid.com	0.005	0.000	00:00:09
212.51.192.185	0.299	0.452	00:00:01
isvcs01.man.lodz.pl	0.060	0.039	00:00:00
71.6.134.233	0.003	0.007	00:00:00
62.122.184.113	0.000	0.011	00:00:00
TOTAL: 11	5.818	8.654	00:02:07

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	1439
212.51.192.185	96
80.111.142.213	4
167.94.138.57	3
pool-100-38-239-226.nycmny.fios.verizon.net	1
azpdcsb56.stretchoid.com	1
45.79.44.78.socradar-curiosity-wide-scan-project.socradar.com	1
71.6.134.233	1
62.122.184.113	1
TOTAL: 9	1547

NNRP unrecognized commands (by host):

System	Conn
167.94.138.57	1
62.122.184.113	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
#003	1
EHLO www.censys.io	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.138.57	1	2
62.122.184.113	1	1
TOTAL: 2	2	3

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	20	100.0%
TOTAL: 1		20	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	20
TOTAL: 1		20

Daily Usenet report

Jul 13 04:15:01 -- Jul 14 04:15:02