Daily Usenet report for csiph.com

Jun 10 04:15:00 -- Jun 11 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 46126 39.1%8.7 MB 55.5%
nnrpd 44484 37.7%3.9 MB 24.9%
innd 24171 20.5%2.5 MB 16.0%
innfeed 3101 2.6%552.7 KB 3.4%
nocem 109 0.1%10.7 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 117992 100.0%15.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 527167 59.1%
Negative hits 319355 35.8%
Do not exist 45125 5.1%
Cache misses 520 0.1%
TOTAL: 4 892167 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.046 0.0%297 0.000 3.522 43.125
article cleanup00:00:00.265 0.0%44589 0.000 0.006 0.048
article logging00:00:00.638 0.0%45107 0.000 0.014 0.099
article parse00:00:01.629 0.0%160831 0.000 0.010 0.023
article write00:04:53.451 0.3%25006 0.301 11.735 45.989
artlog/artcncl00:00:00.002 0.0%236 0.000 0.008 0.500
artlog/artparse00:00:00.013 0.0%799 0.000 0.016 1.000
data move00:00:00.308 0.0%843033 0.000 0.000 0.001
hisgrep/artcncl00:00:00.053 0.0%291 0.000 0.182 3.000
hishave/artcncl00:00:00.003 0.0%297 0.000 0.010 0.125
hishave/artparse00:00:00.001 0.0%206 0.000 0.005 0.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.903 0.0%896792 0.001 0.005 0.095
history sync00:00:01.423 0.0%355 0.000 4.008 69.667
history write00:00:29.164 0.0%45170 0.100 0.646 10.417
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hiswrite/artparse00:00:00.111 0.0%204 0.000 0.544 8.000
idle23:51:20.388 99.3%868052 68.165 98.935 373.984
nntp read00:00:02.862 0.0%881999 0.001 0.003 0.008
overview write00:01:18.308 0.1%25006 0.325 3.132 47.682
perl filter00:01:48.358 0.1%44435 1.265 2.439 4.048
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.419 0.0%50114 0.000 0.008 0.030
TOTAL: 24:01:04.99924:00:03.345 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.067 0.0%25009 0.000 0.003 0.018
article prepare00:00:00.005 0.0%29356 0.000 0.000 0.013
article read00:00:02.565 0.0%3912 0.000 0.656 17.625
backlog stats00:00:00.279 0.0%603917 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.175 0.0%434477 0.000 0.005 0.011
data write00:00:02.884 0.0%417753 0.002 0.007 0.013
idle23:53:05.236100.0%603917 90.425 142.379 490.221
status file00:00:00.350 0.0%234 0.000 1.496 3.500
TOTAL: 23:53:21.99723:53:13.561100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.273 0.0%8090 0.106 0.157 0.226
idle70:36:47.886 99.4%115057 83.022 2209.408600219.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.622 0.0%231425 0.000 0.007 0.997
readart00:01:38.830 0.0%24901 0.000 3.969 66.000
TOTAL: 71:01:20.33170:38:29.611 99.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 288 29182 6623 20820 1739 22%23:44:47
2csiph-out.feeder.erje.net 1151 141875 4591 127006 10278 3%95:02:54
3feeder.eternal-september.org 2 37635 3530 33191 914 9%24:13:35
4csiph-out.news.weretis.net 3 64581 2196 61696 689 3%54:05:52
5news-out.mixmin.net 2 28384 1837 26189 358 6%24:08:55
6news-out.aioe.org 4 24179 1698 22442 39 7%24:09:39
7newsfeed.neva.ru 148 64084 1400 56846 5838 2%72:11:22
8newsfeed.fu-berlin.de 63 28659 1254 26980 425 4%35:47:34
9newsfeeds.xmission.com 1 26336 740 25582 14 2%25:41:05
10news.freedyn.net 3 27695 562 27043 90 2%24:08:39
11news.fcku.it 1 10075 363 9677 35 3%23:21:46
12au2pb.net 1 26849 143 26679 27 0%24:12:45
13news.redatomik.org 1 21866 86 21778 2 0%22:26:07
14news.swapon.de 2 2610 78 2530 2 2%31:42:31
15news.bbs.geek.nz 1 24976 34 24941 1 0%23:59:42
16xanadu-bbs.net 11 724 28 676 20 3%22:54:13
17nntp.pasdenom.info 3 26167 17 26149 1 0%24:08:26
18localhost 38 4 4 0 0 100%00:00:00
TOTAL: 18 1723 585881 25184 540225 20472 4%575:59:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com20.6 MB0.0 KB21.3 MB41.8 MB 49%5.1 KB
2csiph-out.feeder.erje.net16.8 MB47.5 KB41.3 MB58.2 MB 28%4.0 KB
3feeder.eternal-september.org9.1 MB37.0 KB14.7 MB23.8 MB 38%5.5 KB
4news-out.mixmin.net7.2 MB0.0 KB1.1 MB8.4 MB 86%3.9 KB
5csiph-out.news.weretis.net6.0 MB0.0 KB8.5 MB14.5 MB 41%5.2 KB
6news-out.aioe.org3.8 MB0.0 KB69.3 KB3.8 MB 98%2.3 KB
7newsfeed.neva.ru3.3 MB35.3 KB49.8 MB53.2 MB 6%7.5 KB
8newsfeed.fu-berlin.de2.5 MB0.0 KB971.5 KB3.5 MB 72%2.1 KB
9news.freedyn.net2.0 MB0.0 KB153.3 KB2.2 MB 93%3.4 KB
10newsfeeds.xmission.com1.8 MB0.0 KB509.8 KB2.3 MB 78%3.2 KB
11news.fcku.it690.6 KB184.2 KB696.5 KB1.5 MB 43%3.9 KB
12au2pb.net356.8 KB0.0 KB955.2 KB1.3 MB 27%7.7 KB
13news.redatomik.org193.1 KB0.0 KB55.5 KB248.6 KB 77%2.8 KB
14news.swapon.de174.3 KB0.0 KB90.7 KB265.0 KB 65%3.3 KB
15xanadu-bbs.net88.7 KB0.0 KB125.0 KB213.6 KB 41%4.5 KB
16news.bbs.geek.nz46.5 KB1.7 KB1.7 KB49.9 KB 93%1.4 KB
17nntp.pasdenom.info30.0 KB0.0 KB1.5 KB31.5 KB 95%1.8 KB
18localhost4.1 KB0.0 KB0.0 KB4.1 KB100%1.0 KB
TOTAL: 1874.8 MB305.7 KB140.3 MB215.4 MB 34%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 10 04:15:00 - 04:59:59 453 1.8% 0.171.9 MB 2.5% 0.71
Jun 10 05:00:00 - 05:59:59 815 3.3% 0.233.0 MB 4.1% 0.86
Jun 10 06:00:00 - 06:59:59 910 3.6% 0.252.5 MB 3.4% 0.71
Jun 10 07:00:00 - 07:59:59 1118 4.5% 0.313.0 MB 4.0% 0.85
Jun 10 08:00:00 - 08:59:59 1134 4.5% 0.322.8 MB 3.7% 0.78
Jun 10 09:00:00 - 09:59:59 1189 4.8% 0.333.2 MB 4.3% 0.90
Jun 10 10:00:00 - 10:59:59 1154 4.6% 0.323.3 MB 4.4% 0.93
Jun 10 11:00:00 - 11:59:59 1092 4.4% 0.303.1 MB 4.2% 0.88
Jun 10 12:00:00 - 12:59:59 1160 4.6% 0.323.1 MB 4.2% 0.89
Jun 10 13:00:00 - 13:59:59 1311 5.2% 0.363.8 MB 5.1% 1.08
Jun 10 14:00:00 - 14:59:59 1420 5.7% 0.394.3 MB 5.8% 1.22
Jun 10 15:00:00 - 15:59:59 1280 5.1% 0.364.0 MB 5.4% 1.13
Jun 10 16:00:00 - 16:59:59 1284 5.1% 0.363.8 MB 5.2% 1.09
Jun 10 17:00:00 - 17:59:59 1419 5.7% 0.394.1 MB 5.5% 1.16
Jun 10 18:00:00 - 18:59:59 1402 5.6% 0.394.4 MB 5.9% 1.25
Jun 10 19:00:00 - 19:59:59 1297 5.2% 0.364.0 MB 5.4% 1.13
Jun 10 20:00:00 - 20:59:59 1148 4.6% 0.323.5 MB 4.7% 0.99
Jun 10 21:00:00 - 21:59:59 1210 4.8% 0.343.4 MB 4.6% 0.97
Jun 10 22:00:00 - 22:59:59 1073 4.3% 0.303.4 MB 4.6% 0.97
Jun 10 23:00:00 - 23:59:59 843 3.4% 0.232.4 MB 3.2% 0.68
Jun 11 00:00:00 - 00:59:59 676 2.7% 0.191.9 MB 2.5% 0.53
Jun 11 01:00:00 - 01:59:59 541 2.2% 0.151.9 MB 2.6% 0.55
Jun 11 02:00:00 - 02:59:59 533 2.1% 0.151.8 MB 2.4% 0.51
Jun 11 03:00:00 - 03:59:59 408 1.6% 0.111.4 MB 1.9% 0.41
Jun 11 04:00:00 - 04:15:00 121 0.5% 0.13351.6 KB 0.5% 0.39
TOTAL: 24:00:00 24991 100.0% 0.2974.2 MB 100.0% 0.88
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 10329 1062 0 4 0 0 0 0 9263
2newsfeed.neva.ru 5858 976 0 2 0 0 0 0 4880
3usenet.blueworldhosting.com 1747 465 0 0 1 0 0 0 1281
4feeder.eternal-september.org 936 113 0 1 0 0 0 0 822
5newsfeed.fu-berlin.de 753 35 0 0 0 0 0 0 718
6csiph-out.news.weretis.net 631 202 0 0 0 0 0 0 429
7news-out.mixmin.net 390 4 0 0 0 0 0 0 386
8news.freedyn.net 89 1 0 0 0 0 0 0 88
9news.fcku.it 53 0 0 5 0 0 0 0 48
10news-out.aioe.org 44 38 0 0 0 0 0 0 6
11au2pb.net 25 19 0 0 0 0 0 0 6
12xanadu-bbs.net 20 0 0 0 0 0 0 0 20
13newsfeeds.xmission.com 13 9 0 0 0 0 0 0 4
14news.swapon.de 9 0 0 0 0 0 0 0 9
15news.redatomik.org 4 0 0 0 0 0 0 0 4
16nntp.pasdenom.info 1 0 0 0 0 0 0 0 1
TOTAL: 16 20902 2924 0 12 1 0 0 017965

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 736
lada.talk 189
mailing.freebsd.pkg-fallout 125
it-alt.sport.calcio.juventus 88
lada.auto 86
mailing.freebsd.ports-bugs 68
ut.test 58
mailing.freebsd.svn-src-all 58
alt.windows7.general 55
mailing.freebsd.svn-ports-all 54
mailing.freebsd.svn-ports-head 54
fa.freebsd.cvs-all 47
alt.philosophy 38
spline.eisfair 38
mailing.freebsd.svn-src-stable 38
mailing.gcc.gcc-cvs 37
mpc.lists.nanog 36
mailing.database.pgsql-general 32
mailing.openssl.cvs 31
mailing.freebsd.questions 28
TOTAL: 250 2924

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

GroupsCount
it.scienza.astronomia 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11635
EMP (phn path) 2028
PFM bot misc 1427
EMP (phl) 831
EMP (phn nph) 123
Too many newsgroups 101
Binary Payload 58
HTML Multipart 57
Scoring filter (18) 28
Scoring filter (12) 22
Scoring filter (9) 22
Scoring filter (10) 20
Scoring filter (16) 18
Scoring filter (8) 17
Scoring filter (14) 16
Scoring filter (15) 14
User-issued cancel 11
Scoring filter (11) 11
Scoring filter (19) 10
Scoring filter (17) 10
TOTAL: 36 16507

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1010104104
TOTAL: 11010104104

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 140
usenet.blueworldhosting.com 2
TOTAL: 2 142
Huge articles
usenet.blueworldhosting.com 114
feeder.eternal-september.org 31
csiph-out.news.weretis.net 29
news.fcku.it 17
news-out.mixmin.net 8
newsfeeds.xmission.com 4
news.redatomik.org 2
news.swapon.de 1
TOTAL: 8 206
Including strange strings
newsfeed.fu-berlin.de 380
csiph-out.feeder.erje.net 48
feeder.eternal-september.org 34
news-out.mixmin.net 19
csiph-out.news.weretis.net 16
news.swapon.de 7
news-out.aioe.org 5
news.fcku.it 4
newsfeed.neva.ru 3
news.redatomik.org 1
TOTAL: 10 517
No colon-space in header
csiph-out.feeder.erje.net 590
TOTAL: 1 590
TOTAL: 4 1455

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 45459 2280 21791 42 0 58 5%23:59:56
2news.freedyn.net 27986 1078 23339 9 0 1 3%23:59:56
3xanadu-bbs 28651 935 24014 0 0 9 3%23:59:56
4fu-berlin.de 23497 707 22790 0 0 0 3%23:59:56
5weretis.net 23008 162 20996 34 0 0 0%23:59:45
6aioe 24525 148 20735 19 0 1 0%23:59:56
7xmission 28455 145 23388 1 0 0 0%23:59:56
8usenet.pasdenom.info 32722 137 23646 1188 0 3 0%23:59:43
9erje 20616 134 20087 114 0 0 0%23:59:34
10au2pb 26562 87 23934 0 0 0 0%23:59:56
11news.redatomik.org 28483 83 23793 5 0 1 0%23:59:56
12news.mixmin.net 25407 10 21867 0 0 1 0%23:59:56
13bwh 19989 8 17165 0 0 0 0%23:59:56
14neva.ru 28087 6 22399 26 0 1 0%23:59:55
15eternal-september 25916 6 20320 0 0 1 0%23:59:56
16news.swapon.de 2339 4 2058 0 0 0 0%23:58:22
17news.fcku.it 3215 0 2903 0 0 0 0%22:29:54
TOTAL: 17 414917 5930 335225 1438 0 76 1%406:26:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net8.0 MB62.6 KB8.1 MB0.1 KB/s7.6 KB23:59:56
2xanadu-bbs7.5 MB0.0 KB7.5 MB0.1 KB/s8.3 KB23:59:56
3fu-berlin.de6.9 MB0.0 KB6.9 MB0.1 KB/s10.0 KB23:59:56
4news.bbs.geek.nz6.0 MB191.0 KB6.2 MB0.1 KB/s2.7 KB23:59:56
5xmission442.9 KB1.2 KB444.0 KB0.0 KB/s3.0 KB23:59:56
6weretis.net442.6 KB208.2 KB650.7 KB0.0 KB/s3.3 KB23:59:45
7usenet.pasdenom.info351.6 KB8.2 MB8.6 MB0.1 KB/s6.6 KB23:59:43
8erje338.8 KB616.3 KB955.2 KB0.0 KB/s3.9 KB23:59:34
9aioe299.3 KB33.1 KB332.3 KB0.0 KB/s2.0 KB23:59:56
10news.redatomik.org197.5 KB43.4 KB240.9 KB0.0 KB/s2.7 KB23:59:56
11au2pb162.6 KB0.0 KB162.6 KB0.0 KB/s1.9 KB23:59:56
12eternal-september28.4 KB0.0 KB28.4 KB0.0 KB/s4.7 KB23:59:56
13news.mixmin.net25.8 KB0.0 KB25.8 KB0.0 KB/s2.6 KB23:59:56
14bwh11.8 KB0.0 KB11.8 KB0.0 KB/s1.5 KB23:59:56
15neva.ru6.8 KB137.0 KB143.8 KB0.0 KB/s4.5 KB23:59:55
16news.swapon.de4.1 KB0.0 KB4.1 KB0.0 KB/s1.0 KB23:58:22
17news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:29:54
TOTAL: 1730.8 MB9.5 MB40.3 MB0.0 KB/s5.6 KB406:26:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1202.89.176.220 288 56167.2 KB 54 0 004:50:36
2mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca 125 2348.9 KB 19 0 002:00:36
368-185-181-64.dhcp.mdsn.wi.charter.com 21 44.1 KB 4 4 406:57:06
4challenger.nielsenmedia.com 15 23.1 KB 2 0 003:49:44
5dhcp-089-099-203-254.chello.nl 73 22.6 KB 2 0 030:47:39
TOTAL: 5 522 87225.9 KB 81 4 471:01:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 289 56167.2 KB 54 0 026:56:05
2*.dsl.bell.ca 125 2348.9 KB 19 0 002:00:36
3*.dhcp.mdsn.wi.charter.com 21 44.1 KB 4 4 406:57:06
4*.nielsenmedia.com 15 23.1 KB 2 0 003:49:44
5*.chello.nl 73 22.6 KB 2 0 030:47:39
6*.sub-70-193-244.myvzw.com 1 00.0 KB 0 0 000:30:01
TOTAL: 6 524 87225.9 KB 81 4 471:01:15

NNRP auth users [Top 20]:

UserConn
moussa 288
ohlandl 4
TOTAL: 2 292

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dhcp-089-099-203-254.chello.nl 6.189 1.400 0.00030:47:39
216.239.174.71 0.431 0.533 0.00022:02:30
68-185-181-64.dhcp.mdsn.wi.charter.com 1.946 0.494 0.00906:57:06
202.89.176.220 29.703 7.541 0.79404:50:36
challenger.nielsenmedia.com 1.261 0.282 0.00003:49:44
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca 16.711 5.707 0.00002:00:36
227.sub-70-193-244.myvzw.com 0.097 0.016 0.00000:30:01
196.52.22.50 0.508 1.427 0.00000:02:58
TOTAL: 8 56.846 17.400 0.80371:01:15

Curious NNRP server explorers [Top 20]:

SystemConn
227.sub-70-193-244.myvzw.com 1
196.52.22.50 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
dhcp-089-099-203-254.chello.nl 51 0
68-185-181-64.dhcp.mdsn.wi.charter.com 9 0
challenger.nielsenmedia.com 6 3
227.sub-70-193-244.myvzw.com 1 0
TOTAL: 4 67 3

Newsgroup request counts (by category):

CategoryCountPct
1comp 66 75.9%
2uk 11 12.6%
3alt 6 6.9%
4rec 4 4.6%
TOTAL: 4 87100.0%

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

NewsgroupCount
1comp.os.vms 18
2comp.sys.ibm.ps2.hardware 10
3comp.arch 8
4comp.sys.ibm.pc.games.action 6
5comp.arch.fpga 6
6comp.os.cpm 3
7comp.arch.embedded 3
8uk.d-i-y 3
9comp.sys.ibm.pc.games.rpg 3
10rec.arts.tv 3
11comp.ai.neural-nets 2
12uk.media.radio.archers 2
13comp.lang.python 2
14uk.legal 2
15comp.lang.awk 2
16alt.happy.valley 2
17alt.os.linux.ubuntu 1
18alt.home.repair 1
19alt.tv.general-hospital 1
20uk.tech.digital-tv 1
21uk.rec.sheds 1
22uk.rec.audio 1
23comp.sys.ibm.pc.games.adventure 1
24comp.ai.nat-lang 1
25uk.comp.sys.mac 1
26rec.boats 1
27comp.sys.ibm.pc.games.war-historical 1
28alt.os.linux.mageia 1
TOTAL: 28 87