Daily Usenet report: Sep 24 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Sep 24 11:35:19 newsfeed nnrpd[283964]: SERVER perl filter not defined
Sep 24 12:35:08 newsfeed overchan[261600]: input line too long, skipping
Sep 24 14:24:30 newsfeed overchan[261600]: input line too long, skipping
Sep 24 16:05:55 newsfeed nnrpd[297198]: SERVER perl filter not defined
Sep 24 18:33:52 newsfeed overchan[261600]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	642791	94.9%	71.0 MB	94.2%
innfeed	22548	3.3%	2.7 MB	3.5%
innd	8880	1.3%	1.3 MB	1.8%
nnrpd	3341	0.5%	316.9 KB	0.4%
overchan	4	0.0%	0.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	677565	100.0%	75.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	640840	99.6%
Negative hits	2222	0.3%
Positive hits	122	0.0%
Cache misses	13	0.0%
TOTAL: 4	643197	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.439	0.0%	36	0.000	12.194	116.000
article cleanup	00:00:04.091	0.0%	642477	0.004	0.006	0.010
article logging	00:00:13.116	0.0%	642794	0.014	0.020	0.029
article parse	00:07:47.588	0.5%	128806214	0.003	0.004	0.005
article write	00:04:43.530	0.3%	642351	0.234	0.441	0.612
artlog/artcncl	00:00:00.001	0.0%	35	0.000	0.029	1.000
data move	00:01:00.352	0.1%	134103470	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.099	0.0%	35	0.000	2.829	19.000
hishave/artcncl	00:00:00.004	0.0%	36	0.000	0.111	0.429
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:11.979	0.2%	645177	0.202	0.298	0.744
history sync	00:00:00.019	0.0%	291	0.000	0.065	0.500
history write	00:03:47.623	0.3%	642474	0.259	0.354	2.464
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	22:24:30.256	93.4%	128379987	0.484	0.628	0.860
nntp read	00:27:51.214	1.9%	128424242	0.011	0.013	0.016
overview write	00:00:01.679	0.0%	642351	0.001	0.003	0.005
perl filter	00:32:47.589	2.3%	642474	2.378	3.063	3.534
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:16.680	0.0%	1293202	0.010	0.013	0.018
TOTAL: 24:00:05.227	23:46:16.259	99.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.043	0.0%	29285	0.000	0.001	0.016
article prepare	00:00:00.003	0.0%	13646	0.000	0.000	0.018
article read	00:00:11.567	0.0%	3432	0.000	3.370	23.889
backlog stats	00:00:00.043	0.0%	76871	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	23	0.000	0.000	0.000
data read	00:00:00.343	0.0%	36704	0.000	0.009	0.032
data write	00:00:00.787	0.0%	28440	0.000	0.028	0.076
idle	23:55:58.168	100.0%	76871	639.181	1120.815	2735.308
status file	00:00:04.240	0.0%	7348	0.346	0.577	2.203
TOTAL: 23:56:17.081	23:56:15.194	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:16.910	74.7%	2759	0.000	6.129	9756.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.068	0.3%	5847	0.000	0.012	0.500
readart	00:00:00.001	0.0%	22	0.000	0.045	0.500
TOTAL: 00:00:22.650	00:00:16.979	75.0%	-	-	-	-

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	126	642573	642456	0	117	99%	74:59:09
2	news.icm.edu.pl	47	109	3	97	9	2%	10:17:56
3	localhost	1443	2	2	0	0	100%	00:00:00
TOTAL: 3		1616	642684	642461	97	126	99%	85:17:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	307.2 GB	284.7 KB	599.7 KB	307.2 GB	99%	501.3 KB
2	news.icm.edu.pl	284.4 KB	0.0 KB	174.7 KB	459.1 KB	61%	38.3 KB
3	localhost	3.5 KB	0.0 KB	0.0 KB	3.5 KB	100%	1.7 KB
TOTAL: 3		307.2 GB	284.7 KB	774.4 KB	307.2 GB	99%	501.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 24 04:15:02 - 04:59:59	18603	2.9%	6.90	9.8 GB	3.2%	3796.30
Sep 24 05:00:00 - 05:59:59	19205	3.0%	5.33	10.7 GB	3.5%	3113.05
Sep 24 06:00:00 - 06:59:59	21744	3.4%	6.04	11.8 GB	3.8%	3434.76
Sep 24 07:00:00 - 07:59:59	20598	3.2%	5.72	11.9 GB	3.9%	3466.12
Sep 24 08:00:00 - 08:59:59	23494	3.7%	6.53	12.4 GB	4.0%	3603.82
Sep 24 09:00:00 - 09:59:59	27486	4.3%	7.63	12.8 GB	4.2%	3731.36
Sep 24 10:00:00 - 10:59:59	29911	4.7%	8.31	12.6 GB	4.1%	3682.74
Sep 24 11:00:00 - 11:59:59	33392	5.2%	9.28	13.0 GB	4.2%	3800.78
Sep 24 12:00:00 - 12:59:59	27397	4.3%	7.61	12.8 GB	4.1%	3715.40
Sep 24 13:00:00 - 13:59:59	26875	4.2%	7.47	13.6 GB	4.4%	3970.13
Sep 24 14:00:00 - 14:59:59	26344	4.1%	7.32	13.3 GB	4.3%	3877.69
Sep 24 15:00:00 - 15:59:59	25836	4.0%	7.18	12.1 GB	3.9%	3531.78
Sep 24 16:00:00 - 16:59:59	24403	3.8%	6.78	11.8 GB	3.9%	3450.62
Sep 24 17:00:00 - 17:59:59	24859	3.9%	6.91	12.1 GB	3.9%	3523.80
Sep 24 18:00:00 - 18:59:59	27419	4.3%	7.62	12.5 GB	4.1%	3650.67
Sep 24 19:00:00 - 19:59:59	30360	4.7%	8.43	13.0 GB	4.2%	3775.59
Sep 24 20:00:00 - 20:59:59	30371	4.7%	8.44	13.2 GB	4.3%	3835.56
Sep 24 21:00:00 - 21:59:59	38176	5.9%	10.60	14.0 GB	4.6%	4086.46
Sep 24 22:00:00 - 22:59:59	29213	4.5%	8.11	14.4 GB	4.7%	4204.34
Sep 24 23:00:00 - 23:59:59	28145	4.4%	7.82	13.2 GB	4.3%	3838.37
Sep 25 00:00:00 - 00:59:59	26111	4.1%	7.25	13.3 GB	4.3%	3859.68
Sep 25 01:00:00 - 01:59:59	25687	4.0%	7.14	13.3 GB	4.3%	3874.38
Sep 25 02:00:00 - 02:59:59	24271	3.8%	6.74	13.0 GB	4.2%	3786.56
Sep 25 03:00:00 - 03:59:59	25586	4.0%	7.11	13.4 GB	4.4%	3908.91
Sep 25 04:00:00 - 04:15:01	6827	1.1%	7.58	3.5 GB	1.1%	4111.10
TOTAL: 23:59:59	642313	100.0%	7.43	307.6 GB	100.0%	3733.23

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	434	105	3	9	317
2	news.icm.edu.pl	9	0	0	0	9
TOTAL: 2		443	105	3	9	326

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	78
it.comp.os.win.windows10	7
de.comp.lang.perl	6
alt.comp.software.seamonkey	5
comp.mobile.ipad	3
comp.sys.raspberry-pi	3
it.comp.os.linux.ubuntu	1
comp.mobile.android	1
alt.comp.software.firefox	1
TOTAL: 9	105

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4
Binary in non-binary group	3
Too many newsgroups	2
TOTAL: 3	9

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	13494	2616	5470	130	0	0	19%	23:58:57
2	panorama	21063	194	8638	144	43	20336	0%	23:59:57
3	okapi	0	0	0	0	0	615	0%	23:57:46
4	nask	0	0	0	0	0	6012	0%	23:57:46
5	poznan	4	0	2	0	0	0	0%	00:20:21
TOTAL: 5		34561	2810	14110	274	43	26963	8%	96:14:47

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	9.1 MB	622.1 KB	9.7 MB	0.1 KB/s	3.6 KB	23:58:57
2	panorama	648.8 KB	1.2 MB	1.8 MB	0.0 KB/s	5.5 KB	23:59:57
3	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
4	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
5	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	00:20:21
TOTAL: 5		9.7 MB	1.8 MB	11.5 MB	0.0 KB/s	3.8 KB	96:14:47

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	22	24.9 KB	10	0	00:00:08
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		290	22	24.9 KB	10	2	00:00:22

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	290	22	24.9 KB	10	2	00:00:08
2	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
3	unresolved	104	0	0.0 KB	0	0	00:00:13
TOTAL: 3		395	22	24.9 KB	10	2	00:00:22

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
192.241.208.242	0.000	0.006	00:00:09
web.man.lodz.pl	0.841	1.352	00:00:08
80.111.142.213	0.000	0.032	00:00:01
212.51.192.185	0.256	0.428	00:00:01
scanner-25.ch1.censys-scanner.com	0.008	0.003	00:00:00
192.241.201.23	0.007	0.000	00:00:00
92.255.85.183	0.007	0.007	00:00:00
isvcs01.man.lodz.pl	0.007	0.016	00:00:00
TOTAL: 8	1.126	1.844	00:00:22

Curious NNRP server explorers [Top 20]:

System	Conn
212.51.192.185	96
80.111.142.213	4
92.255.85.183	2
scanner-25.ch1.censys-scanner.com	1
192.241.201.23	1
192.241.208.242	1
TOTAL: 6	105

NNRP unrecognized commands (by host):

System	Conn
92.255.85.183	2
scanner-25.ch1.censys-scanner.com	1
192.241.201.23	1
TOTAL: 3	4

NNRP unrecognized commands (by command):

Command	Count
#003	2
MGLNDD_212.191.2.21_119	1
EHLO www.censys.io	1
TOTAL: 3	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
92.255.85.183	2	2
TOTAL: 1	2	2

Newsgroup request counts (by category):

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

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

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

Daily Usenet report

Sep 24 04:15:02 -- Sep 25 04:15:01