Daily Usenet report for csiph.com

Oct 14 04:15:00 -- Oct 15 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 34662 63.1%7.3 MB 74.4%
innd 14902 27.1%1.8 MB 17.9%
innfeed 4045 7.4%626.5 KB 6.2%
nnrpd 1291 2.3%143.0 KB 1.4%
nocem 41 0.1%4.5 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 54942 100.0%9.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 412028 56.5%
Negative hits 283000 38.8%
Do not exist 33918 4.6%
Cache misses 534 0.1%
TOTAL: 4 729480 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.755 0.0%158 0.000 4.778 25.000
article cleanup00:00:00.216 0.0%33711 0.000 0.006 0.034
article logging00:00:00.546 0.0%34225 0.000 0.016 0.394
article parse00:00:01.076 0.0%92213 0.000 0.012 0.030
article write00:06:50.646 0.5%23836 0.350 17.228 63.646
artlog/artcncl00:00:00.001 0.0%140 0.000 0.007 0.167
artlog/artparse00:00:00.003 0.0%214 0.000 0.014 1.000
data move00:00:00.218 0.0%686144 0.000 0.000 0.002
hisgrep/artcncl00:00:00.092 0.0%158 0.000 0.582 7.000
hishave/artcncl00:00:00.000 0.0%158 0.000 0.000 0.000
hishave/artparse00:00:00.002 0.0%213 0.000 0.009 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.101 0.0%729423 0.000 0.011 0.265
history sync00:00:02.056 0.0%363 0.000 5.664 83.000
history write00:00:26.765 0.0%33708 0.062 0.794 27.536
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.093 0.0%212 0.000 0.439 5.000
idle23:39:40.243 99.2%683324 68.643 124.656 476.428
nntp read00:00:02.364 0.0%701450 0.001 0.003 0.007
overview write00:01:42.028 0.1%23836 0.441 4.280 70.175
perl filter00:01:09.239 0.1%33706 1.408 2.054 4.598
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.420 0.0%47708 0.000 0.009 0.032
TOTAL: 23:50:55.86223:50:04.864 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.075 0.0%28665 0.000 0.003 0.029
article prepare00:00:00.004 0.0%32752 0.000 0.000 0.010
article read00:00:04.857 0.0%5642 0.000 0.861 11.800
backlog stats00:00:00.244 0.0%433044 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.848 0.0%333474 0.001 0.006 0.018
data write00:00:02.324 0.0%316002 0.002 0.007 0.016
idle23:54:37.630100.0%433044 110.697 198.773 613.391
status file00:00:00.891 0.0%642 0.000 1.388 55.000
TOTAL: 23:54:56.15223:54:47.873100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.949 0.0%2751 0.000 0.345 2.226
idle72:05:15.158 99.8%3277 411.040 79192.908900199.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.288 0.0%6862 0.000 0.333 12.258
readart00:00:18.209 0.0%7392 0.000 2.463 49.000
TOTAL: 72:14:46.05172:05:36.604 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 114448 6426 101157 6865 5%95:03:04
2csiph-out.news.weretis.net 4 51892 4614 46730 548 8%47:54:32
3feeder.eternal-september.org 5 29605 3733 25587 285 12%24:37:21
4news-out.mixmin.net 2 26941 2258 24062 621 8%24:08:54
5newsfeed.neva.ru 146 40556 1475 37883 1198 3%71:27:29
6news-out.aioe.org 7 24503 1363 23118 22 5%24:25:17
7news.redatomik.org 1 21437 1043 20359 35 4%20:41:28
8newsfeeds.xmission.com 1 24230 1028 23173 29 4%25:41:05
9newsfeed.fu-berlin.de 41 24445 992 22993 460 4%28:41:55
10news.fcku.it 1 10575 512 9932 131 4%23:59:56
11xanadu-bbs.net 6 633 131 497 5 20%13:58:40
12news.freedyn.net 4 26290 53 26203 34 0%24:10:15
13news.swapon.de 1 1797 44 1753 0 2%24:55:57
14nntp.pasdenom.info 2 31702 18 31662 22 0%24:08:59
15news.bbs.geek.nz 2 22470 11 22458 1 0%23:59:48
16localhost 32 0 0 0 0 0%00:00:00
TOTAL: 16 1407 451524 23701 417567 10256 5%497:54:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net19.4 MB0.0 KB20.9 MB40.3 MB 48%3.1 KB
2csiph-out.news.weretis.net13.2 MB1.0 KB10.3 MB23.4 MB 56%4.6 KB
3feeder.eternal-september.org9.3 MB3.5 KB7.8 MB17.1 MB 54%4.4 KB
4news-out.mixmin.net7.6 MB2.7 KB1.6 MB9.2 MB 82%3.3 KB
5newsfeed.neva.ru4.1 MB0.0 KB2.6 MB6.8 MB 61%2.6 KB
6news-out.aioe.org3.4 MB2.7 KB65.6 KB3.4 MB 98%2.5 KB
7newsfeeds.xmission.com3.1 MB1.0 KB1.7 MB4.8 MB 64%4.7 KB
8news.redatomik.org2.7 MB1.1 KB931.9 KB3.6 MB 74%3.4 KB
9newsfeed.fu-berlin.de2.1 MB1.0 KB891.8 KB3.0 MB 71%2.1 KB
10news.fcku.it1.1 MB0.0 KB2.2 MB3.3 MB 32%5.2 KB
11xanadu-bbs.net327.2 KB0.0 KB59.0 KB386.2 KB 84%2.8 KB
12news.freedyn.net279.6 KB1.1 KB2.3 MB2.6 MB 10%30.6 KB
13news.swapon.de102.6 KB0.0 KB0.0 KB102.6 KB100%2.3 KB
14nntp.pasdenom.info33.8 KB3.1 KB377.6 KB414.5 KB 8%10.4 KB
15news.bbs.geek.nz20.6 KB1.1 KB1.1 KB22.7 KB 90%1.9 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1666.7 MB18.3 KB51.7 MB118.4 MB 56%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 14 04:15:00 - 04:59:59 401 1.7% 0.151.6 MB 2.4% 0.61
Oct 14 05:00:00 - 05:59:59 467 2.0% 0.131.3 MB 1.9% 0.37
Oct 14 06:00:00 - 06:59:59 714 3.0% 0.202.1 MB 3.1% 0.60
Oct 14 07:00:00 - 07:59:59 988 4.1% 0.272.6 MB 3.9% 0.74
Oct 14 08:00:00 - 08:59:59 1104 4.6% 0.312.9 MB 4.4% 0.83
Oct 14 09:00:00 - 09:59:59 1192 5.0% 0.333.0 MB 4.5% 0.85
Oct 14 10:00:00 - 10:59:59 1240 5.2% 0.343.1 MB 4.6% 0.88
Oct 14 11:00:00 - 11:59:59 1093 4.6% 0.302.8 MB 4.2% 0.80
Oct 14 12:00:00 - 12:59:59 1134 4.7% 0.322.8 MB 4.1% 0.79
Oct 14 13:00:00 - 13:59:59 1375 5.8% 0.383.5 MB 5.2% 0.99
Oct 14 14:00:00 - 14:59:59 1339 5.6% 0.373.8 MB 5.6% 1.07
Oct 14 15:00:00 - 15:59:59 1430 6.0% 0.404.4 MB 6.6% 1.26
Oct 14 16:00:00 - 16:59:59 1298 5.4% 0.363.6 MB 5.4% 1.03
Oct 14 17:00:00 - 17:59:59 1422 5.9% 0.404.5 MB 6.7% 1.28
Oct 14 18:00:00 - 18:59:59 1300 5.4% 0.363.8 MB 5.6% 1.07
Oct 14 19:00:00 - 19:59:59 1320 5.5% 0.373.5 MB 5.2% 1.00
Oct 14 20:00:00 - 20:59:59 1316 5.5% 0.373.7 MB 5.4% 1.04
Oct 14 21:00:00 - 21:59:59 1167 4.9% 0.323.3 MB 4.9% 0.93
Oct 14 22:00:00 - 22:59:59 986 4.1% 0.272.8 MB 4.2% 0.81
Oct 14 23:00:00 - 23:59:59 695 2.9% 0.192.1 MB 3.1% 0.59
Oct 15 00:00:00 - 00:59:59 501 2.1% 0.141.6 MB 2.4% 0.46
Oct 15 01:00:00 - 01:59:59 466 1.9% 0.131.3 MB 1.9% 0.37
Oct 15 02:00:00 - 02:59:59 458 1.9% 0.131.3 MB 2.0% 0.38
Oct 15 03:00:00 - 03:59:59 393 1.6% 0.111.2 MB 1.8% 0.34
Oct 15 04:00:00 - 04:15:00 102 0.4% 0.11458.4 KB 0.7% 0.51
TOTAL: 24:00:00 23901 100.0% 0.2867.0 MB 100.0% 0.79
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 6876 628 0 0 3 0 0 0 6245
2newsfeed.neva.ru 1210 381 0 0 0 0 0 0 829
3newsfeed.fu-berlin.de 804 44 0 0 0 0 0 0 760
4news-out.mixmin.net 642 3 0 0 0 0 0 0 639
5csiph-out.news.weretis.net 482 263 0 0 0 0 0 0 219
6feeder.eternal-september.org 319 53 0 2 0 0 0 0 264
7news.fcku.it 125 0 0 1 0 0 0 0 124
8news.redatomik.org 54 0 0 0 0 0 0 0 54
9news-out.aioe.org 28 9 0 0 0 0 0 0 19
10newsfeeds.xmission.com 22 1 0 0 0 0 0 0 21
11nntp.pasdenom.info 20 0 0 1 0 0 0 0 19
12news.freedyn.net 17 0 0 0 0 0 0 0 17
13news.swapon.de 8 0 0 0 0 0 0 0 8
14xanadu-bbs.net 5 0 0 0 0 0 0 0 5
TOTAL: 14 10612 1382 0 4 3 0 0 0 9223

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 284
ut.test 213
lada.talk 118
lada.auto 85
fa.freebsd.cvs-all 63
lada.photo 50
alt.windows7.general 36
mozilla.dev.security.policy 35
spline.eisfair 34
fa.openbsd.tech 22
alt.survival 19
it-alt.sport.calcio.juventus 18
mozilla.support.seamonkey 18
fa.freebsd.bugs 18
cakewalk.audio 11
alt.english.usage 10
alt.politics 10
mozilla.general 10
gmane.comp.bacula.user 9
mozilla.dev.platform 9
TOTAL: 142 1382

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
misc.activism.progressive 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6183
EMP (phn path) 1399
EMP (phl) 527
EMP (phn nph) 99
Binary Payload 90
Too many newsgroups 82
User-issued cancel 20
Scoring filter (14) 11
HTML Multipart 11
Scoring filter (8) 8
Scoring filter (10) 7
Scoring filter (19) 6
User-issued spam cancel 6
Scoring filter (9) 5
Scoring filter (16) 5
Scoring filter (11) 5
HTML post 5
Scoring filter (12) 5
Scoring filter (17) 4
Scoring filter (15) 4
TOTAL: 28 8494

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com3503737
TOTAL: 13503737

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
feeder.eternal-september.org 69
csiph-out.news.weretis.net 66
news.fcku.it 29
newsfeeds.xmission.com 19
news-out.mixmin.net 12
news.freedyn.net 8
nntp.pasdenom.info 6
news.redatomik.org 3
xanadu-bbs.net 1
TOTAL: 9 213
Including strange strings
newsfeed.fu-berlin.de 335
feeder.eternal-september.org 56
news.redatomik.org 27
news-out.mixmin.net 23
csiph-out.news.weretis.net 22
csiph-out.feeder.erje.net 20
newsfeed.neva.ru 14
news-out.aioe.org 8
news.swapon.de 8
newsfeeds.xmission.com 1
TOTAL: 10 514
No colon-space in header
csiph-out.feeder.erje.net 1
TOTAL: 1 1
TOTAL: 3 728

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 41537 3897 19146 76 0 1 9%23:56:50
2xanadu-bbs 25658 1045 23173 25 0 4245 4%23:58:59
3news.freedyn.net 24714 933 22873 49 0 0 3%23:57:56
4fu-berlin.de 22568 685 21883 0 0 0 3%23:59:25
5usenet.pasdenom.info 25905 101 22607 1175 0 0 0%23:59:54
6aioe 20959 48 20185 9 0 8 0%24:07:44
7news.redatomik.org 22587 47 21935 1 0 0 0%24:02:19
8xmission 26602 36 22145 6 0 0 0%23:59:55
9weretis.net 16580 8 16017 4 0 0 0%23:59:54
10eternal-september 20733 6 19055 0 0 0 0%23:59:55
11erje 17479 2 17355 15 0 3 0%23:55:22
12news.fcku.it 3098 0 3043 0 0 0 0%23:12:19
13au2pb 0 0 0 0 0 23080 0%23:50:06
14bwh 0 0 0 0 0 23126 0%23:58:44
15news.mixmin.net 21134 0 20496 0 0 0 0%23:57:25
16neva.ru 22441 0 21248 18 0 0 0%23:59:42
17news.swapon.de 1973 0 1922 4 0 0 0%23:57:12
TOTAL: 17 313968 6808 273083 1382 0 50463 2%406:53:41
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.bbs.geek.nz9.6 MB257.5 KB9.8 MB0.1 KB/s2.5 KB23:56:50
2xanadu-bbs6.1 MB69.2 KB6.2 MB0.1 KB/s5.9 KB23:58:59
3news.freedyn.net5.7 MB60.5 KB5.8 MB0.1 KB/s6.0 KB23:57:56
4fu-berlin.de5.1 MB0.0 KB5.1 MB0.1 KB/s7.6 KB23:59:25
5usenet.pasdenom.info312.6 KB5.8 MB6.1 MB0.1 KB/s4.9 KB23:59:54
6aioe112.1 KB24.1 KB136.1 KB0.0 KB/s2.4 KB24:07:44
7news.redatomik.org106.2 KB2.9 KB109.2 KB0.0 KB/s2.3 KB24:02:19
8xmission97.1 KB13.9 KB111.1 KB0.0 KB/s2.6 KB23:59:55
9weretis.net21.2 KB30.9 KB52.1 KB0.0 KB/s4.3 KB23:59:54
10eternal-september17.3 KB0.0 KB17.3 KB0.0 KB/s2.9 KB23:59:55
11erje3.3 KB33.3 KB36.5 KB0.0 KB/s2.1 KB23:55:22
12news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s023:12:19
13au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:06
14bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:44
15news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:25
16neva.ru0.0 KB41.7 KB41.7 KB0.0 KB/s2.3 KB23:59:42
17news.swapon.de0.0 KB6.9 KB6.9 KB0.0 KB/s1.7 KB23:57:12
TOTAL: 1727.1 MB6.3 MB33.5 MB0.0 KB/s4.2 KB406:53:41
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1c-73-195-247-24.hsd1.nj.comcast.net 14 2241.5 KB 4 0 005:54:04
2challenger.nielsenmedia.com 8 2241.5 KB 4 0 002:00:56
3tempe0.bbox.io 56 1046.4 KB 4 0 007:10:07
TOTAL: 3 78 54129.5 KB 12 0 072:14:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.hsd1.nj.comcast.net 14 2241.5 KB 4 0 005:54:04
2*.nielsenmedia.com 8 2241.5 KB 4 0 002:00:56
3*.bbox.io 56 1046.4 KB 4 0 007:10:07
4unresolved 101 00.0 KB 0 0 048:55:10
5*.133.22.98.dynamic.ip.windstream.net 1 00.0 KB 0 0 002:08:40
6*.chello.nl 32 00.0 KB 0 0 005:02:23
7*.dhcp.mdsn.wi.charter.com 5 00.0 KB 0 0 001:03:20
TOTAL: 7 217 54129.5 KB 12 0 072:14:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
216.239.174.218 8.011 1.873 0.00048:47:19
tempe0.bbox.io 4.555 1.265 0.00007:10:07
c-73-195-247-24.hsd1.nj.comcast.net 1.478 0.326 0.00005:54:04
dhcp-089-099-203-254.chello.nl 2.575 0.621 0.00005:02:23
h132.133.22.98.dynamic.ip.windstream.net 0.164 0.064 0.00002:08:40
challenger.nielsenmedia.com 0.805 0.211 0.00002:00:56
68-185-181-64.dhcp.mdsn.wi.charter.com 0.449 0.103 0.00001:03:20
5.51.176.30 0.177 0.070 0.00000:07:20
196.52.16.10 0.310 0.814 0.00000:00:30
TOTAL: 9 18.524 5.347 0.00072:14:44

Curious NNRP server explorers [Top 20]:

SystemConn
216.239.174.218 96
dhcp-089-099-203-254.chello.nl 32
68-185-181-64.dhcp.mdsn.wi.charter.com 5
5.51.176.30 4
196.52.16.10 1
h132.133.22.98.dynamic.ip.windstream.net 1
TOTAL: 6 139

NNRP client timeouts [Top 20]:

SystemConnPeer
216.239.174.218 94 0
tempe0.bbox.io 12 0
c-73-195-247-24.hsd1.nj.comcast.net 10 0
challenger.nielsenmedia.com 4 0
68-185-181-64.dhcp.mdsn.wi.charter.com 2 0
h132.133.22.98.dynamic.ip.windstream.net 1 0
TOTAL: 6 123 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 46 85.2%
2muc 8 14.8%
TOTAL: 2 54100.0%

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

NewsgroupCount
1comp.lang.awk 44
2muc.lists.freebsd.stable 8
3comp.sys.ibm.ps2.hardware 2
TOTAL: 3 54