Daily Usenet report for csiph.com

Oct 11 04:15:00 -- Oct 12 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 20027 48.2%5.2 MB 64.5%
innd 17333 41.7%2.2 MB 27.1%
innfeed 3370 8.1%594.8 KB 7.2%
nnrpd 784 1.9%89.2 KB 1.1%
nocem 48 0.1%4.8 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 41563 100.0%8.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 297522 57.1%
Negative hits 203225 39.0%
Do not exist 19496 3.7%
Cache misses 707 0.1%
TOTAL: 4 520950 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.745 0.0%92 0.000 18.967 115.500
article cleanup00:00:00.120 0.0%18976 0.000 0.006 0.035
article logging00:00:00.874 0.0%19397 0.000 0.045 3.013
article parse00:00:02.786 0.0%77592 0.000 0.036 0.317
article write00:02:30.441 0.2%16097 0.273 9.346 80.833
artlog/artcncl00:00:00.004 0.0%85 0.000 0.047 1.000
artlog/artparse00:00:00.038 0.0%544 0.000 0.070 1.304
data move00:00:00.118 0.0%502695 0.000 0.000 0.001
hisgrep/artcncl00:00:00.095 0.0%89 0.000 1.067 22.000
hishave/artcncl00:00:00.034 0.0%92 0.000 0.370 4.667
hishave/artparse00:00:00.001 0.0%544 0.000 0.002 0.043
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:29.641 0.1%521280 0.001 0.172 0.895
history sync00:00:01.632 0.0%383 0.000 4.261 93.000
history write00:01:30.476 0.1%18974 0.232 4.768 25.244
hiswrite/artcncl00:00:00.028 0.0%3 1.000 9.333 13.500
hiswrite/artparse00:00:02.103 0.0%539 0.000 3.902 32.111
idle23:48:16.678 99.1%490672 70.747 174.652 641.802
nntp read00:00:02.252 0.0%510005 0.000 0.004 0.020
overview write00:05:45.697 0.4%16097 2.290 21.476 130.345
perl filter00:00:35.005 0.0%18974 1.341 1.845 6.058
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.306 0.0%32236 0.000 0.009 0.192
TOTAL: 24:01:03.03824:00:20.074100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.054 0.0%19427 0.000 0.003 0.032
article prepare00:00:00.003 0.0%13188 0.000 0.000 0.023
article read00:00:03.242 0.0%1182 0.000 2.743 49.000
backlog stats00:00:00.211 0.0%338031 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.448 0.0%263478 0.001 0.005 0.013
data write00:00:01.603 0.0%246966 0.000 0.006 0.016
idle23:54:43.582100.0%338031 126.700 254.662 909.156
status file00:00:01.901 0.0%283 0.000 6.717 210.000
TOTAL: 23:54:59.88423:54:52.044100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle36:25:10.031100.0%498 97.000263273.155600093.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.012 0.0%1134 0.000 0.011 0.167
readart00:00:00.496 0.0%18 0.000 27.556 68.000
TOTAL: 36:25:41.43436:25:10.539100.0%----

Control commands to INND:

CommandNumber
L 1
flush 5
flushlogs 2
go 2
logmode 2
mode 4
pause 2
paused 2
reload 2
reserve 2
TOTAL: 10 24

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 5 32352 2554 29543 255 7%47:42:02
2newsfeeds.xmission.com 2 17458 2357 15080 21 13%29:10:32
3feeder.eternal-september.org 3 19247 2137 17025 85 11%27:34:04
4news.freedyn.net 2 19001 2001 15992 1008 10%24:08:46
5csiph-out.news.xs4all.nl 876 17596 1648 14966 982 9%71:27:42
6news-out.aioe.org 3 16012 1401 14595 16 8%24:08:50
7csiph-out.feeder.erje.net 1440 77818 1236 76266 316 1%118:43:57
8newsfeed.neva.ru 148 18611 900 17463 248 4%71:43:21
9news-out.mixmin.net 3 17088 776 16140 172 4%24:02:40
10newsfeed.fu-berlin.de 8 14564 684 13787 93 4%23:15:21
11news.fcku.it 7 2014 235 1779 0 11%22:28:55
12csiph-out.feed.uzoreto.com 864 24764 199 24365 200 0%71:21:38
13nntp.pasdenom.info 2 10869 62 10798 9 0%23:58:07
14news.swapon.de 10 1138 18 1101 19 1%23:09:43
15localhost 41 9 9 0 0 100%00:00:00
16news.samoylyk.net 4 15949 8 15937 4 0%22:50:37
17news.bbs.nz 1 11997 1 11996 0 0%18:37:27
18xanadu-bbs.net 29 416 0 415 1 0%20:48:14
TOTAL: 18 3448 316903 16226 297248 3429 5%665:11:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.weretis.net7.6 MB0.0 KB4.2 MB11.7 MB 64%4.3 KB
2csiph-out.feeder.erje.net7.0 MB0.0 KB3.3 MB10.4 MB 67%6.8 KB
3newsfeeds.xmission.com6.5 MB0.0 KB534.5 KB7.0 MB 92%3.0 KB
4feeder.eternal-september.org5.8 MB0.0 KB457.7 KB6.2 MB 92%2.9 KB
5news.freedyn.net5.1 MB7.2 KB37.6 MB42.7 MB 11%14.5 KB
6csiph-out.news.xs4all.nl4.7 MB0.0 KB8.1 MB12.8 MB 36%5.0 KB
7news-out.aioe.org3.0 MB0.0 KB26.1 KB3.0 MB 99%2.2 KB
8news-out.mixmin.net2.7 MB0.0 KB338.5 KB3.1 MB 89%3.3 KB
9newsfeed.neva.ru2.1 MB0.0 KB1.1 MB3.1 MB 66%2.8 KB
10newsfeed.fu-berlin.de1.7 MB0.0 KB170.9 KB1.8 MB 90%2.4 KB
11csiph-out.feed.uzoreto.com597.9 KB0.0 KB3.7 MB4.3 MB 13%11.0 KB
12news.fcku.it428.5 KB0.0 KB0.0 KB428.5 KB100%1.8 KB
13nntp.pasdenom.info153.8 KB0.0 KB12.4 KB166.2 KB 92%2.3 KB
14news.swapon.de43.5 KB0.0 KB11.6 MB11.6 MB 0%321.9 KB
15news.samoylyk.net23.7 KB0.0 KB3.1 MB3.1 MB 0%265.9 KB
16localhost10.6 KB0.0 KB0.0 KB10.6 KB100%1.2 KB
17news.bbs.nz1.6 KB0.0 KB0.0 KB1.6 KB100%1.6 KB
18xanadu-bbs.net0.0 KB0.0 KB8.5 KB8.5 KB 0%8.5 KB
TOTAL: 1847.4 MB7.2 KB74.2 MB121.5 MB 38%6.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 11 04:15:00 - 04:59:59 185 1.1% 0.07478.6 KB 1.0% 0.18
Oct 11 05:00:00 - 05:59:59 379 2.4% 0.111.0 MB 2.2% 0.29
Oct 11 06:00:00 - 06:59:59 483 3.0% 0.131.5 MB 3.1% 0.42
Oct 11 07:00:00 - 07:59:59 681 4.2% 0.192.5 MB 5.4% 0.72
Oct 11 08:00:00 - 08:59:59 724 4.5% 0.202.2 MB 4.7% 0.62
Oct 11 09:00:00 - 09:59:59 915 5.7% 0.253.1 MB 6.7% 0.89
Oct 11 10:00:00 - 10:59:59 717 4.5% 0.201.8 MB 3.9% 0.52
Oct 11 11:00:00 - 11:59:59 806 5.0% 0.222.2 MB 4.6% 0.62
Oct 11 12:00:00 - 12:59:59 785 4.9% 0.222.1 MB 4.5% 0.60
Oct 11 13:00:00 - 13:59:59 844 5.2% 0.232.0 MB 4.3% 0.57
Oct 11 14:00:00 - 14:59:59 1148 7.1% 0.323.1 MB 6.6% 0.88
Oct 11 15:00:00 - 15:59:59 952 5.9% 0.263.2 MB 6.9% 0.92
Oct 11 16:00:00 - 16:59:59 835 5.2% 0.232.2 MB 4.7% 0.63
Oct 11 17:00:00 - 17:59:59 865 5.4% 0.242.2 MB 4.6% 0.62
Oct 11 18:00:00 - 18:59:59 949 5.9% 0.262.6 MB 5.6% 0.75
Oct 11 19:00:00 - 19:59:59 803 5.0% 0.222.3 MB 4.8% 0.65
Oct 11 20:00:00 - 20:59:59 816 5.1% 0.232.5 MB 5.2% 0.70
Oct 11 21:00:00 - 21:59:59 687 4.3% 0.192.0 MB 4.2% 0.56
Oct 11 22:00:00 - 22:59:59 599 3.7% 0.171.8 MB 3.8% 0.51
Oct 11 23:00:00 - 23:59:59 540 3.4% 0.151.7 MB 3.6% 0.48
Oct 12 00:00:00 - 00:59:59 365 2.3% 0.101.1 MB 2.4% 0.32
Oct 12 01:00:00 - 01:59:59 362 2.2% 0.101.2 MB 2.5% 0.33
Oct 12 02:00:00 - 02:59:59 319 2.0% 0.09998.4 KB 2.1% 0.28
Oct 12 03:00:00 - 03:59:59 259 1.6% 0.07912.4 KB 1.9% 0.25
Oct 12 04:00:00 - 04:15:00 72 0.4% 0.08209.9 KB 0.4% 0.23
TOTAL: 24:00:00 16090 100.0% 0.1946.9 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1017 46 0 0 0 0 0 0 971
2news.freedyn.net 1000 14 0 2 0 0 0 0 984
3newsfeed.fu-berlin.de 454 20 0 0 0 0 0 0 434
4csiph-out.feeder.erje.net 325 78 0 0 0 0 0 0 247
5csiph-out.news.weretis.net 296 83 0 0 0 0 0 0 213
6newsfeed.neva.ru 249 72 0 0 0 0 0 0 177
7csiph-out.feed.uzoreto.com 200 7 0 0 0 0 0 0 193
8news-out.mixmin.net 173 7 0 0 0 0 0 0 166
9feeder.eternal-september.org 74 16 0 0 0 0 0 0 58
10news.swapon.de 22 0 0 0 0 0 0 0 22
11news-out.aioe.org 20 11 0 0 0 0 0 0 9
12nntp.pasdenom.info 9 0 0 0 0 0 0 0 9
13newsfeeds.xmission.com 9 2 0 0 0 0 0 0 7
14news.samoylyk.net 4 0 0 0 0 0 0 0 4
15xanadu-bbs.net 1 0 0 0 0 0 0 0 1
TOTAL: 15 3853 356 0 2 0 0 0 0 3495

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 44
alt.bbs.synchronet 25
alt.binaries.pictures.purebeauty 25
alt.computer.workshop 20
alt.english.usage 17
lada.auto 16
rocksolid.shared.test 14
alt.windows7.general 14
it-alt.comp.software.mozilla 11
test.group 10
alt.testing 9
mozilla.dev.security.policy 8
mozilla.support.firefox 7
alt.binaries.ebook 7
alt.binaries.ebooks 7
it-alt.sport.calcio.juventus 6
spline.eisfair 6
mozilla.general 6
oesterreich.tratsch 5
mozilla.support.thunderbird 5
TOTAL: 77 356

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1850
EMP (phn path) 244
EMP (phl) 179
EMP (phn nph) 96
Too many newsgroups 89
HTML Multipart 17
User-issued cancel 14
Binary: misplaced rar 10
Binary Payload 7
User-issued spam cancel 6
Scoring filter (10) 5
Scoring filter (11) 4
Scoring filter (12) 3
Scoring filter (8) 2
Scoring filter (15) 1
HTML Image Tags 1
Too many newsgroups (meow) 1
TOTAL: 17 2529

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com2902929
TOTAL: 129132929

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 50
csiph-out.news.xs4all.nl 1
csiph-out.feed.uzoreto.com 1
TOTAL: 3 52
Huge articles
news.freedyn.net 315
csiph-out.news.xs4all.nl 58
csiph-out.feeder.erje.net 55
csiph-out.news.weretis.net 47
csiph-out.feed.uzoreto.com 35
news.swapon.de 19
newsfeeds.xmission.com 7
news.samoylyk.net 4
feeder.eternal-september.org 3
news-out.mixmin.net 2
TOTAL: 10 545
Including strange strings
newsfeed.fu-berlin.de 343
csiph-out.news.xs4all.nl 35
csiph-out.news.weretis.net 19
csiph-out.feeder.erje.net 8
news-out.mixmin.net 6
news-out.aioe.org 6
news.swapon.de 3
newsfeed.neva.ru 1
TOTAL: 8 421
TOTAL: 3 1018

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 18699 898 15186 0 0 0 4%23:59:29
2news.samoylyk.net 16660 468 15613 1 0 3279 2%23:59:30
3news.freedyn.net 14327 444 13586 20 0 0 3%23:59:19
4fu-berlin.de 15249 441 14808 0 0 0 2%23:59:44
5news.bbs.nz 29326 191 15391 7 0 0 0%23:50:07
6usenet.pasdenom.info 16520 99 15463 464 0 28 0%23:59:54
7neva.ru 14797 33 14403 86 0 0 0%23:59:54
8newsfeed.xs4all.nl 14703 22 13967 8 0 49 0%23:56:42
9aioe 14058 21 13611 0 0 0 0%23:50:07
10weretis.net 13032 14 12863 4 0 0 0%23:50:07
11news.mixmin.net 15108 13 14725 0 0 0 0%23:58:59
12erje 14985 13 14759 0 0 0 0%23:59:54
13xmission 16704 12 13316 0 0 0 0%23:59:54
14eternal-september 13973 11 13536 1 0 0 0%23:59:54
15news.swapon.de 1154 10 1138 0 0 0 0%23:25:13
16news.uzoreto.com 15752 1 15514 17 0 0 0%23:50:07
17news.fcku.it 1732 0 1729 0 0 0 0%22:58:59
18news.redatomik.org 0 0 0 0 0 15593 0%23:50:07
TOTAL: 18 246779 2691 219608 608 0 18949 1%429:28:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs5.9 MB0.0 KB5.9 MB0.1 KB/s6.7 KB23:59:29
2news.samoylyk.net4.8 MB3.7 KB4.8 MB0.1 KB/s10.5 KB23:59:30
3news.freedyn.net4.7 MB34.0 KB4.8 MB0.1 KB/s10.5 KB23:59:19
4fu-berlin.de4.7 MB0.0 KB4.7 MB0.1 KB/s10.9 KB23:59:44
5news.bbs.nz409.0 KB18.4 KB427.3 KB0.0 KB/s2.2 KB23:50:07
6usenet.pasdenom.info184.5 KB4.8 MB4.9 MB0.1 KB/s9.0 KB23:59:54
7neva.ru61.8 KB160.2 KB222.0 KB0.0 KB/s1.9 KB23:59:54
8newsfeed.xs4all.nl48.8 KB35.0 KB83.9 KB0.0 KB/s2.8 KB23:56:42
9aioe30.9 KB0.0 KB30.9 KB0.0 KB/s1.5 KB23:50:07
10weretis.net20.6 KB4.8 KB25.4 KB0.0 KB/s1.4 KB23:50:07
11erje20.1 KB0.0 KB20.1 KB0.0 KB/s1.5 KB23:59:54
12news.mixmin.net18.6 KB0.0 KB18.6 KB0.0 KB/s1.4 KB23:58:59
13xmission18.1 KB0.0 KB18.1 KB0.0 KB/s1.5 KB23:59:54
14eternal-september16.0 KB4.4 KB20.4 KB0.0 KB/s1.7 KB23:59:54
15news.swapon.de14.0 KB0.0 KB14.0 KB0.0 KB/s1.4 KB23:25:13
16news.uzoreto.com1.5 KB74.7 KB76.3 KB0.0 KB/s4.2 KB23:50:07
17news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:58:59
18news.redatomik.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:07
TOTAL: 1820.9 MB5.1 MB26.0 MB0.0 KB/s8.1 KB429:28:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
168-114-222-246.dhcp.mdsn.wi.charter.com 36 910.7 KB 9 9 809:35:31
2a131033.upc-a.chello.nl 85 89.8 KB 7 0 025:48:36
3208-71-239-109.cust.centrio.cz 2 14.8 KB 1 0 001:00:08
TOTAL: 3 123 1825.3 KB 17 9 836:25:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dhcp.mdsn.wi.charter.com 36 910.7 KB 9 9 809:35:31
2*.upc-a.chello.nl 85 89.8 KB 7 0 025:48:36
3*.cust.centrio.cz 2 14.8 KB 1 0 001:00:08
4unresolved 9 00.0 KB 0 0 000:01:23
TOTAL: 4 132 1825.3 KB 17 9 836:25:40

NNRP auth users [Top 20]:

UserConn
ohlandl 8
ctomczyk 2
TOTAL: 2 10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
a131033.upc-a.chello.nl 6.242 1.265 0.00025:48:36
68-114-222-246.dhcp.mdsn.wi.charter.com 2.898 0.628 0.02109:35:31
208-71-239-109.cust.centrio.cz 0.182 0.031 0.00601:00:08
108.188.110.44 0.057 0.025 0.00000:00:32
134.56.157.127 0.063 0.024 0.00000:00:32
159.203.201.69 0.066 0.017 0.00000:00:09
125.64.94.220 0.058 0.022 0.00000:00:03
94.164.196.140 0.123 0.038 0.00000:00:02
94.167.232.145 0.068 0.015 0.00000:00:01
94.161.203.162 0.066 0.015 0.00000:00:01
185.234.218.237 0.057 0.033 0.00000:00:00
TOTAL: 11 9.880 2.113 0.02736:25:40

Curious NNRP server explorers [Top 20]:

SystemConn
94.164.196.140 2
125.64.94.220 1
185.234.218.237 1
94.167.232.145 1
134.56.157.127 1
108.188.110.44 1
159.203.201.69 1
94.161.203.162 1
TOTAL: 8 9

NNRP unrecognized commands (by host):

SystemConn
134.56.157.127 10
108.188.110.44 10
185.234.218.237 1
TOTAL: 3 21

NNRP unrecognized commands (by command):

CommandCount
User-Agent: ApiTool 2
Host: 69.160.37.58 2
Accept-Language: en-us 2
Authorization: Basic YWRtaW46ezEyMjEzQkQ... 2
Content-Type: text/xml 2
Connection: close 2
Accept: */* 2
Content-Length: 586 2
Cache-Control: max-age=0 2
Accept-Encoding: identity 2
GET / HTTP/1.0 1
TOTAL: 11 21

NNRP client timeouts [Top 20]:

SystemConnPeer
68-114-222-246.dhcp.mdsn.wi.charter.com 11 0
208-71-239-109.cust.centrio.cz 2 0
185.234.218.237 1 1
TOTAL: 3 14 1

Newsgroup request counts (by category):

CategoryCountPct
1comp 18100.0%
TOTAL: 1 18100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 17
2comp.lang.javascript 1
TOTAL: 2 18