Daily Usenet report

Oct 31 04:15:01 -- Nov 1 04:15:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Oct 31 05:35:09 newsfeed nnrpd[1712908]: SERVER perl filter not defined
Oct 31 05:35:09 newsfeed nnrpd[1712908]: SERVER perl filter not defined
Oct 31 05:37:21 newsfeed nnrpd[1713183]: SERVER perl filter not defined
Oct 31 05:37:21 newsfeed nnrpd[1713183]: SERVER perl filter not defined
Oct 31 07:03:51 newsfeed nnrpd[1724260]: SERVER perl filter not defined
Oct 31 07:03:51 newsfeed nnrpd[1724260]: SERVER perl filter not defined
Nov 1 00:15:02 newsfeed pgpverify[84737]: pgpverify: /usr/bin/gpg1: no such file
Nov 1 00:15:02 newsfeed pgpverify[84737]: pgpverify: /usr/bin/gpg1: no such file
Nov 1 01:04:02 newsfeed pgpverify[90712]: pgpverify: /usr/bin/gpg1: no such file
Nov 1 01:04:02 newsfeed pgpverify[90712]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 162330 79.6%17.8 MB 82.0%
innd 24410 12.0%2.3 MB 10.5%
nnrpd 15876 7.8%1.4 MB 6.7%
innfeed 1334 0.7%167.5 KB 0.8%
controlchan 68 0.0%15.7 KB 0.1%
pgpverify 4 0.0%0.3 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 204024 100.0%21.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 321544 99.7%
Negative hits 972 0.3%
Positive hits 146 0.0%
Cache misses 8 0.0%
TOTAL: 4 322670 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.056 0.0%112 0.000 0.500 4.000
article cleanup00:00:00.990 0.0%322804 0.000 0.003 0.008
article logging00:00:04.542 0.0%322890 0.003 0.014 0.026
article parse00:00:06.752 0.0%1100634 0.003 0.006 0.011
article write00:00:12.564 0.0%322796 0.022 0.039 0.091
artlog/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
data move00:00:00.824 0.0%1647616 0.000 0.001 0.002
hisgrep/artcncl00:00:00.028 0.0%140 0.000 0.200 2.000
hishave/artcncl00:00:00.000 0.0%28 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:50.032 0.0%323896 0.000 0.154 11.633
history sync00:00:00.038 0.0%702 0.000 0.054 1.000
history write00:02:09.822 0.1%322798 0.025 0.402 10.888
idle47:34:10.878 99.7%1347134 70.546 127.122 356.370
nntp read00:00:10.184 0.0%1061140 0.006 0.010 0.016
overview write00:00:00.500 0.0%322796 0.000 0.002 0.006
perl filter00:02:57.232 0.1%322798 0.463 0.549 0.744
python filter00:00:00.060 0.0%322804 0.000 0.000 0.002
site send00:00:04.734 0.0%665670 0.003 0.007 0.012
TOTAL: 47:41:27.24447:40:49.236100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.034 0.0%20096 0.000 0.002 0.024
article prepare00:00:00.000 0.0%1432 0.000 0.000 0.000
article read00:00:00.008 0.0%358 0.000 0.022 1.000
backlog stats00:00:00.014 0.0%112862 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.504 0.0%56470 0.000 0.009 0.033
data write00:00:01.194 0.0%35410 0.000 0.034 0.085
idle47:35:00.588100.0%112862 825.088 1517.788 3552.959
status file00:00:00.230 0.0%372 0.000 0.618 4.000
TOTAL: 47:35:03.75447:35:02.572100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:04.056 77.0%8898 0.000 13.942 10010.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.286 0.2%30170 0.000 0.009 0.333
readart00:00:00.014 0.0%44 0.000 0.318 0.350
TOTAL: 00:02:41.09800:02:04.356 77.2%----

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
moderator@dana.de002202
us-control@lists.killfile.org000200
TOTAL004404

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 204 324680 324674 0 6 99%78:44:36
2news.icm.edu.pl 72 136 14 120 2 10%16:43:54
3localhost 8 6 6 0 0 100%00:00:00
TOTAL: 3 284 324822 324694 120 8 99%95:28:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.4 GB107.2 KB0.0 KB3.4 GB 99%11.0 KB
2news.icm.edu.pl182.0 KB0.0 KB28.1 KB210.1 KB 86%13.1 KB
3localhost9.1 KB0.0 KB0.0 KB9.1 KB100%1.5 KB
TOTAL: 33.4 GB107.2 KB28.1 KB3.4 GB 99%11.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 31 04:15:01 - 04:59:59 3604 2.2% 1.3440.4 MB 2.3% 15.33
Oct 31 05:00:00 - 05:59:59 6145 3.8% 1.7169.9 MB 4.0% 19.87
Oct 31 06:00:00 - 06:59:59 6179 3.8% 1.7270.6 MB 4.0% 20.09
Oct 31 07:00:00 - 07:59:59 7728 4.8% 2.1572.4 MB 4.1% 20.60
Oct 31 08:00:00 - 08:59:59 8239 5.1% 2.2977.0 MB 4.4% 21.90
Oct 31 09:00:00 - 09:59:59 8013 4.9% 2.2374.0 MB 4.2% 21.06
Oct 31 10:00:00 - 10:59:59 9484 5.8% 2.6387.3 MB 5.0% 24.83
Oct 31 11:00:00 - 11:59:59 9692 6.0% 2.6991.3 MB 5.2% 25.98
Oct 31 12:00:00 - 12:59:59 8137 5.0% 2.2682.3 MB 4.7% 23.42
Oct 31 13:00:00 - 13:59:59 7520 4.6% 2.0989.5 MB 5.1% 25.45
Oct 31 14:00:00 - 14:59:59 8625 5.3% 2.4090.3 MB 5.2% 25.68
Oct 31 15:00:00 - 15:59:59 8223 5.1% 2.2880.0 MB 4.6% 22.75
Oct 31 16:00:00 - 16:59:59 4750 2.9% 1.3256.4 MB 3.2% 16.05
Oct 31 17:00:00 - 17:59:59 6060 3.7% 1.6875.1 MB 4.3% 21.37
Oct 31 18:00:00 - 18:59:59 5359 3.3% 1.4965.3 MB 3.7% 18.56
Oct 31 19:00:00 - 19:59:59 5638 3.5% 1.5760.0 MB 3.4% 17.06
Oct 31 20:00:00 - 20:59:59 6503 4.0% 1.8172.3 MB 4.1% 20.57
Oct 31 21:00:00 - 21:59:59 5664 3.5% 1.5767.3 MB 3.8% 19.15
Oct 31 22:00:00 - 22:59:59 6355 3.9% 1.7762.5 MB 3.6% 17.77
Oct 31 23:00:00 - 23:59:59 6554 4.0% 1.8273.7 MB 4.2% 20.96
Nov 1 00:00:00 - 00:59:59 6053 3.7% 1.6874.2 MB 4.2% 21.12
Nov 1 01:00:00 - 01:59:59 7805 4.8% 2.1790.9 MB 5.2% 25.86
Nov 1 02:00:00 - 02:59:59 4488 2.8% 1.2557.3 MB 3.3% 16.29
Nov 1 03:00:00 - 03:59:59 4413 2.7% 1.2354.7 MB 3.1% 15.56
Nov 1 04:00:00 - 04:15:01 1038 0.6% 1.1513.8 MB 0.8% 15.72
TOTAL: 24:00:00 162269 100.0% 1.881.7 GB 100.0% 20.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 46 0 0 3 0 0 0 0 43
2news.icm.edu.pl 1 0 0 0 0 0 0 0 1
TOTAL: 2 47 0 0 3 0 0 0 0 44

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 2
TOTAL: 1 2

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 37808 346 19740 12 0 2 0%47:50:46
2poznan 16 0 12 0 0 0 0%02:21:20
TOTAL: 2 37824 346 19752 12 0 2 0%50:12:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm741.9 KB58.9 KB800.8 KB0.0 KB/s2.2 KB47:50:46
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:21:20
TOTAL: 2741.9 KB58.9 KB800.8 KB0.0 KB/s2.2 KB50:12:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 12 4042.1 KB 2 0 000:00:25
2172.16.2.4 576 49.4 KB 2 0 000:00:33
3isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 3 594 4451.6 KB 4 6 000:02:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 616 4451.6 KB 4 0 000:01:52
2*.stretchoid.com 4 00.0 KB 0 0 000:00:20
3*.man.lodz.pl2886 00.0 KB 0 6 000:00:24
4*.dip0.t-ipconnect.de 6 00.0 KB 0 0 000:00:05
TOTAL: 43512 4451.6 KB 4 6 000:02:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.16.2.4 1.328 2.772 0.00000:00:33
66.61.98.95 0.028 0.066 0.00000:00:25
nms1.man.lodz.pl 5.994 12.998 0.00000:00:24
152.32.183.22 0.008 0.028 0.00000:00:23
azpdsss1oosc.stretchoid.com 0.004 0.020 0.00000:00:20
206.168.34.62 0.068 0.034 0.00000:00:15
80.111.142.213 0.012 0.048 0.00000:00:08
p5de77a35.dip0.t-ipconnect.de 0.022 0.032 0.00000:00:05
205.210.31.239 0.002 0.010 0.00000:00:02
104.152.52.228 0.006 0.008 0.00000:00:01
71.6.134.235 0.008 0.006 0.00000:00:01
147.185.132.174 0.002 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.018 0.032 0.00000:00:00
TOTAL: 13 7.500 16.064 0.00000:02:42

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
80.111.142.213 8
206.168.34.62 6
152.32.183.22 6
p5de77a35.dip0.t-ipconnect.de 6
azpdsss1oosc.stretchoid.com 4
147.185.132.174 2
104.152.52.228 2
205.210.31.239 2
71.6.134.235 2
TOTAL: 10 2918

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

SystemConn
152.32.183.22 8
104.152.52.228 4
azpdsss1oosc.stretchoid.com 2
206.168.34.62 2
TOTAL: 4 16

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

CommandCount
MAIL FROM:<relaycheck_please_ignore@prot... 2
—m”h€æ#Fˆ° ]naŠiV 2
MGLNDD_212.191.2.21_119 2
EHLO www.censys.io 2
ÜïDÐޔ،†–»íØfæÇ£zƒ#005"=l“{ 2
#026#003#001#001#027#001 2
À#024 2
EHLO 212.191.2.21 2
TOTAL: 8 16

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.62 2 4
TOTAL: 1 2 8

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 40 90.9%
2pl 4 9.1%
TOTAL: 2 44100.0%

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

NewsgroupCount
1lodman.info 40
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 44