Daily Usenet report: Jun 15 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jun 15 05:12:14 newsfeed nnrpd[561563]: SERVER perl filter not defined
Jun 15 07:17:31 newsfeed overchan[558001]: input line too long, skipping
Jun 15 07:58:38 newsfeed nnrpd[571323]: SERVER perl filter not defined
Jun 15 09:03:11 newsfeed nnrpd[575180]: SERVER perl filter not defined
Jun 15 10:27:23 newsfeed overchan[558001]: input line too long, skipping
Jun 15 12:19:55 newsfeed overchan[558001]: input line too long, skipping
Jun 15 12:49:54 newsfeed overchan[558001]: input line too long, skipping
Jun 15 14:16:44 newsfeed nnrpd[593548]: SERVER perl filter not defined
Jun 15 16:00:46 newsfeed overchan[558001]: input line too long, skipping
Jun 15 17:00:04 newsfeed pgpverify[602967]: pgpverify: /usr/bin/gpg1: no such file
Jun 15 17:00:06 newsfeed pgpverify[602981]: pgpverify: /usr/bin/gpg1: no such file
Jun 15 19:16:09 newsfeed overchan[558001]: input line too long, skipping
Jun 15 20:13:24 newsfeed nnrpd[613728]: SERVER perl filter not defined
Jun 15 20:33:34 newsfeed nnrpd[614844]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	991567	95.2%	111.8 MB	94.7%
innfeed	35435	3.4%	4.2 MB	3.6%
innd	11064	1.1%	1.7 MB	1.4%
nnrpd	3682	0.4%	347.5 KB	0.3%
controlchan	23	0.0%	5.0 KB	0.0%
overchan	7	0.0%	1.1 KB	0.0%
pgpverify	2	0.0%	0.2 KB	0.0%
TOTAL: 7	1041780	100.0%	118.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	982937	99.4%
Negative hits	6004	0.6%
Positive hits	187	0.0%
Cache misses	25	0.0%
TOTAL: 4	989153	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.835	0.0%	77	0.000	10.844	90.667
article cleanup	00:00:05.578	0.0%	987363	0.003	0.006	0.016
article logging	00:00:17.286	0.0%	987665	0.012	0.018	0.027
article parse	00:09:22.001	0.7%	158371877	0.003	0.004	0.005
article write	00:05:50.324	0.4%	987127	0.181	0.355	0.614
artlog/artcncl	00:00:00.001	0.0%	77	0.000	0.013	1.000
data move	00:00:44.374	0.1%	165590429	0.000	0.000	0.000
hisgrep/artcncl	00:00:00.108	0.0%	62	0.000	1.742	7.000
hishave/artcncl	00:00:00.004	0.0%	77	0.000	0.052	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:33.865	0.2%	993522	0.090	0.215	1.544
history sync	00:00:00.004	0.0%	290	0.000	0.014	0.500
history write	00:16:33.426	1.1%	987359	0.162	1.006	10.100
hiswrite/artcncl	00:00:00.002	0.0%	15	0.000	0.133	0.500
idle	21:56:00.238	91.4%	156203193	0.358	0.505	0.788
nntp read	00:29:56.820	2.1%	157705268	0.010	0.011	0.013
overview write	00:00:02.250	0.0%	987127	0.001	0.002	0.004
perl filter	00:44:06.118	3.1%	987359	1.950	2.680	3.636
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:23.061	0.0%	1984239	0.009	0.012	0.015
TOTAL: 24:00:02.573	23:46:56.295	99.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.046	0.0%	38339	0.000	0.001	0.010
article prepare	00:00:00.001	0.0%	14028	0.000	0.000	0.013
article read	00:00:10.336	0.0%	3488	0.000	2.963	23.520
backlog stats	00:00:00.040	0.0%	100566	0.000	0.000	0.004
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:00.416	0.0%	47844	0.000	0.009	0.029
data write	00:00:01.056	0.0%	38194	0.000	0.028	0.082
idle	23:53:46.584	100.0%	100566	544.673	855.424	1931.712
status file	00:00:09.488	0.0%	13265	0.376	0.715	5.883
TOTAL: 23:54:10.512	23:54:07.967	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:48.386	67.0%	2878	0.000	16.812	10010.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.076	0.1%	6235	0.000	0.012	0.500
readart	00:00:00.007	0.0%	27	0.000	0.259	2.333
TOTAL: 00:01:12.271	00:00:48.469	67.1%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
group-admin@isc.org	0	0	2	2	0	2
TOTAL	0	0	2	2	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	202	991163	991012	0	151	99%	91:22:06
2	news.icm.edu.pl	47	259	28	146	85	10%	14:22:24
3	localhost	1447	6	6	0	0	100%	00:00:00
TOTAL: 3		1696	991428	991046	146	236	99%	105:44:30

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	373.3 GB	863.1 KB	1.3 MB	373.3 GB	99%	395.0 KB
2	news.icm.edu.pl	443.4 KB	0.0 KB	1.2 MB	1.6 MB	26%	14.7 KB
3	localhost	11.8 KB	0.0 KB	0.0 KB	11.8 KB	100%	2.0 KB
TOTAL: 3		373.3 GB	863.1 KB	2.5 MB	373.4 GB	99%	394.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 15 04:15:02 - 04:59:59	21478	2.2%	7.96	11.0 GB	2.9%	4264.18
Jun 15 05:00:00 - 05:59:59	27658	2.8%	7.68	14.3 GB	3.8%	4154.10
Jun 15 06:00:00 - 06:59:59	27679	2.8%	7.69	13.6 GB	3.6%	3956.92
Jun 15 07:00:00 - 07:59:59	29271	3.0%	8.13	15.0 GB	4.0%	4374.01
Jun 15 08:00:00 - 08:59:59	30842	3.1%	8.57	15.8 GB	4.2%	4590.47
Jun 15 09:00:00 - 09:59:59	31011	3.1%	8.61	14.9 GB	4.0%	4340.52
Jun 15 10:00:00 - 10:59:59	31625	3.2%	8.78	14.3 GB	3.8%	4177.94
Jun 15 11:00:00 - 11:59:59	32294	3.3%	8.97	16.0 GB	4.3%	4658.45
Jun 15 12:00:00 - 12:59:59	34259	3.5%	9.52	15.8 GB	4.2%	4591.19
Jun 15 13:00:00 - 13:59:59	33200	3.4%	9.22	15.5 GB	4.2%	4519.65
Jun 15 14:00:00 - 14:59:59	32026	3.2%	8.90	14.7 GB	3.9%	4284.22
Jun 15 15:00:00 - 15:59:59	34455	3.5%	9.57	14.0 GB	3.7%	4078.92
Jun 15 16:00:00 - 16:59:59	42455	4.3%	11.79	17.5 GB	4.7%	5096.12
Jun 15 17:00:00 - 17:59:59	33730	3.4%	9.37	14.7 GB	3.9%	4284.47
Jun 15 18:00:00 - 18:59:59	32793	3.3%	9.11	15.2 GB	4.1%	4435.32
Jun 15 19:00:00 - 19:59:59	32014	3.2%	8.89	14.9 GB	4.0%	4338.74
Jun 15 20:00:00 - 20:59:59	34339	3.5%	9.54	15.9 GB	4.3%	4625.82
Jun 15 21:00:00 - 21:59:59	37871	3.8%	10.52	15.2 GB	4.1%	4418.20
Jun 15 22:00:00 - 22:59:59	34692	3.5%	9.64	15.4 GB	4.1%	4475.54
Jun 15 23:00:00 - 23:59:59	72617	7.3%	20.17	18.7 GB	5.0%	5454.89
Jun 16 00:00:00 - 00:59:59	92386	9.3%	25.66	18.5 GB	4.9%	5380.55
Jun 16 01:00:00 - 01:59:59	70062	7.1%	19.46	17.4 GB	4.7%	5074.97
Jun 16 02:00:00 - 02:59:59	63912	6.4%	17.75	16.8 GB	4.5%	4900.40
Jun 16 03:00:00 - 03:59:59	61935	6.3%	17.20	14.7 GB	3.9%	4270.87
Jun 16 04:00:00 - 04:15:02	16346	1.6%	18.12	3.9 GB	1.0%	4477.47
TOTAL: 24:00:00	990950	100.0%	11.47	373.5 GB	100.0%	4533.33

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	455	133	4	2	316
2	news.icm.edu.pl	85	0	0	0	85
TOTAL: 2		540	133	4	2	401

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	50
comp.mobile.android	27
it.tlc.cellulari.android	24
it.comp.os.win.windows10	18
alt.comp.software.firefox	7
alt.comp.software.seamonkey	5
it.discussioni.energia	1
it.comp.os.linux.ubuntu	1
TOTAL: 8	133

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

Groups	Count
pl.praca.oferowana	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	91
Binary in non-binary group	5
Scoring filter (9)	1
TOTAL: 3	97

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	16260	2531	6910	160	1	1	15%	23:59:57
2	panorama	33351	351	10981	96	3	27034	1%	23:59:57
3	nask	0	0	0	0	0	6981	0%	23:57:47
4	poznan	28	0	28	0	0	0	0%	01:12:48
5	okapi	0	0	0	0	0	997	0%	23:57:47
TOTAL: 5		49639	2882	17919	256	4	35013	5%	97:08:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	9.1 MB	777.2 KB	9.9 MB	0.1 KB/s	3.8 KB	23:59:57
2	panorama	1.2 MB	474.9 KB	1.7 MB	0.0 KB/s	3.8 KB	23:59:57
3	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:47
4	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	01:12:48
5	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:47
TOTAL: 5		10.3 MB	1.2 MB	11.6 MB	0.0 KB/s	3.8 KB	97:08:16

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	24	26.3 KB	9	0	00:00:09
2	212.90.61.180	1	2	3.3 KB	1	0	00:00:01
3	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 3		295	26	29.6 KB	10	6	00:01:12

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	294	24	26.3 KB	9	6	00:00:09
2	unresolved	172	2	3.3 KB	1	0	00:01:02
TOTAL: 2		466	26	29.6 KB	10	6	00:01:12

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
45.33.101.246	0.279	0.343	00:00:31
23.224.186.73	0.005	0.012	00:00:16
192.241.209.73	0.003	0.005	00:00:09
web.man.lodz.pl	0.850	1.842	00:00:09
80.111.142.213	0.005	0.032	00:00:01
212.51.192.185	0.258	0.547	00:00:01
212.90.61.180	0.025	0.004	00:00:01
178.62.6.247	0.015	0.051	00:00:00
isvcs01.man.lodz.pl	0.024	0.062	00:00:00
TOTAL: 9	1.464	2.898	00:01:12

Curious NNRP server explorers [Top 20]:

System	Conn
212.51.192.185	96
45.33.101.246	60
178.62.6.247	8
80.111.142.213	4
23.224.186.73	2
192.241.209.73	1
TOTAL: 6	171

NNRP unrecognized commands (by host):

System	Conn
178.62.6.247	42
23.224.186.73	3
TOTAL: 2	45

NNRP unrecognized commands (by command):

Command	Count
Connection: keep-alive	7
Accept: /	7
Host: 212.191.2.21:119	7
Accept-Encoding: gzip, deflate	7
User-Agent: Mozilla/5.0 (Windows NT 10.0...	6
GET /stalker_portal/c/version.js HTTP/1....	1
GET /system_api.php HTTP/1.1	1
GET /c/version.js HTTP/1.1	1
User-Agent: Mozilla/5.0 (Windows NT 6.1;...	1
#026#003#001	1
GET /stream/live.php HTTP/1.1	1
#001	1
GET / HTTP/1.1	1
GET /streaming/clients_live.php HTTP/1.1	1
GET /flu/403.html HTTP/1.1	1
†üHFÜ#013.Êê0ÉM#030þ¤#025ifä3#031àÏÍ×ý	1
TOTAL: 16	45

NNRP client timeouts [Top 20]:

System	Conn	Peer
23.224.186.73	1	1
TOTAL: 1	1	2

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	24	92.3%
2	lodman	2	7.7%
TOTAL: 2		26	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	16
2	pl.comp.pecet	8
3	lodman.info	2
TOTAL: 3		26

Daily Usenet report

Jun 15 04:15:02 -- Jun 16 04:15:02