Daily Usenet report: Dec 15 04:15:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Dec 15 08:00:47 newsfeed nnrpd[687776]: SERVER perl filter not defined
Dec 15 14:19:42 newsfeed overchan[676411]: input line too long, skipping
Dec 15 14:37:18 newsfeed nnrpd[706367]: SERVER perl filter not defined
Dec 15 14:37:58 newsfeed nnrpd[706374]: SERVER perl filter not defined
Dec 15 14:39:22 newsfeed nnrpd[706385]: SERVER perl filter not defined
Dec 15 16:42:16 newsfeed overchan[676411]: input line too long, skipping
Dec 15 16:43:51 newsfeed overchan[676411]: input line too long, skipping
Dec 15 17:00:05 newsfeed pgpverify[714316]: pgpverify: /usr/bin/gpg1: no such file
Dec 15 17:00:07 newsfeed pgpverify[714329]: pgpverify: /usr/bin/gpg1: no such file
Dec 15 20:05:23 newsfeed overchan[676411]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	878632	96.0%	95.6 MB	95.4%
innfeed	22704	2.5%	2.7 MB	2.7%
innd	10203	1.1%	1.6 MB	1.6%
nnrpd	3419	0.4%	323.1 KB	0.3%
controlchan	23	0.0%	4.7 KB	0.0%
overchan	5	0.0%	0.8 KB	0.0%
pgpverify	2	0.0%	0.3 KB	0.0%
TOTAL: 7	914988	100.0%	100.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	874224	99.8%
Negative hits	1918	0.2%
Positive hits	146	0.0%
Cache misses	34	0.0%
TOTAL: 4	876322	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.892	0.0%	50	0.000	17.840	101.500
article cleanup	00:00:05.541	0.0%	877730	0.004	0.006	0.010
article logging	00:00:18.606	0.0%	878033	0.016	0.021	0.031
article parse	00:07:50.079	0.5%	133298191	0.003	0.004	0.006
article write	00:05:19.605	0.4%	877649	0.203	0.364	0.643
artlog/artcncl	00:00:00.000	0.0%	50	0.000	0.000	0.000
data move	00:00:36.259	0.0%	139526411	0.000	0.000	0.000
hisgrep/artcncl	00:00:00.200	0.0%	50	0.000	4.000	17.200
hishave/artcncl	00:00:00.036	0.0%	50	0.000	0.720	3.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:12:04.190	0.8%	879845	0.159	0.823	11.547
history sync	00:00:00.013	0.0%	291	0.000	0.045	0.500
history write	00:18:07.384	1.3%	877729	0.267	1.239	14.444
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	21:59:22.354	91.6%	132491845	0.437	0.597	0.825
nntp read	00:25:56.989	1.8%	132874132	0.011	0.012	0.015
overview write	00:00:02.340	0.0%	877649	0.001	0.003	0.006
perl filter	00:39:52.176	2.8%	877729	2.173	2.725	3.592
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:22.298	0.0%	1765065	0.010	0.013	0.018
TOTAL: 24:00:03.184	23:49:58.962	99.3%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.041	0.0%	30775	0.000	0.001	0.014
article prepare	00:00:00.001	0.0%	16246	0.000	0.000	0.023
article read	00:00:13.400	0.0%	4083	0.000	3.282	44.091
backlog stats	00:00:00.042	0.0%	83556	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	31	0.000	0.000	0.000
data read	00:00:00.378	0.0%	40332	0.000	0.009	0.029
data write	00:00:00.965	0.0%	31177	0.005	0.031	0.091
idle	23:55:19.635	100.0%	83556	601.333	1030.682	1950.513
status file	00:00:04.149	0.0%	7359	0.367	0.564	1.643
TOTAL: 23:55:40.692	23:55:38.611	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:30:37.994	99.1%	2783	0.000	660.436	181798.200
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.095	0.0%	5953	0.000	0.016	0.500
readart	00:00:00.000	0.0%	10	0.000	0.000	0.000
TOTAL: 00:30:54.292	00:30:38.089	99.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	160	878467	878391	0	76	99%	87:12:39
2	news.icm.edu.pl	52	149	15	129	5	10%	13:29:07
3	localhost	1445	4	4	0	0	100%	00:00:00
TOTAL: 3		1657	878620	878410	129	81	99%	100:41:46

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	313.9 GB	64.0 KB	289.4 KB	313.9 GB	99%	374.7 KB
2	news.icm.edu.pl	532.3 KB	0.0 KB	65.6 KB	597.9 KB	89%	29.9 KB
3	localhost	6.0 KB	0.0 KB	0.0 KB	6.0 KB	100%	1.5 KB
TOTAL: 3		313.9 GB	64.0 KB	355.0 KB	313.9 GB	99%	374.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 15 04:15:01 - 04:59:59	16995	1.9%	6.30	9.0 GB	2.9%	3507.40
Dec 15 05:00:00 - 05:59:59	21372	2.4%	5.94	11.1 GB	3.5%	3222.82
Dec 15 06:00:00 - 06:59:59	22840	2.6%	6.34	12.2 GB	3.9%	3562.90
Dec 15 07:00:00 - 07:59:59	23347	2.7%	6.49	12.7 GB	4.0%	3706.14
Dec 15 08:00:00 - 08:59:59	27925	3.2%	7.76	13.6 GB	4.3%	3952.78
Dec 15 09:00:00 - 09:59:59	22800	2.6%	6.33	11.5 GB	3.7%	3360.42
Dec 15 10:00:00 - 10:59:59	33695	3.8%	9.36	11.5 GB	3.6%	3337.03
Dec 15 11:00:00 - 11:59:59	74374	8.5%	20.66	15.9 GB	5.0%	4622.08
Dec 15 12:00:00 - 12:59:59	43103	4.9%	11.97	14.1 GB	4.5%	4095.93
Dec 15 13:00:00 - 13:59:59	48134	5.5%	13.37	13.5 GB	4.3%	3944.25
Dec 15 14:00:00 - 14:59:59	47983	5.5%	13.33	14.3 GB	4.5%	4153.64
Dec 15 15:00:00 - 15:59:59	52416	6.0%	14.56	14.2 GB	4.5%	4123.08
Dec 15 16:00:00 - 16:59:59	44544	5.1%	12.37	13.2 GB	4.2%	3838.64
Dec 15 17:00:00 - 17:59:59	31079	3.5%	8.63	13.2 GB	4.2%	3851.12
Dec 15 18:00:00 - 18:59:59	27243	3.1%	7.57	12.6 GB	4.0%	3674.28
Dec 15 19:00:00 - 19:59:59	29991	3.4%	8.33	11.8 GB	3.8%	3445.20
Dec 15 20:00:00 - 20:59:59	39053	4.4%	10.85	12.5 GB	4.0%	3651.83
Dec 15 21:00:00 - 21:59:59	38819	4.4%	10.78	12.5 GB	4.0%	3638.64
Dec 15 22:00:00 - 22:59:59	52780	6.0%	14.66	13.0 GB	4.1%	3788.45
Dec 15 23:00:00 - 23:59:59	30311	3.5%	8.42	12.1 GB	3.9%	3529.18
Dec 16 00:00:00 - 00:59:59	37205	4.2%	10.33	12.9 GB	4.1%	3752.89
Dec 16 01:00:00 - 01:59:59	44367	5.1%	12.32	16.1 GB	5.1%	4680.41
Dec 16 02:00:00 - 02:59:59	31283	3.6%	8.69	13.9 GB	4.4%	4047.74
Dec 16 03:00:00 - 03:59:59	28402	3.2%	7.89	13.2 GB	4.2%	3846.09
Dec 16 04:00:00 - 04:15:02	8138	0.9%	9.02	3.7 GB	1.2%	4277.45
TOTAL: 24:00:01	878199	100.0%	10.16	314.2 GB	100.0%	3813.58

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	378	69	1	6	302
2	news.icm.edu.pl	5	0	0	0	5
TOTAL: 2		383	69	1	6	307

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	40
comp.mobile.android	8
alt.comp.software.firefox	7
it.comp.os.win.windows10	5
alt.comp.software.seamonkey	3
de.comm.provider.telefonie	2
it.tlc.cellulari.android	1
it.comp.virtualizzazione	1
de.comp.lang.vbclassic	1
it.comp.os.linux.ubuntu	1
TOTAL: 10	69

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

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

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	5
TOTAL: 1	5

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	15474	3000	6318	277	0	0	19%	23:59:56
2	panorama	21315	244	8748	196	48	21620	1%	23:59:57
3	poznan	16	0	15	0	0	0	0%	00:31:00
4	okapi	0	0	0	0	0	787	0%	23:57:48
5	nask	0	0	0	0	0	6850	0%	23:57:48
TOTAL: 5		36805	3244	15081	473	48	29257	8%	96:26:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	12.2 MB	34.2 MB	46.3 MB	0.5 KB/s	14.5 KB	23:59:56
2	panorama	902.2 KB	2.0 MB	2.9 MB	0.0 KB/s	6.8 KB	23:59:57
3	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	00:31:00
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:48
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:48
TOTAL: 5		13.0 MB	36.2 MB	49.2 MB	0.1 KB/s	13.6 KB	96:26:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	10	10.1 KB	5	0	00:00:09
2	isvcs01.man.lodz.pl	4	0	0.0 KB	0	4	00:00:00
TOTAL: 2		292	10	10.1 KB	5	4	00:30:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	293	10	10.1 KB	5	4	00:30:27
2	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
3	unresolved	110	0	0.0 KB	0	0	00:00:26
TOTAL: 3		404	10	10.1 KB	5	4	00:30:54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-tom.man.lodz.pl	0.010	0.000	00:30:18
202.95.12.35	0.012	0.004	00:00:20
web.man.lodz.pl	0.802	1.905	00:00:09
159.65.13.181	0.014	0.056	00:00:02
80.111.142.213	0.014	0.027	00:00:01
212.51.192.185	0.250	0.555	00:00:01
scanner-06.ch1.censys-scanner.com	0.012	0.000	00:00:00
192.241.206.78	0.000	0.009	00:00:00
isvcs01.man.lodz.pl	0.022	0.028	00:00:00
TOTAL: 9	1.136	2.584	00:30:54

Curious NNRP server explorers [Top 20]:

System	Conn
212.51.192.185	95
159.65.13.181	8
80.111.142.213	4
202.95.12.35	2
scanner-06.ch1.censys-scanner.com	1
192.241.206.78	1
pc-tom.man.lodz.pl	1
TOTAL: 7	112

NNRP unrecognized commands (by host):

System	Conn
159.65.13.181	42
202.95.12.35	3
192.241.206.78	1
scanner-06.ch1.censys-scanner.com	1
TOTAL: 4	47

NNRP unrecognized commands (by command):

Command	Count
Connection: keep-alive	7
Host: 212.191.2.21:119	7
Accept: /	7
Accept-Encoding: gzip, deflate	7
User-Agent: Mozilla/5.0 (Windows NT 10.0...	6
GET /system_api.php HTTP/1.1	1
GET /stalker_portal/c/version.js HTTP/1....	1
User-Agent: VLC/3.0.8 LibVLC/3.0.8	1
$p*óè°#`#027Dt?eÎ¦%=ÿ ,\VƒÄÛ} ‡{Çx#022×Ô!öYœ...	1
#023#003#023#001#023#002#001	1
EHLO www.censys.io	1
GET /flu/403.html HTTP/1.1	1
MGLNDD_212.191.2.21_119	1
#026#003#001#001#011#001	1
GET /stream/live.php HTTP/1.1	1
GET /streaming/clients_live.php HTTP/1.1	1
GET / HTTP/1.1	1
GET /c/version.js HTTP/1.1	1
TOTAL: 18	47

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-tom.man.lodz.pl	1	0
TOTAL: 1	1	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	6
2	pl.comp.pecet	4
TOTAL: 2		10

Daily Usenet report

Dec 15 04:15:01 -- Dec 16 04:15:02