Daily Usenet Report

Mar 15 00:01:01 -- Mar 16 00:01:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Mar 15 00:02:04 www innd: message repeated 2 times: [ ctlinnd command s]
Mar 15 10:00:06 www pgpverify[735698]: pgpverify: verification failed
Mar 15 10:00:07 www pgpverify[735714]: pgpverify: verification failed
Mar 15 14:30:03 www pgpverify[743605]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 16826 71.7%2.6 MB 76.1%
innd 5281 22.5%658.6 KB 18.5%
innfeed 1236 5.3%180.2 KB 5.1%
nnrpd 81 0.3%6.5 KB 0.2%
controlchan 24 0.1%5.1 KB 0.1%
pgpverify 3 0.0%0.6 KB 0.0%
TOTAL: 6 23451 100.0%3.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 54385 45.6%
Negative hits 48304 40.5%
Do not exist 16480 13.8%
Cache misses 25 0.0%
TOTAL: 4 119194 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.038 0.0%44 0.000 0.864 7.000
article cleanup00:00:00.330 0.0%16504 0.000 0.020 0.233
article logging00:00:00.752 0.0%16784 0.000 0.045 0.148
article parse00:00:00.539 0.0%23699 0.000 0.023 0.143
article write00:00:07.572 0.0%12761 0.239 0.593 2.533
artlog/artcncl00:00:00.002 0.0%44 0.000 0.045 1.000
data move00:00:00.136 0.0%120846 0.000 0.001 0.008
hisgrep/artcncl00:00:00.004 0.0%32 0.000 0.125 1.000
hishave/artcncl00:00:00.001 0.0%44 0.000 0.023 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.866 0.0%119368 0.000 0.016 0.107
history sync00:00:00.049 0.0%345 0.000 0.142 1.000
history write00:00:02.687 0.0%16499 0.033 0.163 0.731
hiswrite/artcncl00:00:00.001 0.0%12 0.000 0.083 0.500
idle23:58:25.923 99.8%118378 246.477 729.071 4082.381
nntp read00:00:05.057 0.0%118619 0.018 0.043 0.092
overview write00:00:06.144 0.0%12761 0.139 0.481 2.011
perl filter00:00:35.249 0.0%16499 0.929 2.136 3.900
python filter00:00:02.361 0.0%16499 0.071 0.143 0.519
site send00:00:03.844 0.0%25525 0.025 0.151 0.393
TOTAL: 24:00:41.45423:59:32.555 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.133 0.0%13243 0.000 0.010 0.102
article prepare00:00:00.000 0.0%3316 0.000 0.000 0.000
article read00:00:00.340 0.0%822 0.000 0.414 19.000
backlog stats00:00:00.176 0.0%131019 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.947 0.0%86118 0.009 0.034 0.069
data write00:00:11.548 0.0%74836 0.068 0.154 0.330
idle23:55:56.981100.0%131019 254.859 657.592 3115.368
status file00:00:00.159 0.0%169 0.000 0.941 5.000
TOTAL: 23:56:18.09823:56:12.284100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle17:45:59.620100.0%1207 118.500 52990.572 53166.365
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.584 0.0%2466 0.000 0.237 0.239
readart00:00:00.017 0.0%86 0.198 0.198 0.198
TOTAL: 17:46:01.05417:46:00.221100.0%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
moderator@dana.de000100
TOTAL002302

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 8 28029 10718 16101 1210 38%49:06:43
2peer.alt119.net 7 16402 1387 12617 2398 8%23:59:36
3newsfeed.xs3.de 2 13453 719 12659 75 5%23:59:22
4news.bbs.nz 11 22996 46 22945 5 0%47:21:58
5news.nk.ca 1 0 0 0 0 0%00:10:00
6204.209.81.3 3 0 0 0 0 0%00:30:00
7localhost 25 0 0 0 0 0%00:00:00
TOTAL: 7 57 80880 12870 64322 3688 15%145:07:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net40.8 MB22.3 KB4.9 MB45.7 MB 89%3.9 KB
2peer.alt119.net3.9 MB18.0 KB18.6 MB22.5 MB 17%6.1 KB
3newsfeed.xs3.de2.6 MB2.9 KB304.9 KB2.9 MB 89%3.8 KB
4news.bbs.nz104.0 KB0.0 KB8.6 KB112.5 KB 92%2.2 KB
5news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
6204.209.81.30.0 KB0.0 KB0.0 KB0.0 KB 0%0
7localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 747.4 MB43.2 KB23.8 MB71.2 MB 66%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 15 00:01:01 - 00:59:59 190 1.5% 0.05975.6 KB 2.0% 0.28
Mar 15 01:00:00 - 01:59:59 307 2.4% 0.091.6 MB 3.4% 0.46
Mar 15 02:00:00 - 02:59:59 378 3.0% 0.102.7 MB 5.8% 0.76
Mar 15 03:00:00 - 03:59:59 923 7.2% 0.262.5 MB 5.4% 0.72
Mar 15 04:00:00 - 04:59:59 594 4.7% 0.171.7 MB 3.7% 0.48
Mar 15 05:00:00 - 05:59:59 635 5.0% 0.182.2 MB 4.7% 0.62
Mar 15 06:00:00 - 06:59:59 619 4.9% 0.172.0 MB 4.4% 0.58
Mar 15 07:00:00 - 07:59:59 602 4.7% 0.171.8 MB 3.8% 0.51
Mar 15 08:00:00 - 08:59:59 582 4.6% 0.162.2 MB 4.7% 0.62
Mar 15 09:00:00 - 09:59:59 665 5.2% 0.182.1 MB 4.5% 0.59
Mar 15 10:00:00 - 10:59:59 679 5.3% 0.192.2 MB 4.7% 0.62
Mar 15 11:00:00 - 11:59:59 834 6.5% 0.232.7 MB 5.9% 0.78
Mar 15 12:00:00 - 12:59:59 954 7.5% 0.274.3 MB 9.2% 1.22
Mar 15 13:00:00 - 13:59:59 705 5.5% 0.202.3 MB 5.0% 0.66
Mar 15 14:00:00 - 14:59:59 686 5.4% 0.192.7 MB 5.8% 0.77
Mar 15 15:00:00 - 15:59:59 541 4.2% 0.151.5 MB 3.2% 0.42
Mar 15 16:00:00 - 16:59:59 611 4.8% 0.172.1 MB 4.6% 0.61
Mar 15 17:00:00 - 17:59:59 627 4.9% 0.171.7 MB 3.6% 0.48
Mar 15 18:00:00 - 18:59:59 382 3.0% 0.112.0 MB 4.3% 0.57
Mar 15 19:00:00 - 19:59:59 345 2.7% 0.102.1 MB 4.6% 0.61
Mar 15 20:00:00 - 20:59:59 245 1.9% 0.07786.8 KB 1.7% 0.22
Mar 15 21:00:00 - 21:59:59 192 1.5% 0.05620.9 KB 1.3% 0.17
Mar 15 22:00:00 - 22:59:59 314 2.5% 0.091.3 MB 2.8% 0.37
Mar 15 23:00:00 - 23:59:59 143 1.1% 0.04521.4 KB 1.1% 0.14
Mar 16 00:00:00 - 00:01:01 6 0.0% 0.1011.0 KB 0.0% 0.18
TOTAL: 24:00:00 12759 100.0% 0.1546.6 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1peer.alt119.net 2464 4 0 1 0 0 0 0 2459
2endofthelinebbs-out.news.weretis.net 1476 2 0 3 0 0 0 0 1471
3newsfeed.xs3.de 82 0 0 1 0 0 0 0 81
4news.bbs.nz 1 0 0 0 0 0 0 0 1
TOTAL: 4 4023 6 0 5 0 0 0 0 4012

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.music.pink-floyd.publius 2
grisbi.test 1
mozilla.general 1
soc.men.alt.feminism 1
talk.politics 1
TOTAL: 5 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1748
Too many newsgroups 750
Subject (for) 519
EMP (phn path) 278
Subject (For) 208
EMP (phn nph) 131
Subject (buy) 26
Subject (FOR) 14
Subject (Buy) 13
HTML Multipart 9
EMP (phl) 9
Subject (BuY) 6
Binary: misplaced binary 5
User-issued cancel 5
Subject (KETAMINE) 4
Subject (BUY) 3
User-issued spam cancel 2
Subject (ketamine) 1
Subject (fOr) 1
TOTAL: 19 3732

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 263
peer.alt119.net 12
newsfeed.xs3.de 5
TOTAL: 3 280
TOTAL: 1 280

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 12069 766 10644 0 0 4 6%23:59:49
2news.bbs.nz 24641 14 12704 19 0 456 0%23:59:57
3news.nk.ca 13323 14 11900 11 0 839 0%23:59:57
4newsfeed.xs3.de 12091 3 12032 1 0 10 0%23:59:57
5news.weretis.net 12783 1 12757 1 0 0 0%23:59:51
TOTAL: 5 74907 798 60037 32 0 1309 1%119:59:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net4.0 MB0.0 KB4.0 MB0.0 KB/s5.3 KB23:59:49
2news.nk.ca49.9 KB113.7 KB163.7 KB0.0 KB/s6.5 KB23:59:57
3news.bbs.nz38.5 KB164.4 KB202.9 KB0.0 KB/s6.1 KB23:59:57
4newsfeed.xs3.de3.8 KB2.4 KB6.1 KB0.0 KB/s1.5 KB23:59:57
5news.weretis.net1.7 KB86.4 KB88.1 KB0.0 KB/s44.0 KB23:59:51
TOTAL: 54.1 MB366.9 KB4.4 MB0.0 KB/s5.5 KB119:59:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 814.1 KB 3 2 017:46:01
TOTAL: 1 2 814.1 KB 3 2 017:46:01

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.186.38.89 0.679 0.786 0.00417:46:00
175.198.181.131 0.133 0.045 0.00000:00:00
TOTAL: 2 0.812 0.831 0.00417:46:01

Curious NNRP server explorers [Top 20]:

SystemConn
175.198.181.131 2
TOTAL: 1 2

NNRP unrecognized commands (by host):

SystemConn
175.198.181.131 8
TOTAL: 1 8

NNRP unrecognized commands (by command):

CommandCount
Proxy-Connection: keep-alive 2
User-Agent: Mozilla/5.0 2
CONNECT m.blog.naver.com:443 HTTP/1.1 1
Host: blog.daum.net 1
Host: m.blog.naver.com 1
CONNECT blog.daum.net:80 HTTP/1.1 1
TOTAL: 6 8

NNRP client timeouts [Top 20]:

SystemConnPeer
47.186.38.89 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1news 2 33.3%
2alt 2 33.3%
3soc 2 33.3%
TOTAL: 3 6100.0%

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

NewsgroupCount
1alt.music.lyrics 2
2soc.genealogy.britain 2
3news.admin.peering 2
TOTAL: 3 6