Daily Usenet report: Aug 20 04:15:02

Unknown entries from news log file:

First 32 / 32 lines (100.0%)

Aug 20 17:03:22 newsfeed nnrpd[390054]: SERVER perl filter not defined
Aug 20 17:03:22 newsfeed nnrpd[390054]: SERVER perl filter not defined
Aug 20 17:07:25 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 384000 duplicate size 0 rejected size 0]
Aug 20 17:07:25 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 384000 duplicate size 0 rejected size 0]
Aug 20 17:07:28 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 384000 duplicate size 0 rejected size 0]
Aug 20 17:07:28 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 384000 duplicate size 0 rejected size 0]
Aug 20 21:33:29 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 20 21:33:29 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 20 21:33:31 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 20 21:33:31 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Aug 20 22:00:58 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:00:58 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:00:59 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:00:59 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:01:00 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:01:00 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:01:01 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:01:01 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:01:02 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:01:02 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:48:11 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 22:48:11 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 23:29:06 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 20 23:29:06 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:46 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:46 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:47 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:47 newsfeed innd: message repeated 3 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:49 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:49 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:50 newsfeed innd: message repeated 5 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Aug 21 00:14:50 newsfeed innd: message repeated 5 times: [ newsfeed.pionier.net.pl:72 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	751606	94.7%	79.6 MB	94.7%
innd	24636	3.1%	2.8 MB	3.3%
nnrpd	16044	2.0%	1.5 MB	1.8%
innfeed	1264	0.2%	144.6 KB	0.2%
overchan	2	0.0%	0.3 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	793554	100.0%	84.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	1494772	99.8%
Negative hits	2574	0.2%
Positive hits	148	0.0%
Cache misses	96	0.0%
TOTAL: 4	1497590	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.036	0.0%	98	0.000	0.367	5.000
article cleanup	00:00:03.286	0.0%	1498064	0.000	0.002	0.008
article logging	00:00:16.080	0.0%	1498192	0.005	0.011	0.025
article parse	00:00:22.590	0.0%	4748366	0.003	0.005	0.008
article write	00:00:40.280	0.0%	1497970	0.019	0.027	0.228
artlog/artcncl	00:00:00.000	0.0%	26	0.000	0.000	0.000
data move	00:00:02.938	0.0%	6319526	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.010	0.0%	124	0.000	0.081	1.000
hishave/artcncl	00:00:00.000	0.0%	26	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:34.400	0.0%	1500772	0.000	0.023	0.218
history sync	00:00:00.046	0.0%	770	0.000	0.060	1.000
history write	00:01:46.602	0.1%	1497970	0.017	0.071	0.832
idle	47:44:40.332	99.4%	5406470	11.150	31.792	254.904
nntp read	00:00:32.436	0.0%	4253394	0.006	0.008	0.015
overview write	00:00:01.680	0.0%	1497970	0.000	0.001	0.004
perl filter	00:10:42.612	0.4%	1497970	0.272	0.429	0.781
python filter	00:00:00.194	0.0%	1497972	0.000	0.000	0.001
site send	00:00:16.782	0.0%	3007562	0.004	0.006	0.010
TOTAL: 48:01:38.278	48:00:00.304	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.022	0.0%	11782	0.000	0.002	0.056
article prepare	00:00:00.000	0.0%	3712	0.000	0.000	0.000
article read	00:00:00.040	0.0%	928	0.000	0.043	1.000
backlog stats	00:00:00.018	0.0%	73650	0.000	0.000	0.012
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.374	0.0%	33716	0.000	0.011	0.167
data write	00:00:00.744	0.0%	22238	0.000	0.033	0.103
idle	47:43:18.334	100.0%	73650	1362.036	2332.632	15233.025
status file	00:00:00.360	0.0%	334	0.000	1.078	9.889
TOTAL: 47:43:20.896	47:43:19.892	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:03:40.322	10.4%	8942	0.250	24.639	5490.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.194	0.0%	30392	0.000	0.006	0.667
readart	00:00:00.002	0.0%	10	0.000	0.200	0.250
TOTAL: 00:35:16.866	00:03:40.518	10.4%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	102	1487300	1487210	0	90	99%	65:07:56
2	news.icm.edu.pl	68	134	6	124	4	4%	16:48:04
3	localhost	4	2	2	0	0	100%	00:00:00
TOTAL: 3		174	1487436	1487218	124	94	99%	81:56:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	11.8 GB	477.2 KB	11.8 GB	99%	8.3 KB
2	news.icm.edu.pl	55.3 KB	38.1 KB	93.4 KB	59%	9.3 KB
3	localhost	3.8 KB	0.0 KB	3.8 KB	100%	1.9 KB
TOTAL: 3		11.8 GB	515.3 KB	11.8 GB	99%	8.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 20 04:15:02 - 04:59:59	7393	1.0%	2.74	45.9 MB	0.8%	17.42
Aug 20 05:00:00 - 05:59:59	8613	1.1%	2.39	68.6 MB	1.1%	19.50
Aug 20 06:00:00 - 06:59:59	4720	0.6%	1.31	46.7 MB	0.8%	13.28
Aug 20 07:00:00 - 07:59:59	5088	0.7%	1.41	55.2 MB	0.9%	15.71
Aug 20 08:00:00 - 08:59:59	6385	0.8%	1.77	47.0 MB	0.8%	13.37
Aug 20 09:00:00 - 09:59:59	9371	1.2%	2.60	87.5 MB	1.4%	24.90
Aug 20 10:00:00 - 10:59:59	10798	1.4%	3.00	117.5 MB	1.9%	33.42
Aug 20 11:00:00 - 11:59:59	8205	1.1%	2.28	91.0 MB	1.5%	25.87
Aug 20 12:00:00 - 12:59:59	12339	1.6%	3.43	128.2 MB	2.1%	36.46
Aug 20 13:00:00 - 13:59:59	10078	1.3%	2.80	127.4 MB	2.1%	36.24
Aug 20 14:00:00 - 14:59:59	19818	2.6%	5.50	183.1 MB	3.0%	52.10
Aug 20 15:00:00 - 15:59:59	47795	6.4%	13.28	343.8 MB	5.7%	97.79
Aug 20 16:00:00 - 16:59:59	61527	8.2%	17.09	477.7 MB	7.9%	135.88
Aug 20 17:00:00 - 17:59:59	54776	7.3%	15.22	397.5 MB	6.6%	113.06
Aug 20 18:00:00 - 18:59:59	52312	7.0%	14.53	400.3 MB	6.6%	113.86
Aug 20 19:00:00 - 19:59:59	51545	6.9%	14.32	463.2 MB	7.6%	131.76
Aug 20 20:00:00 - 20:59:59	30939	4.1%	8.59	274.7 MB	4.5%	78.13
Aug 20 21:00:00 - 21:59:59	68227	9.1%	18.95	458.8 MB	7.6%	130.49
Aug 20 22:00:00 - 22:59:59	58988	7.8%	16.39	485.7 MB	8.0%	138.16
Aug 20 23:00:00 - 23:59:59	52915	7.0%	14.70	450.8 MB	7.4%	128.24
Aug 21 00:00:00 - 00:59:59	52686	7.0%	14.63	389.0 MB	6.4%	110.64
Aug 21 01:00:00 - 01:59:59	39087	5.2%	10.86	305.3 MB	5.0%	86.84
Aug 21 02:00:00 - 02:59:59	29299	3.9%	8.14	265.0 MB	4.4%	75.36
Aug 21 03:00:00 - 03:59:59	42288	5.6%	11.75	285.3 MB	4.7%	81.15
Aug 21 04:00:00 - 04:15:02	6290	0.8%	6.97	63.6 MB	1.0%	72.18
TOTAL: 24:00:00	751482	100.0%	8.70	5.9 GB	100.0%	71.81

Sites sending bad articles:

Server		Total	Duplic	Other
1	newsfeed.pionier.net.pl	109	45	64
2	news.icm.edu.pl	2	2	0
TOTAL: 2		111	47	64

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	21854	796	10704	128	172	3%	47:58:40
2	poznan	6	4	2	0	0	66%	01:00:18
TOTAL: 2		21860	800	10706	128	172	3%	48:58:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	2.6 MB	651.6 KB	3.2 MB	3.6 KB	47:58:40
2	poznan	37.5 KB	0.0 KB	37.5 KB	9.4 KB	01:00:18
TOTAL: 2		2.6 MB	651.6 KB	3.2 MB	3.6 KB	48:58:58

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	66.61.98.95	48	10	23.0 KB	4	0	00:00:49
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		50	10	23.0 KB	4	2	00:35:17

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	650	10	23.0 KB	4	0	00:33:56
2	*.internet-census.org	14	0	0.0 KB	0	0	00:00:47
3	*.man.lodz.pl	2882	0	0.0 KB	0	2	00:00:30
4	*.186.132.66.censys-scanner.com	2	0	0.0 KB	0	0	00:00:03
TOTAL: 4		3548	10	23.0 KB	4	2	00:35:17

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
183.57.177.131	0.064	0.042	00:31:32
66.61.98.95	0.124	0.346	00:00:49
172.16.2.4	1.636	4.150	00:00:36
61.111.131.217	0.012	0.024	00:00:36
nms2.man.lodz.pl	8.102	20.350	00:00:30
zl-dala-us-gp1-wk124a.internet-census.org	0.006	0.012	00:00:21
zl-laxc-us-cpp-wk109.internet-census.org	0.010	0.026	00:00:08
16.5.0.130	0.006	0.016	00:00:07
80.111.142.213	0.024	0.062	00:00:05
sh-chi-us-cpp-wk105.internet-census.org	0.004	0.016	00:00:04
sh-chi-us-cpp-wk107.internet-census.org	0.002	0.018	00:00:04
sh-ams-nl-cpp-wk103.internet-census.org	0.006	0.016	00:00:04
sh-ams-nl-cpp-wk104.internet-census.org	0.004	0.012	00:00:04
169.186.132.66.censys-scanner.com	0.050	0.018	00:00:03
147.185.133.108	0.008	0.010	00:00:03
36.255.97.14	0.006	0.016	00:00:03
194.180.49.104	0.006	0.014	00:00:00
isvcs01.man.lodz.pl	0.002	0.024	00:00:00
TOTAL: 18	10.072	25.172	00:35:17

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	2880
172.16.2.4	576
80.111.142.213	8
183.57.177.131	6
zl-laxc-us-cpp-wk109.internet-census.org	4
61.111.131.217	4
169.186.132.66.censys-scanner.com	2
194.180.49.104	2
sh-ams-nl-cpp-wk104.internet-census.org	2
147.185.133.108	2
sh-chi-us-cpp-wk107.internet-census.org	2
16.5.0.130	2
36.255.97.14	2
sh-ams-nl-cpp-wk103.internet-census.org	2
zl-dala-us-gp1-wk124a.internet-census.org	2
sh-chi-us-cpp-wk105.internet-census.org	2
TOTAL: 16	3498

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

System	Conn
36.255.97.14	18
147.185.133.108	8
169.186.132.66.censys-scanner.com	2
TOTAL: 3	28

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

Command	Count
À#024#023#001#023#002#023#003#001	2
Host: 212.191.2.21:119	2
Accept-Encoding: gzip	2
User-Agent: Hello from Palo Alto Network...	2
õW³Xë2÷p#027d…¬Y’6O™3i»#037Þ$·ßúCÃ¼¸ëPŸœH#0326Õ½÷...	2
#021ì	2
%±—#001ð¹ð:³tÂ#025#006÷ÆœÈR3ÇjoC©íCÅGEÏM„u¿#030@#032Û®...	2
#026#003#001#005Â#001	2
EHLO www.censys.io	2
±#033PJA}ø#033 ³#031ØÆ#014oj•4’j¤Ë#017eOÐck–sNÀƒ_™¹¾ô...	2
GET / HTTP/1.1	2
[É?Yt>#0252<ûPÂ$ù²1¹©¼Â‹ÄCS„æ#036ÑtîóAÓ6›×¸#0214...	2
Á–J#037çU,Àe<Ôz‹EP‰#001—ŒE0BU#026:#0269Ì©Ï#037µ>çd?CYµ...	2
Ña¡#004#007`Ï“¨²¸¦V#0204ý$‰òv	2
TOTAL: 14	28

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	lodman	10	100.0%
TOTAL: 1		10	100.0%

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

Newsgroup		Count
1	lodman.info	10
TOTAL: 1		10

Daily Usenet report

Aug 20 04:15:02 -- Aug 21 04:15:02