Daily Usenet report

Sep 30 04:15:01 -- Oct 1 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Sep 30 08:44:56 newsfeed nnrpd[1042039]: SERVER perl filter not defined
Sep 30 08:44:56 newsfeed nnrpd[1042039]: SERVER perl filter not defined
Oct 1 02:00:37 newsfeed pgpverify[1166592]: pgpverify: verification failed
Oct 1 02:00:37 newsfeed pgpverify[1166592]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 211641 85.5%23.5 MB 87.1%
innd 18532 7.5%1.8 MB 6.7%
nnrpd 15994 6.5%1.5 MB 5.6%
innfeed 1342 0.5%148.3 KB 0.5%
controlchan 44 0.0%10.8 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
overchan 2 0.0%0.1 KB 0.0%
TOTAL: 7 247557 100.0%26.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 422242 99.9%
Negative hits 324 0.1%
Positive hits 72 0.0%
Cache misses 54 0.0%
TOTAL: 4 422692 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.034 0.0%76 0.000 0.447 1.200
article cleanup00:00:01.068 0.0%423286 0.000 0.003 0.008
article logging00:00:04.770 0.0%423322 0.005 0.011 0.021
article parse00:00:07.176 0.0%1433432 0.003 0.005 0.010
article write00:00:13.920 0.0%423284 0.018 0.033 0.058
artlog/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
data move00:00:00.966 0.0%1968508 0.000 0.000 0.002
hisgrep/artcncl00:00:00.014 0.0%92 0.000 0.152 0.833
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:21.114 0.0%423720 0.001 0.050 0.317
history sync00:00:00.028 0.0%602 0.000 0.047 0.667
history write00:00:52.674 0.0%423286 0.028 0.124 0.404
idle47:54:00.508 99.8%1677100 10.595 102.821 230.806
nntp read00:00:09.670 0.0%1340860 0.004 0.007 0.014
overview write00:00:00.512 0.0%423284 0.000 0.001 0.006
perl filter00:03:16.580 0.1%423286 0.336 0.464 0.636
python filter00:00:00.082 0.0%423288 0.000 0.000 0.002
site send00:00:05.124 0.0%858494 0.003 0.006 0.009
TOTAL: 48:00:34.02247:59:14.240100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.036 0.0%31024 0.000 0.001 0.043
article prepare00:00:00.002 0.0%37624 0.000 0.000 0.000
article read00:00:01.378 0.0%9412 0.000 0.146 2.000
backlog stats00:00:00.012 0.0%85470 0.000 0.000 0.006
callbacks00:00:00.000 0.0%10 0.000 0.000 0.000
data read00:00:00.262 0.0%42752 0.000 0.006 0.083
data write00:00:00.572 0.0%30816 0.000 0.019 0.118
idle47:57:51.178100.0%85470 38.223 2020.255 16221.784
prepart/cb00:00:00.000 0.0%16 0.000 0.000 0.000
readart/cb00:00:00.000 0.0%4 0.000 0.000 0.000
status file00:00:00.296 0.0%374 0.000 0.791 9.000
TOTAL: 47:57:54.37847:57:53.736100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:38.602 78.7%8890 0.000 17.840 9824.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.220 0.1%30154 0.000 0.007 0.333
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 00:03:21.62000:02:38.822 78.8%----

Control commands to INND:

CommandNumber
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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org002002
us-control@lists.killfile.org000200
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 136 423256 423254 0 2 99%64:54:54
2localhost 4 2 2 0 0 100%00:00:00
3news.icm.edu.pl 32 112 2 110 0 1%08:19:06
TOTAL: 3 172 423370 423258 110 2 99%73:14:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.8 GB0.0 KB29.5 KB3.8 GB 99%9.3 KB
2news.icm.edu.pl17.3 KB0.0 KB0.0 KB17.3 KB100%8.7 KB
3localhost2.8 KB0.0 KB0.0 KB2.8 KB100%1.4 KB
TOTAL: 33.8 GB0.0 KB29.5 KB3.8 GB 99%9.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 04:15:01 - 04:59:59 6802 3.2% 2.5248.1 MB 2.5% 18.23
Sep 30 05:00:00 - 05:59:59 7349 3.5% 2.0461.6 MB 3.2% 17.53
Sep 30 06:00:00 - 06:59:59 4779 2.3% 1.3347.8 MB 2.5% 13.60
Sep 30 07:00:00 - 07:59:59 5446 2.6% 1.5153.9 MB 2.8% 15.34
Sep 30 08:00:00 - 08:59:59 7551 3.6% 2.1068.3 MB 3.5% 19.42
Sep 30 09:00:00 - 09:59:59 9899 4.7% 2.7580.4 MB 4.2% 22.86
Sep 30 10:00:00 - 10:59:59 10734 5.1% 2.9891.1 MB 4.7% 25.90
Sep 30 11:00:00 - 11:59:59 6998 3.3% 1.9453.9 MB 2.8% 15.34
Sep 30 12:00:00 - 12:59:59 9852 4.7% 2.7466.5 MB 3.5% 18.93
Sep 30 13:00:00 - 13:59:59 8690 4.1% 2.4177.1 MB 4.0% 21.92
Sep 30 14:00:00 - 14:59:59 7237 3.4% 2.0167.2 MB 3.5% 19.11
Sep 30 15:00:00 - 15:59:59 6221 2.9% 1.7358.9 MB 3.1% 16.76
Sep 30 16:00:00 - 16:59:59 7354 3.5% 2.0464.7 MB 3.4% 18.41
Sep 30 17:00:00 - 17:59:59 6777 3.2% 1.8855.9 MB 2.9% 15.89
Sep 30 18:00:00 - 18:59:59 6157 2.9% 1.7162.7 MB 3.3% 17.83
Sep 30 19:00:00 - 19:59:59 8268 3.9% 2.3070.7 MB 3.7% 20.11
Sep 30 20:00:00 - 20:59:59 7911 3.7% 2.2074.6 MB 3.9% 21.23
Sep 30 21:00:00 - 21:59:59 8141 3.8% 2.2685.0 MB 4.4% 24.16
Sep 30 22:00:00 - 22:59:59 16892 8.0% 4.69145.9 MB 7.6% 41.50
Sep 30 23:00:00 - 23:59:59 12320 5.8% 3.42122.6 MB 6.4% 34.88
Oct 1 00:00:00 - 00:59:59 14187 6.7% 3.94131.8 MB 6.8% 37.50
Oct 1 01:00:00 - 01:59:59 16874 8.0% 4.69205.8 MB 10.7% 58.53
Oct 1 02:00:00 - 02:59:59 7228 3.4% 2.0162.3 MB 3.2% 17.71
Oct 1 03:00:00 - 03:59:59 6679 3.2% 1.8656.8 MB 2.9% 16.15
Oct 1 04:00:00 - 04:15:02 1268 0.6% 1.4111.8 MB 0.6% 13.42
TOTAL: 24:00:01 211614 100.0% 2.451.9 GB 100.0% 22.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 18 0 0 0 0 0 0 0 18
2news.icm.edu.pl 1 0 0 0 0 0 0 0 1
TOTAL: 2 19 0 0 0 0 0 0 0 19

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2
TOTAL: 1 2

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 17
news.icm.edu.pl 1
TOTAL: 2 18
TOTAL: 1 18

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 30664 8982 15742 422 12 5866 29%47:55:32
2poznan 2 0 2 0 0 0 0%00:40:00
TOTAL: 2 30666 8982 15744 422 12 5866 29%48:35:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm22.5 MB3.0 MB25.4 MB0.2 KB/s2.8 KB47:55:32
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:40:00
TOTAL: 222.5 MB3.0 MB25.4 MB0.1 KB/s2.8 KB48:35:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 40 22.8 KB 2 0 000:00:48
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 42 22.8 KB 2 2 000:03:22

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 638 22.8 KB 2 0 000:02:25
2*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
3*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
4*.internet-census.org 12 00.0 KB 0 0 000:00:20
5*.man.lodz.pl2882 00.0 KB 0 2 000:00:23
6*.infrawat.ch 4 00.0 KB 0 0 000:00:00
7*.172.132.66.censys-scanner.com 2 00.0 KB 0 0 000:00:01
8*.probe.onyphe.net 4 00.0 KB 0 0 000:00:06
TOTAL: 83546 22.8 KB 2 2 000:03:22

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.61.98.95 0.112 0.210 0.00000:00:48
192.51.188.11 0.010 0.018 0.00000:00:36
172.16.2.4 1.594 2.988 0.00000:00:33
nms1.man.lodz.pl 7.732 14.660 0.00000:00:23
zl-amsc-nl-gp1-wk117a.internet-census.org 0.006 0.012 0.00000:00:20
20.14.76.20 0.004 0.024 0.00000:00:20
alvarado.probe.onyphe.net 0.014 0.018 0.00000:00:06
80.111.142.213 0.022 0.048 0.00000:00:05
r3-27-1b.monitoring.internet-measurement.com 0.010 0.006 0.00000:00:03
178.172.132.66.censys-scanner.com 0.048 0.018 0.00000:00:01
198.235.24.73 0.006 0.008 0.00000:00:00
205.210.31.70 0.006 0.006 0.00000:00:00
o018.scanner.modat.io 0.006 0.010 0.00000:00:00
89-21-67-162.infrawat.ch 0.002 0.012 0.00000:00:00
193-176-31-217.infrawat.ch 0.004 0.012 0.00000:00:00
zl-laxd-us-cpp-wk110.internet-census.org 0.006 0.012 0.00000:00:00
zl-laxd-us-cpp-wk111.internet-census.org 0.004 0.012 0.00000:00:00
sh-chi-us-cpp-wk106.internet-census.org 0.004 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.010 0.008 0.00000:00:00
sh-ams-nl-cpp-wk101.internet-census.org 0.006 0.010 0.00000:00:00
TOTAL: 21 9.616 18.108 0.00000:03:22

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
172.16.2.4 578
80.111.142.213 8
20.14.76.20 4
192.51.188.11 4
alvarado.probe.onyphe.net 4
o018.scanner.modat.io 2
sh-chi-us-cpp-wk106.internet-census.org 2
178.172.132.66.censys-scanner.com 2
zl-amsc-nl-gp1-wk117a.internet-census.org 2
89-21-67-162.infrawat.ch 2
zl-laxd-us-cpp-wk110.internet-census.org 2
sh-ams-nl-cpp-wk103.internet-census.org 2
sh-ams-nl-cpp-wk101.internet-census.org 2
193-176-31-217.infrawat.ch 2
205.210.31.70 2
zl-laxd-us-cpp-wk111.internet-census.org 2
198.235.24.73 2
r3-27-1b.monitoring.internet-measurement.com 2
TOTAL: 19 3504

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

SystemConn
alvarado.probe.onyphe.net 4
20.14.76.20 2
178.172.132.66.censys-scanner.com 2
TOTAL: 3 8

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

CommandCount
MGLNDD_212.191.2.21_119 2
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 2
#026#003#003#002a#001 2
EHLO www.censys.io 2
TOTAL: 4 8

NNRP client timeouts [Top 20]:

SystemConnPeer
89-21-67-162.infrawat.ch 2 2
TOTAL: 1 2 8

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1lodman.info 2
TOTAL: 1 2