Daily Usenet report: Aug 24 04:15:01

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Aug 24 09:15:04 newsfeed nnrpd[1027812]: SERVER perl filter not defined
Aug 24 09:15:04 newsfeed nnrpd[1027812]: SERVER perl filter not defined
Aug 24 12:31:51 newsfeed nnrpd[1051623]: SERVER perl filter not defined
Aug 24 12:31:51 newsfeed nnrpd[1051623]: SERVER perl filter not defined
Aug 24 12:37:17 newsfeed nnrpd[1052378]: SERVER perl filter not defined
Aug 24 12:37:17 newsfeed nnrpd[1052378]: SERVER perl filter not defined
Aug 24 13:30:35 newsfeed nnrpd[1058798]: SERVER perl filter not defined
Aug 24 13:30:35 newsfeed nnrpd[1058798]: SERVER perl filter not defined
Aug 24 13:40:18 newsfeed nnrpd[1059905]: SERVER perl filter not defined
Aug 24 13:40:18 newsfeed nnrpd[1059905]: SERVER perl filter not defined
Aug 24 22:59:00 newsfeed nnrpd[1132719]: SERVER perl filter not defined
Aug 24 22:59:00 newsfeed nnrpd[1132719]: SERVER perl filter not defined
Aug 24 23:47:28 newsfeed nnrpd[1138497]: SERVER perl filter not defined
Aug 24 23:47:28 newsfeed nnrpd[1138497]: SERVER perl filter not defined
Aug 25 01:14:55 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:91 checkpoint seconds 2 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1536000 duplicate size 0 rejected size 0]
Aug 25 01:14:55 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:91 checkpoint seconds 2 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 1536000 duplicate size 0 rejected size 0]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	267938	87.9%	29.7 MB	89.3%
innd	19610	6.4%	1.9 MB	5.8%
nnrpd	15890	5.2%	1.5 MB	4.5%
innfeed	1360	0.4%	148.6 KB	0.4%
controlchan	2	0.0%	0.1 KB	0.0%
overchan	2	0.0%	0.2 KB	0.0%
TOTAL: 6	304802	100.0%	33.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	532726	99.9%
Negative hits	454	0.1%
Cache misses	96	0.0%
Positive hits	72	0.0%
TOTAL: 4	533348	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.016	0.0%	62	0.000	0.258	2.000
article cleanup	00:00:01.324	0.0%	534658	0.000	0.002	0.005
article logging	00:00:06.716	0.0%	534708	0.006	0.013	0.024
article parse	00:00:09.182	0.0%	1762152	0.002	0.005	0.009
article write	00:00:17.520	0.0%	534646	0.019	0.033	0.270
artlog/artcncl	00:00:00.000	0.0%	20	0.000	0.000	0.000
data move	00:00:01.568	0.0%	2470048	0.000	0.001	0.001
hisgrep/artcncl	00:00:00.000	0.0%	82	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	20	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.852	0.0%	535248	0.001	0.003	0.012
history sync	00:00:00.020	0.0%	690	0.000	0.029	0.500
history write	00:00:29.278	0.0%	534646	0.028	0.055	0.263
idle	47:53:57.950	99.7%	2085010	24.525	82.704	239.052
nntp read	00:00:13.610	0.0%	1648810	0.005	0.008	0.014
overview write	00:00:00.672	0.0%	534646	0.000	0.001	0.004
perl filter	00:04:47.764	0.2%	534646	0.406	0.538	0.722
python filter	00:00:00.098	0.0%	534660	0.000	0.000	0.003
site send	00:00:06.620	0.0%	1080810	0.003	0.006	0.011
TOTAL: 48:01:15.042	48:00:14.190	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.030	0.0%	21480	0.000	0.001	0.030
article prepare	00:00:00.002	0.0%	23284	0.000	0.000	0.000
article read	00:00:00.822	0.0%	5824	0.000	0.141	0.250
backlog stats	00:00:00.018	0.0%	55088	0.000	0.000	0.020
callbacks	00:00:00.000	0.0%	2	0.000	0.000	0.000
data read	00:00:00.188	0.0%	28540	0.000	0.007	0.100
data write	00:00:00.270	0.0%	17120	0.000	0.016	0.059
idle	47:59:47.328	100.0%	55088	72.586	3136.569	17168.914
status file	00:00:00.246	0.0%	380	0.000	0.647	4.000
TOTAL: 47:59:51.176	47:59:48.904	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:53.588	75.7%	8870	0.333	12.806	5042.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.210	0.1%	30016	0.000	0.007	0.667
TOTAL: 00:02:29.998	00:01:53.798	75.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	54
flushlogs	4
go	4
logmode	4
lowmark	2
mode	298
name	4
pause	4
paused	4
reload	4
reserve	4
TOTAL: 11	386

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	64	535058	535048	0	10	99%	61:49:30
2	localhost	16	14	14	0	0	100%	00:00:00
3	news.icm.edu.pl	20	142	4	136	2	2%	10:07:32
TOTAL: 3		100	535214	535066	136	12	99%	71:57:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	4.8 GB	142.1 KB	4.8 GB	99%	9.4 KB
2	news.icm.edu.pl	131.0 KB	53.3 KB	184.2 KB	71%	30.7 KB
3	localhost	20.2 KB	0.0 KB	20.2 KB	100%	1.4 KB
TOTAL: 3		4.8 GB	195.4 KB	4.8 GB	99%	9.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 24 04:15:01 - 04:59:59	3744	1.4%	1.39	30.9 MB	1.3%	11.72
Aug 24 05:00:00 - 05:59:59	5431	2.0%	1.51	44.5 MB	1.8%	12.66
Aug 24 06:00:00 - 06:59:59	8252	3.1%	2.29	91.4 MB	3.7%	26.00
Aug 24 07:00:00 - 07:59:59	8457	3.2%	2.35	90.0 MB	3.7%	25.60
Aug 24 08:00:00 - 08:59:59	9096	3.4%	2.53	81.8 MB	3.3%	23.26
Aug 24 09:00:00 - 09:59:59	6784	2.5%	1.88	72.8 MB	3.0%	20.69
Aug 24 10:00:00 - 10:59:59	8888	3.3%	2.47	76.9 MB	3.1%	21.87
Aug 24 11:00:00 - 11:59:59	9668	3.6%	2.69	80.2 MB	3.3%	22.82
Aug 24 12:00:00 - 12:59:59	11426	4.3%	3.17	107.1 MB	4.4%	30.47
Aug 24 13:00:00 - 13:59:59	10245	3.8%	2.85	102.6 MB	4.2%	29.17
Aug 24 14:00:00 - 14:59:59	12120	4.5%	3.37	106.2 MB	4.3%	30.21
Aug 24 15:00:00 - 15:59:59	12216	4.6%	3.39	99.5 MB	4.0%	28.29
Aug 24 16:00:00 - 16:59:59	10902	4.1%	3.03	89.6 MB	3.6%	25.49
Aug 24 17:00:00 - 17:59:59	10618	4.0%	2.95	88.3 MB	3.6%	25.11
Aug 24 18:00:00 - 18:59:59	8316	3.1%	2.31	76.3 MB	3.1%	21.70
Aug 24 19:00:00 - 19:59:59	10810	4.0%	3.00	145.6 MB	5.9%	41.42
Aug 24 20:00:00 - 20:59:59	9086	3.4%	2.52	99.9 MB	4.1%	28.41
Aug 24 21:00:00 - 21:59:59	11520	4.3%	3.20	104.3 MB	4.2%	29.66
Aug 24 22:00:00 - 22:59:59	14174	5.3%	3.94	133.1 MB	5.4%	37.86
Aug 24 23:00:00 - 23:59:59	21391	8.0%	5.94	181.2 MB	7.4%	51.55
Aug 25 00:00:00 - 00:59:59	18524	6.9%	5.15	152.6 MB	6.2%	43.40
Aug 25 01:00:00 - 01:59:59	15741	5.9%	4.37	128.9 MB	5.2%	36.65
Aug 25 02:00:00 - 02:59:59	13638	5.1%	3.79	119.6 MB	4.9%	34.03
Aug 25 03:00:00 - 03:59:59	12654	4.7%	3.52	119.9 MB	4.9%	34.11
Aug 25 04:00:00 - 04:15:01	4196	1.6%	4.66	36.1 MB	1.5%	41.00
TOTAL: 24:00:00	267897	100.0%	3.10	2.4 GB	100.0%	29.15

Sites sending bad articles:

Server		Total	Duplic	Other
1	newsfeed.pionier.net.pl	30	5	25
2	news.icm.edu.pl	1	1	0
TOTAL: 2		31	6	25

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	14054	5438	6466	380	6	9188	38%	47:55:24
2	poznan	4	0	4	0	0	0	0%	01:00:00
TOTAL: 2		14058	5438	6470	380	6	9188	38%	48:55:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	16.6 MB	1.4 MB	18.0 MB	0.1 KB/s	3.2 KB	47:55:24
2	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	01:00:00
TOTAL: 2		16.6 MB	1.4 MB	18.0 MB	0.1 KB/s	3.2 KB	48:55:24

NNRP readership statistics:

System		Conn	Post	Elapsed
1	40.195.132.66.censys-scanner.com	2	0	00:00:11
2	172.16.2.4	576	0	00:00:34
3	80.111.142.213	8	0	00:00:05
4	nms2.man.lodz.pl	2880	0	00:00:24
5	59.155.45.199.censys-scanner.com	10	0	00:00:12
6	sh-ams-nl-cpp-wk103.internet-census.org	2	0	00:00:04
7	93.123.109.167	12	0	00:00:09
8	sh-ams-nl-cpp-wk101.internet-census.org	2	0	00:00:05
9	zl-laxd-us-cpp-wk111.internet-census.org	2	0	00:00:04
10	sh-chi-us-cpp-wk105.internet-census.org	2	0	00:00:05
11	zl-amsc-nl-gp1-wk128d.internet-census.org	2	0	00:00:20
12	zl-laxc-us-cpp-wk109.internet-census.org	2	0	00:00:04
13	r3-164-a4.monitoring.internet-measurement.com	2	0	00:00:03
14	sh-chi-us-cpp-wk106.internet-census.org	2	0	00:00:04
15	isvcs01.man.lodz.pl	14	14	00:00:00
TOTAL: 15		3518	14	00:02:30

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	*.monitoring.internet-measurement.com	2	0	00:00:03
2	*.man.lodz.pl	2894	14	00:00:25
3	*.internet-census.org	14	0	00:00:49
4	*.155.45.199.censys-scanner.com	10	0	00:00:12
5	unresolved	596	0	00:00:48
6	*.195.132.66.censys-scanner.com	2	0	00:00:11
TOTAL: 6		3518	14	00:02:30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
172.16.2.4	1.568	4.182	00:00:34
nms2.man.lodz.pl	8.114	20.146	00:00:24
zl-amsc-nl-gp1-wk128d.internet-census.org	0.012	0.012	00:00:20
59.155.45.199.censys-scanner.com	0.074	0.066	00:00:12
40.195.132.66.censys-scanner.com	0.056	0.012	00:00:11
93.123.109.167	0.036	0.078	00:00:09
sh-ams-nl-cpp-wk101.internet-census.org	0.006	0.012	00:00:05
80.111.142.213	0.026	0.060	00:00:05
sh-chi-us-cpp-wk105.internet-census.org	0.006	0.012	00:00:05
sh-chi-us-cpp-wk106.internet-census.org	0.004	0.014	00:00:04
zl-laxd-us-cpp-wk111.internet-census.org	0.006	0.014	00:00:04
zl-laxc-us-cpp-wk109.internet-census.org	0.002	0.014	00:00:04
sh-ams-nl-cpp-wk103.internet-census.org	0.002	0.016	00:00:04
r3-164-a4.monitoring.internet-measurement.com	0.002	0.018	00:00:03
isvcs01.man.lodz.pl	0.030	0.130	00:00:00
TOTAL: 15	9.944	24.786	00:02:30

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
93.123.109.167	54
59.155.45.199.censys-scanner.com	4
40.195.132.66.censys-scanner.com	2
TOTAL: 3	60

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
À#024#023#001#023#002#023#003#001	6
#026#003#001#005Õ#001	6
User-Agent: Mozilla/5.0 (Windows NT 10.0...	4
Host: 212.191.2.21:119	4
Content-Length: 15	4
EHLO www.censys.io	4
Accept-Encoding: gzip, deflate	4
Content-Type: application/json	4
ƒ#023Õ$™ˆ	2
#026#003#001	2
5#002¡Ü	2
:h °·Û×~Ôt#013L0œ¿!#034®éª ¯¡ñ¨#	2
(#021¤ÛÙ²®@XA#003#031¦,²©#024~K–´O»#017B1HÀfŒn¢C¾	2
5Z^)È#025#025`UÙx	2
á\Ú"º#031#0131²#¶“Â(#020»#020R¨aÓ¤NŸ›\|#037,#011¢Ô#016îáEÍÆaÅZ...	2
¤#026	2
É›²²bÜºM\x7f‡\#003#026bs%&ªˆ®v™Tt:7ÃåA\|ºS#036ÕÅj“gJÄ...	2
ÎõYc¥›³YÄ#006µU#030:#036†#020¢ÑÊh€—[ö"’‡—ÈyòLÂ°#015&3<...	2
ñ¸M#023#010'²ö#004Tb€±á@\£E#025gË‰{	2
zÉ#034§xó´†²c#033Etœ9#023#031L‹QU¢&ÔŠHaàsÆÇB]Y#017VÊ¸	2
TOTAL: 20	60

NNRP client timeouts [Top 20]:

System	Conn	Peer
93.123.109.167	2	2
59.155.45.199.censys-scanner.com	2	6
TOTAL: 2	4	8

Daily Usenet report

Aug 24 04:15:01 -- Aug 25 04:15:01