Daily Usenet report

Sep 15 04:15:02 -- Sep 16 04:15:01

Unknown entries from news log file:

First 24 / 24 lines (100.0%)

Sep 15 04:15:58 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 15 04:15:58 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 15 10:30:31 newsfeed nnrpd[678040]: SERVER perl filter not defined
Sep 15 10:30:31 newsfeed nnrpd[678040]: SERVER perl filter not defined
Sep 15 13:32:01 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Sep 15 13:32:01 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Sep 15 13:32:02 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Sep 15 13:32:02 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 409600 duplicate size 0 rejected size 0]
Sep 15 13:47:44 newsfeed nnrpd[701562]: SERVER perl filter not defined
Sep 15 13:47:44 newsfeed nnrpd[701562]: SERVER perl filter not defined
Sep 15 14:32:06 newsfeed nnrpd[706864]: SERVER perl filter not defined
Sep 15 14:32:06 newsfeed nnrpd[706864]: SERVER perl filter not defined
Sep 15 14:40:57 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Sep 15 14:40:57 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Sep 15 14:40:58 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Sep 15 14:40:58 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:77 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 358400 duplicate size 0 rejected size 0]
Sep 15 15:32:06 newsfeed nnrpd[714528]: SERVER perl filter not defined
Sep 15 15:32:06 newsfeed nnrpd[714528]: SERVER perl filter not defined
Sep 15 17:00:03 newsfeed pgpverify[725005]: pgpverify: verification failed
Sep 15 17:00:03 newsfeed pgpverify[725005]: pgpverify: verification failed
Sep 15 17:00:05 newsfeed pgpverify[725019]: pgpverify: verification failed
Sep 15 17:00:05 newsfeed pgpverify[725019]: pgpverify: verification failed
Sep 15 22:56:37 newsfeed nnrpd[767619]: SERVER perl filter not defined
Sep 15 22:56:37 newsfeed nnrpd[767619]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 482445 92.5%53.6 MB 93.2%
innd 21826 4.2%2.3 MB 4.0%
nnrpd 15888 3.0%1.5 MB 2.6%
innfeed 1398 0.3%151.0 KB 0.3%
controlchan 46 0.0%10.2 KB 0.0%
pgpverify 4 0.0%0.5 KB 0.0%
overchan 2 0.0%0.1 KB 0.0%
TOTAL: 7 521609 100.0%57.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 956720 99.7%
Negative hits 2540 0.3%
Cache misses 78 0.0%
Positive hits 66 0.0%
TOTAL: 4 959404 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.162 0.0%114 0.000 1.421 4.500
article cleanup00:00:02.638 0.0%965270 0.001 0.003 0.006
article logging00:00:11.762 0.0%965340 0.007 0.012 0.024
article parse00:00:13.366 0.0%2851672 0.003 0.005 0.008
article write00:00:42.512 0.0%965262 0.021 0.044 1.234
artlog/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
data move00:00:01.616 0.0%3562968 0.000 0.000 0.002
hisgrep/artcncl00:00:00.082 0.0%144 0.000 0.569 1.000
hishave/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:31.982 0.0%967922 0.000 0.033 0.351
history sync00:00:00.052 0.0%746 0.000 0.070 1.667
history write00:01:38.700 0.1%965262 0.024 0.102 0.435
idle47:48:14.394 99.5%3134768 24.326 54.899 172.508
nntp read00:00:19.424 0.0%2485116 0.005 0.008 0.014
overview write00:00:01.182 0.0%965262 0.000 0.001 0.004
perl filter00:07:32.866 0.3%965262 0.303 0.469 1.368
python filter00:00:00.198 0.0%965272 0.000 0.000 0.002
site send00:00:11.598 0.0%1942854 0.004 0.006 0.011
TOTAL: 48:01:45.99447:59:42.534 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%24524 0.000 0.001 0.038
article prepare00:00:00.000 0.0%31756 0.000 0.000 0.000
article read00:00:00.496 0.0%7942 0.000 0.062 0.063
backlog stats00:00:00.016 0.0%56234 0.000 0.000 0.027
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:00.234 0.0%30104 0.000 0.008 0.146
data write00:00:00.232 0.0%17886 0.000 0.013 0.133
idle47:40:48.518100.0%56234 37.443 3052.397 16231.541
status file00:00:00.330 0.0%398 0.000 0.829 5.000
TOTAL: 47:40:50.34247:40:49.854100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:10.368 77.5%8852 0.000 14.728 10048.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.264 0.2%29968 0.000 0.009 0.500
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:02:48.31800:02:10.632 77.6%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 294
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 382

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org004404
TOTAL004404

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 124 961680 961676 0 4 99%64:58:18
2localhost 12 10 10 0 0 100%00:00:00
3news.icm.edu.pl 20 118 8 106 4 6%06:42:12
TOTAL: 3 156 961808 961694 106 8 99%71:40:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl6.7 GB38.3 KB0.0 KB6.7 GB 99%7.3 KB
2news.icm.edu.pl296.5 KB35.6 KB0.0 KB332.1 KB 89%27.7 KB
3localhost16.6 KB0.0 KB0.0 KB16.6 KB100%1.7 KB
TOTAL: 36.7 GB73.9 KB0.0 KB6.7 GB 99%7.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 15 04:15:02 - 04:59:59 22332 4.6% 8.28164.7 MB 4.8% 62.51
Sep 15 05:00:00 - 05:59:59 25535 5.3% 7.09201.9 MB 5.8% 57.43
Sep 15 06:00:00 - 06:59:59 12700 2.6% 3.5387.0 MB 2.5% 24.75
Sep 15 07:00:00 - 07:59:59 22407 4.6% 6.22165.8 MB 4.8% 47.17
Sep 15 08:00:00 - 08:59:59 14298 3.0% 3.97110.5 MB 3.2% 31.42
Sep 15 09:00:00 - 09:59:59 13687 2.8% 3.8096.6 MB 2.8% 27.47
Sep 15 10:00:00 - 10:59:59 17696 3.7% 4.92127.5 MB 3.7% 36.27
Sep 15 11:00:00 - 11:59:59 16134 3.3% 4.48100.0 MB 2.9% 28.45
Sep 15 12:00:00 - 12:59:59 13844 2.9% 3.8599.3 MB 2.9% 28.25
Sep 15 13:00:00 - 13:59:59 17436 3.6% 4.84117.2 MB 3.4% 33.33
Sep 15 14:00:00 - 14:59:59 31200 6.5% 8.67222.7 MB 6.4% 63.33
Sep 15 15:00:00 - 15:59:59 13947 2.9% 3.8799.7 MB 2.9% 28.37
Sep 15 16:00:00 - 16:59:59 19305 4.0% 5.36123.3 MB 3.6% 35.08
Sep 15 17:00:00 - 17:59:59 11592 2.4% 3.22103.1 MB 3.0% 29.34
Sep 15 18:00:00 - 18:59:59 21174 4.4% 5.88157.8 MB 4.6% 44.90
Sep 15 19:00:00 - 19:59:59 12434 2.6% 3.4585.5 MB 2.5% 24.33
Sep 15 20:00:00 - 20:59:59 28612 5.9% 7.95219.5 MB 6.4% 62.44
Sep 15 21:00:00 - 21:59:59 17896 3.7% 4.9798.9 MB 2.9% 28.14
Sep 15 22:00:00 - 22:59:59 20543 4.3% 5.71141.4 MB 4.1% 40.22
Sep 15 23:00:00 - 23:59:59 17111 3.5% 4.7597.8 MB 2.8% 27.82
Sep 16 00:00:00 - 00:59:59 32987 6.8% 9.16248.5 MB 7.2% 70.69
Sep 16 01:00:00 - 01:59:59 33203 6.9% 9.22236.8 MB 6.9% 67.37
Sep 16 02:00:00 - 02:59:59 28935 6.0% 8.04213.6 MB 6.2% 60.75
Sep 16 03:00:00 - 03:59:59 12180 2.5% 3.3894.0 MB 2.7% 26.75
Sep 16 04:00:00 - 04:15:01 5203 1.1% 5.7739.6 MB 1.1% 44.99
TOTAL: 23:59:59 482391 100.0% 5.583.4 GB 100.0% 40.92
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 37 0 0 2 0 0 0 0 35
2news.icm.edu.pl 2 0 0 2 0 0 0 0 0
TOTAL: 2 39 0 0 4 0 0 0 0 35

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 35
TOTAL: 1 35
TOTAL: 1 35

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 13800 7542 5304 394 6 11286 54%47:55:24
2poznan 12 0 8 0 0 0 0%01:23:00
TOTAL: 2 13812 7542 5312 394 6 11286 54%49:18:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm23.0 MB1.1 MB24.2 MB0.1 KB/s3.1 KB47:55:24
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:23:00
TOTAL: 223.0 MB1.1 MB24.2 MB0.1 KB/s3.1 KB49:18:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172.16.2.4 576 45.2 KB 2 0 000:00:36
2isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 2 586 45.2 KB 2 10 000:02:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 608 45.2 KB 2 0 000:01:48
2*.man.lodz.pl2890 00.0 KB 0 10 000:00:32
3*.infrawat.ch 6 00.0 KB 0 0 000:00:00
4*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
5*.internet-census.org 14 00.0 KB 0 0 000:00:21
6*.195.132.66.censys-scanner.com 2 00.0 KB 0 0 000:00:05
TOTAL: 63522 45.2 KB 2 10 000:02:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
121.199.161.156 0.020 0.062 0.00000:00:41
172.16.2.4 1.696 3.538 0.00000:00:36
nms1.man.lodz.pl 8.200 17.114 0.00000:00:32
zl-dala-us-gp1-wk134c.internet-census.org 0.002 0.014 0.00000:00:21
9.234.42.1 0.008 0.020 0.00000:00:20
40.195.132.66.censys-scanner.com 0.052 0.016 0.00000:00:05
80.111.142.213 0.030 0.038 0.00000:00:05
94.26.68.254 0.004 0.016 0.00000:00:03
isvcs01.man.lodz.pl 0.048 0.054 0.00000:00:00
81.19.216.124 0.010 0.008 0.00000:00:00
o022.scanner.modat.io 0.002 0.012 0.00000:00:00
147.185.132.207 0.002 0.016 0.00000:00:00
194-88-98-110.infrawat.ch 0.006 0.008 0.00000:00:00
87.251.64.18 0.002 0.024 0.00000:00:00
89-37-172-139.infrawat.ch 0.010 0.008 0.00000:00:00
sh-chi-us-cpp-wk105.internet-census.org 0.010 0.028 0.00000:00:00
sh-ams-nl-cpp-wk104.internet-census.org 0.006 0.010 0.00000:00:00
zl-laxc-us-cpp-wk109.internet-census.org 0.004 0.030 0.00000:00:00
zl-laxd-us-cpp-wk110.internet-census.org 0.006 0.012 0.00000:00:00
69-5-169-214.infrawat.ch 0.010 0.008 0.00000:00:00
TOTAL: 21 10.130 21.048 0.00000:02:49

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
121.199.161.156 10
80.111.142.213 8
87.251.64.18 4
9.234.42.1 4
sh-chi-us-cpp-wk105.internet-census.org 4
69-5-169-214.infrawat.ch 2
94.26.68.254 2
89-37-172-139.infrawat.ch 2
zl-laxd-us-cpp-wk110.internet-census.org 2
81.19.216.124 2
sh-ams-nl-cpp-wk103.internet-census.org 2
sh-ams-nl-cpp-wk104.internet-census.org 2
zl-laxc-us-cpp-wk109.internet-census.org 2
194-88-98-110.infrawat.ch 2
40.195.132.66.censys-scanner.com 2
o022.scanner.modat.io 2
147.185.132.207 2
zl-dala-us-gp1-wk134c.internet-census.org 2
TOTAL: 19 2936

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

SystemConn
87.251.64.18 18
121.199.161.156 6
40.195.132.66.censys-scanner.com 2
9.234.42.1 2
TOTAL: 4 28

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

CommandCount
#026#003#001#002 6
EHLO www.censys.io 2
#026#003#001 2
User-Agent: Mozilla/5.0 (Windows NT 10.0... 2
Connection: close 2
Accept-Encoding: gzip, deflate, br 2
GET / HTTP/1.1 2
MGLNDD_212.191.2.21_119 2
À#024À#011À#023 2
Accept: text/html,application/xhtml+xml,... 2
Accept-Language: en-US,en;q=0.9 2
Host: 212.191.2.21:119 2
TOTAL: 12 28

NNRP client timeouts [Top 20]:

SystemConnPeer
121.199.161.156 4 4
81.19.216.124 2 2
194-88-98-110.infrawat.ch 2 2
TOTAL: 3 8 16

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

NewsgroupCount
1pl.comp.pecet 4
TOTAL: 1 4
innreport from INN 2.7.2 (20240212 prerelease) based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then