Daily Usenet report: Jun 28 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Jun 28 06:47:42 newsfeed overchan[759281]: input line too long, skipping
Jun 28 06:52:06 newsfeed overchan[759281]: input line too long, skipping
Jun 28 09:20:28 newsfeed nnrpd[774048]: SERVER perl filter not defined
Jun 28 10:34:53 newsfeed overchan[759281]: input line too long, skipping
Jun 28 11:50:05 newsfeed nnrpd[782746]: SERVER perl filter not defined
Jun 28 11:51:33 newsfeed nnrpd[782759]: SERVER perl filter not defined
Jun 28 12:28:57 newsfeed overchan[759281]: input line too long, skipping
Jun 28 15:24:05 newsfeed overchan[759281]: input line too long, skipping
Jun 28 15:36:37 newsfeed overchan[759281]: input line too long, skipping
Jun 28 15:39:12 newsfeed overchan[759281]: input line too long, skipping
Jun 28 18:49:13 newsfeed nnrpd[801134]: SERVER perl filter not defined
Jun 28 19:13:07 newsfeed overchan[759281]: input line too long, skipping
Jun 28 19:40:14 newsfeed overchan[759281]: input line too long, skipping
Jun 29 00:22:03 newsfeed nnrpd[815990]: SERVER perl filter not defined
Jun 29 00:22:38 newsfeed nnrpd[815993]: SERVER perl filter not defined
Jun 29 00:22:50 newsfeed nnrpd[816000]: SERVER perl filter not defined
Jun 29 00:22:56 newsfeed nnrpd[816001]: SERVER perl filter not defined
Jun 29 00:36:27 newsfeed overchan[759281]: input line too long, skipping
Jun 29 01:26:20 newsfeed overchan[759281]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	67614	76.8%	7.6 MB	77.3%
innfeed	10660	12.1%	1.2 MB	12.3%
nnrpd	7720	8.8%	795.7 KB	7.9%
innd	2035	2.3%	259.1 KB	2.6%
overchan	12	0.0%	1.5 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	88042	100.0%	9.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	66494	98.6%
Negative hits	684	1.0%
Positive hits	253	0.4%
Cache misses	28	0.0%
TOTAL: 4	67459	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.701	0.0%	42	0.000	16.690	62.000
article cleanup	00:00:00.435	0.0%	66899	0.000	0.007	0.020
article logging	00:00:01.752	0.0%	67290	0.005	0.026	0.054
article parse	00:00:02.620	0.0%	345222	0.002	0.008	0.015
article write	00:00:12.245	0.0%	66783	0.046	0.183	2.355
artlog/artcncl	00:00:00.000	0.0%	42	0.000	0.000	0.000
data move	00:00:00.519	0.0%	482161	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.254	0.0%	42	0.000	6.048	29.000
hishave/artcncl	00:00:00.145	0.0%	42	0.000	3.452	9.300
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:06:57.899	0.5%	67805	3.272	6.163	57.610
history sync	00:00:00.024	0.0%	398	0.000	0.060	0.667
history write	00:07:14.422	0.5%	66881	4.008	6.495	46.342
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:44:41.225	98.9%	406452	34.473	210.311	527.116
nntp read	00:00:06.121	0.0%	343068	0.007	0.018	0.031
overview write	00:00:00.255	0.0%	66783	0.000	0.004	0.015
perl filter	00:01:18.533	0.1%	66881	0.511	1.174	1.682
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:02.203	0.0%	144221	0.005	0.015	0.031
TOTAL: 24:00:59.184	24:00:39.353	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	19514	0.000	0.002	0.036
article prepare	00:00:00.000	0.0%	1558	0.000	0.000	0.000
article read	00:00:06.631	0.0%	390	0.000	17.003	387.000
backlog stats	00:00:00.035	0.0%	56799	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:00.306	0.0%	29429	0.000	0.010	0.035
data write	00:00:00.715	0.0%	18900	0.000	0.038	0.106
idle	23:58:39.340	100.0%	56799	857.013	1519.733	3351.983
status file	00:00:08.833	0.0%	3373	0.000	2.619	49.406
TOTAL: 23:58:57.341	23:58:55.899	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:34.288	64.0%	4252	0.000	8.064	10036.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.166	0.3%	10257	0.000	0.016	0.500
readart	00:00:00.001	0.0%	26	0.000	0.038	0.500
TOTAL: 00:00:53.552	00:00:34.455	64.3%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	92	67275	67157	6	112	99%	40:53:51
2	news.icm.edu.pl	48	250	23	223	4	9%	17:34:53
3	localhost	9	8	8	0	0	100%	00:00:00
TOTAL: 3		149	67533	67188	229	116	99%	58:28:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	914.0 MB	427.7 KB	650.4 KB	915.1 MB	99%	13.9 KB
2	news.icm.edu.pl	970.3 KB	8.8 KB	57.7 KB	1.0 MB	93%	38.4 KB
3	localhost	13.4 KB	0.0 KB	0.0 KB	13.4 KB	100%	1.7 KB
TOTAL: 3		915.0 MB	436.5 KB	708.1 KB	916.1 MB	99%	13.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 28 04:15:02 - 04:59:59	1380	2.1%	0.51	17.8 MB	1.9%	6.75
Jun 28 05:00:00 - 05:59:59	2124	3.2%	0.59	33.6 MB	3.7%	9.56
Jun 28 06:00:00 - 06:59:59	1983	3.0%	0.55	34.1 MB	3.7%	9.69
Jun 28 07:00:00 - 07:59:59	2178	3.2%	0.60	32.1 MB	3.5%	9.12
Jun 28 08:00:00 - 08:59:59	2487	3.7%	0.69	25.6 MB	2.8%	7.28
Jun 28 09:00:00 - 09:59:59	3114	4.6%	0.86	33.4 MB	3.7%	9.49
Jun 28 10:00:00 - 10:59:59	2826	4.2%	0.79	32.3 MB	3.5%	9.20
Jun 28 11:00:00 - 11:59:59	2551	3.8%	0.71	32.0 MB	3.5%	9.10
Jun 28 12:00:00 - 12:59:59	3024	4.5%	0.84	110.4 MB	12.1%	31.39
Jun 28 13:00:00 - 13:59:59	2454	3.7%	0.68	33.0 MB	3.6%	9.39
Jun 28 14:00:00 - 14:59:59	5075	7.6%	1.41	59.2 MB	6.5%	16.83
Jun 28 15:00:00 - 15:59:59	2928	4.4%	0.81	39.8 MB	4.4%	11.33
Jun 28 16:00:00 - 16:59:59	2871	4.3%	0.80	41.2 MB	4.5%	11.72
Jun 28 17:00:00 - 17:59:59	2927	4.4%	0.81	47.8 MB	5.2%	13.59
Jun 28 18:00:00 - 18:59:59	2130	3.2%	0.59	27.3 MB	3.0%	7.76
Jun 28 19:00:00 - 19:59:59	2819	4.2%	0.78	41.7 MB	4.6%	11.87
Jun 28 20:00:00 - 20:59:59	2806	4.2%	0.78	40.2 MB	4.4%	11.42
Jun 28 21:00:00 - 21:59:59	2858	4.3%	0.79	36.4 MB	4.0%	10.36
Jun 28 22:00:00 - 22:59:59	2327	3.5%	0.65	26.1 MB	2.9%	7.42
Jun 28 23:00:00 - 23:59:59	2064	3.1%	0.57	24.2 MB	2.6%	6.88
Jun 29 00:00:00 - 00:59:59	2548	3.8%	0.71	38.9 MB	4.3%	11.08
Jun 29 01:00:00 - 01:59:59	3836	5.7%	1.07	47.6 MB	5.2%	13.53
Jun 29 02:00:00 - 02:59:59	1710	2.5%	0.47	22.4 MB	2.5%	6.38
Jun 29 03:00:00 - 03:59:59	4838	7.2%	1.34	31.4 MB	3.4%	8.94
Jun 29 04:00:00 - 04:15:01	1207	1.8%	1.34	4.3 MB	0.5%	4.88
TOTAL: 23:59:59	67065	100.0%	0.78	912.7 MB	100.0%	10.82

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.pionier.net.pl	503	95	17	391
2	news.icm.edu.pl	4	0	1	3
TOTAL: 2		507	95	18	394

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	29
it.comp.os.win.windows10	20
comp.mobile.android	18
alt.comp.software.seamonkey	12
comp.sys.raspberry-pi	4
alt.comp.software.firefox	4
de.comm.software.mailreader	3
it.tlc.cellulari.android	3
de.comm.provider.telefonie	2
TOTAL: 9	95

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	panorama	8878	99	3435	108	1	15877	1%	23:59:57
2	icm	13522	59	10447	2	0	1	0%	23:59:55
3	okapi	0	0	0	0	0	925	0%	23:57:47
4	poznan	31	0	23	0	0	0	0%	02:51:25
5	nask	0	0	0	0	0	7045	0%	23:57:47
TOTAL: 5		22431	158	13905	110	1	23848	0%	98:46:51

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	panorama	260.0 KB	593.6 KB	853.6 KB	4.1 KB	23:59:57
2	icm	222.4 KB	4.8 KB	227.2 KB	3.7 KB	23:59:55
3	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
4	poznan	0.0 KB	0.0 KB	0.0 KB	0	02:51:25
5	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
TOTAL: 5		482.4 KB	598.4 KB	1.1 MB	4.0 KB	98:46:51

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	26	24.7 KB	13	0	00:00:09
2	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:00
TOTAL: 2		296	26	24.7 KB	13	8	00:00:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	1736	26	24.7 KB	13	8	00:00:23
2	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
3	unresolved	106	0	0.0 KB	0	0	00:00:29
TOTAL: 3		1843	26	24.7 KB	13	8	00:00:53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms2.man.lodz.pl	4.690	7.358	00:00:14
104.152.52.206	0.003	0.007	00:00:10
198.199.117.94	0.000	0.006	00:00:09
web.man.lodz.pl	0.929	1.508	00:00:09
159.89.144.135	0.000	0.006	00:00:05
80.111.142.213	0.021	0.024	00:00:02
212.51.192.185	0.333	0.501	00:00:01
94.102.61.41	0.003	0.007	00:00:00
scanner-29.ch1.censys-scanner.com	0.004	0.012	00:00:00
isvcs01.man.lodz.pl	0.052	0.048	00:00:00
104.152.52.201	0.005	0.005	00:00:00
192.241.192.20	0.000	0.011	00:00:00
?	0.000	0.010	00:00:00
TOTAL: 13	6.040	9.503	00:00:53

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	1440
212.51.192.185	96
80.111.142.213	4
159.89.144.135	1
198.199.117.94	1
scanner-29.ch1.censys-scanner.com	1
104.152.52.201	1
192.241.192.20	1
94.102.61.41	1
104.152.52.206	1
TOTAL: 10	1547

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
94.102.61.41	5
192.241.192.20	1
scanner-29.ch1.censys-scanner.com	1
TOTAL: 3	7

NNRP unrecognized commands (by command):

Command	Count
Accept-Encoding: gzip	1
GET / HTTP/1.1	1
MGLNDD_212.191.2.21_119	1
Host: 212.191.2.21:119	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Accept: /	1
EHLO www.censys.io	1
TOTAL: 7	7

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	14
2	pl.comp.pecet	12
TOTAL: 2		26

Daily Usenet report

Jun 28 04:15:02 -- Jun 29 04:15:01