Daily Usenet report for csiph.com

Mar 11 04:15:00 -- Mar 12 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 11 15:00:02 csiph pgpverify[40939]: pgpverify: verification failed
Mar 11 15:00:02 csiph pgpverify[40947]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 23232 52.1%4.9 MB 66.2%
innd 11138 25.0%1.4 MB 18.3%
nnrpd 7241 16.2%656.2 KB 8.6%
innfeed 2800 6.3%504.1 KB 6.6%
nocem 182 0.4%20.5 KB 0.3%
controlchan 2 0.0%0.1 KB 0.0%
pgpverify 2 0.0%0.3 KB 0.0%
TOTAL: 7 44597 100.0%7.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 263690 56.2%
Negative hits 182978 39.0%
Do not exist 22394 4.8%
Cache misses 321 0.1%
TOTAL: 4 469383 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.191 0.0%369 0.000 8.648 334.000
article cleanup00:00:00.161 0.0%22152 0.000 0.007 0.070
article logging00:00:03.047 0.0%22665 0.000 0.134 6.074
article parse00:00:02.425 0.0%61255 0.000 0.040 1.158
article write00:03:57.464 0.3%16690 0.648 14.228 186.698
artlog/artcncl00:00:00.001 0.0%300 0.000 0.003 0.071
artlog/artparse00:00:00.403 0.0%276 0.000 1.460 65.000
data move00:00:00.134 0.0%456473 0.000 0.000 0.002
hisgrep/artcncl00:00:00.015 0.0%365 0.000 0.041 1.000
hishave/artcncl00:00:00.005 0.0%369 0.000 0.014 1.000
hishave/artparse00:00:00.000 0.0%276 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:28.291 0.0%469484 0.003 0.060 1.531
history sync00:00:04.436 0.0%372 0.000 11.925 404.000
history write00:01:12.203 0.1%22149 0.314 3.260 36.289
hiswrite/artcncl00:00:00.030 0.0%4 0.000 7.500 30.000
hiswrite/artparse00:00:01.224 0.0%275 0.000 4.451 261.000
idle23:46:14.651 99.0%447360 98.284 191.288 658.524
nntp read00:00:02.383 0.0%463891 0.002 0.005 0.011
overview write00:07:13.600 0.5%16690 1.646 25.980 457.815
perl filter00:00:45.023 0.1%21968 1.171 2.049 8.173
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.337 0.0%33558 0.000 0.010 0.046
TOTAL: 24:01:04.27124:00:09.024 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.045 0.0%16664 0.000 0.003 0.026
article prepare00:00:00.003 0.0%16356 0.000 0.000 0.021
article read00:00:09.179 0.0%2029 0.000 4.524 38.000
backlog stats00:00:00.187 0.0%314216 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.686 0.0%238773 0.000 0.007 0.015
data write00:00:01.489 0.0%224507 0.002 0.007 0.016
idle23:54:35.102100.0%314216 157.837 273.936 840.427
status file00:00:01.647 0.0%237 0.000 6.949 184.000
TOTAL: 23:54:59.85223:54:49.338100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle33:50:16.618 99.9%17799 92.453 6844.015450624.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.571 0.0%36851 0.000 0.015 11.677
readart00:01:48.406 0.1%10147 0.000 10.684 68.000
TOTAL: 33:53:05.61733:52:05.595100.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000200
TOTAL000200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 71733 4603 65061 2069 6%94:58:20
2csiph-out.news.weretis.net 10 33811 3570 29995 246 10%47:40:21
3feeder.eternal-september.org 5 19205 2817 15028 1360 14%24:24:01
4news-out.aioe.org 2 16127 1468 14635 24 9%24:09:53
5newsfeed.fu-berlin.de 12 16696 1050 15412 234 6%27:23:15
6news.redatomik.org 3 14546 1034 13502 10 7%22:49:06
7newsfeed.neva.ru 144 21732 711 19589 1432 3%71:20:15
8newsfeeds.xmission.com 2 18303 580 17707 16 3%27:40:04
9news.fcku.it 1 7338 446 6770 122 6%23:59:58
10news-out.mixmin.net 1 17471 298 16989 184 1%23:59:32
11news.swapon.de 5 1823 60 1756 7 3%23:44:26
12news.freedyn.net 2 18256 41 18193 22 0%24:42:45
13nntp.pasdenom.info 2 15200 27 15170 3 0%23:59:23
14localhost 49 16 16 0 0 100%00:00:05
15news.bbs.geek.nz 3 19206 2 19204 0 0%28:01:26
16xanadu-bbs.net 23 527 0 527 0 0%22:50:46
TOTAL: 16 1416 291990 16723 269538 5729 5%511:43:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net15.7 MB64.8 KB11.2 MB26.9 MB 58%4.1 KB
2csiph-out.news.weretis.net11.7 MB0.0 KB10.6 MB22.2 MB 52%6.0 KB
3feeder.eternal-september.org8.0 MB0.0 KB5.3 MB13.3 MB 59%3.3 KB
4news-out.aioe.org3.8 MB0.0 KB48.7 KB3.9 MB 98%2.7 KB
5news.redatomik.org2.6 MB0.0 KB458.2 KB3.0 MB 85%3.0 KB
6newsfeed.fu-berlin.de2.3 MB0.0 KB394.7 KB2.7 MB 85%2.1 KB
7newsfeed.neva.ru1.9 MB0.0 KB14.2 MB16.0 MB 11%7.7 KB
8newsfeeds.xmission.com1.8 MB0.0 KB120.4 KB1.9 MB 93%3.3 KB
9news.fcku.it1.2 MB0.0 KB2.1 MB3.3 MB 37%6.0 KB
10news-out.mixmin.net1.2 MB0.0 KB623.2 KB1.8 MB 66%3.9 KB
11news.swapon.de123.6 KB0.0 KB2.6 MB2.8 MB 4%42.1 KB
12news.freedyn.net122.6 KB0.0 KB749.3 KB871.9 KB 14%13.8 KB
13nntp.pasdenom.info54.0 KB0.0 KB4.8 KB58.8 KB 91%2.0 KB
14localhost29.9 KB0.0 KB0.0 KB29.9 KB100%1.9 KB
15news.bbs.geek.nz10.4 KB0.0 KB0.0 KB10.4 KB100%5.2 KB
16xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1650.5 MB64.8 KB48.3 MB98.9 MB 51%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 11 04:15:00 - 04:59:59 245 1.5% 0.09738.5 KB 1.4% 0.27
Mar 11 05:00:00 - 05:59:59 351 2.1% 0.101.2 MB 2.3% 0.34
Mar 11 06:00:00 - 06:59:59 387 2.3% 0.111.1 MB 2.2% 0.32
Mar 11 07:00:00 - 07:59:59 453 2.7% 0.131.6 MB 3.2% 0.47
Mar 11 08:00:00 - 08:59:59 615 3.7% 0.171.7 MB 3.4% 0.49
Mar 11 09:00:00 - 09:59:59 756 4.5% 0.212.5 MB 5.0% 0.72
Mar 11 10:00:00 - 10:59:59 910 5.5% 0.252.9 MB 5.7% 0.82
Mar 11 11:00:00 - 11:59:59 800 4.8% 0.222.6 MB 5.1% 0.73
Mar 11 12:00:00 - 12:59:59 728 4.4% 0.201.9 MB 3.7% 0.54
Mar 11 13:00:00 - 13:59:59 792 4.7% 0.222.1 MB 4.2% 0.60
Mar 11 14:00:00 - 14:59:59 819 4.9% 0.232.4 MB 4.7% 0.68
Mar 11 15:00:00 - 15:59:59 939 5.6% 0.263.0 MB 5.9% 0.85
Mar 11 16:00:00 - 16:59:59 965 5.8% 0.272.8 MB 5.5% 0.79
Mar 11 17:00:00 - 17:59:59 931 5.6% 0.262.4 MB 4.7% 0.68
Mar 11 18:00:00 - 18:59:59 911 5.5% 0.252.3 MB 4.6% 0.66
Mar 11 19:00:00 - 19:59:59 1042 6.2% 0.293.5 MB 6.9% 0.99
Mar 11 20:00:00 - 20:59:59 996 6.0% 0.283.0 MB 6.0% 0.86
Mar 11 21:00:00 - 21:59:59 858 5.1% 0.242.4 MB 4.8% 0.69
Mar 11 22:00:00 - 22:59:59 712 4.3% 0.202.1 MB 4.2% 0.60
Mar 11 23:00:00 - 23:59:59 696 4.2% 0.192.4 MB 4.8% 0.69
Mar 12 00:00:00 - 00:59:59 559 3.4% 0.161.7 MB 3.4% 0.49
Mar 12 01:00:00 - 01:59:59 473 2.8% 0.131.5 MB 3.0% 0.43
Mar 12 02:00:00 - 02:59:59 370 2.2% 0.101.1 MB 2.2% 0.32
Mar 12 03:00:00 - 03:59:59 294 1.8% 0.081.1 MB 2.2% 0.32
Mar 12 04:00:00 - 04:15:00 81 0.5% 0.09367.5 KB 0.7% 0.41
TOTAL: 24:00:00 16683 100.0% 0.1950.5 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 2091 155 0 3 0 0 0 0 1933
2newsfeed.neva.ru 1437 103 0 0 0 0 0 0 1334
3feeder.eternal-september.org 1364 59 0 0 0 0 0 0 1305
4newsfeed.fu-berlin.de 667 54 0 0 0 0 0 0 613
5csiph-out.news.weretis.net 255 96 0 0 0 0 0 0 159
6news-out.mixmin.net 190 0 0 0 0 0 0 0 190
7news.fcku.it 129 1 0 0 0 0 0 0 128
8news-out.aioe.org 27 22 0 0 0 0 0 0 5
9news.swapon.de 27 0 0 0 0 0 0 0 27
10news.redatomik.org 25 0 0 0 0 0 0 0 25
11news.freedyn.net 16 0 0 0 0 0 0 0 16
12newsfeeds.xmission.com 14 1 0 0 0 0 0 0 13
13news.bbs.geek.nz 4 0 0 0 0 0 0 0 4
14nntp.pasdenom.info 3 3 0 0 0 0 0 0 0
TOTAL: 14 6249 494 0 3 0 0 0 0 5752

Unwanted newsgroups [Top 20]:

NewsgroupCount
spline.eisfair 46
alt.windows7.general 40
mpc.lists.freebsd.x11 33
alt.bbs.synchronet 27
lada.talk 25
free.it.religioni.scientology 22
mozilla.support.thunderbird 19
mpc.lists.freebsd.ports.bugs 18
it-alt.sport.calcio.juventus 18
gmane.comp.gis.openstreetmap.tagging 15
lada.auto 14
lada.kitchen 13
cakewalk.audio 12
oesterreich.tratsch 10
mpc.lists.freebsd.gnome 9
mozilla.support.firefox 8
lada.photo 7
mozilla.support.seamonkey 7
alt.survival 6
alt.religion 6
TOTAL: 97 494

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3821
Binary: misplaced rar 347
EMP (phn path) 300
EMP (phn nph) 153
Too many newsgroups 53
HTML Multipart 31
EMP (phl) 16
User-issued cancel 14
Binary Payload 12
Scoring filter (10) 10
Too many newsgroups (low_xpost) 8
HTML post 5
Scoring filter (11) 2
Binary Image: misplaced png 2
Scoring filter (8) 2
Too many newsgroups (meow) 1
Scoring filter (9) 1
Cancel for rejected article 1
Scoring filter (12) 1
Binary: misplaced par2 1
TOTAL: 21 4782

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com920105105
TOTAL: 19284105105

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 181
TOTAL: 1 181
Huge articles
csiph-out.feeder.erje.net 145
csiph-out.news.weretis.net 99
feeder.eternal-september.org 13
news.swapon.de 6
news-out.mixmin.net 5
news.freedyn.net 4
news.bbs.geek.nz 1
news.fcku.it 1
newsfeeds.xmission.com 1
news.redatomik.org 1
TOTAL: 10 276
Including strange strings
newsfeed.fu-berlin.de 432
csiph-out.feeder.erje.net 27
news.swapon.de 20
news.redatomik.org 17
csiph-out.news.weretis.net 7
newsfeed.neva.ru 5
news-out.aioe.org 3
feeder.eternal-september.org 1
news.fcku.it 1
TOTAL: 9 513
TOTAL: 3 970

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 30061 670 15520 8 0 0 2%23:59:48
2news.freedyn.net 17960 654 15988 4 0 0 3%23:59:55
3xanadu-bbs 18422 536 16146 1 0 0 2%23:59:42
4fu-berlin.de 15500 490 15010 0 0 0 3%23:59:55
5usenet.pasdenom.info 17946 169 15323 1164 0 5 0%23:59:55
6aioe 14163 69 13308 0 0 0 0%23:59:50
7weretis.net 13200 42 11909 16 0 0 0%23:59:36
8news.redatomik.org 15966 21 15048 17 0 0 0%23:59:55
9xmission 17027 19 15583 0 0 0 0%23:59:49
10erje 12238 18 11916 1 0 0 0%23:59:45
11neva.ru 15892 16 15283 134 0 0 0%23:59:55
12news.swapon.de 1859 16 1795 0 0 0 0%23:49:50
13eternal-september 13763 16 13209 0 0 0 0%23:59:29
14news.mixmin.net 15644 15 15148 1 0 0 0%23:59:44
15news.fcku.it 1304 0 1275 0 0 0 0%21:10:21
TOTAL: 15 220945 2751 192461 1346 0 5 1%356:57:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net5.3 MB26.4 KB5.3 MB0.1 KB/s8.3 KB23:59:55
2xanadu-bbs5.0 MB5.7 KB5.0 MB0.1 KB/s9.5 KB23:59:42
3fu-berlin.de4.8 MB0.0 KB4.8 MB0.1 KB/s10.1 KB23:59:55
4news.bbs.geek.nz1.7 MB24.2 KB1.7 MB0.0 KB/s2.6 KB23:59:48
5usenet.pasdenom.info496.9 KB6.0 MB6.5 MB0.1 KB/s5.0 KB23:59:55
6aioe173.4 KB0.0 KB173.4 KB0.0 KB/s2.5 KB23:59:50
7weretis.net103.4 KB55.0 KB158.4 KB0.0 KB/s2.7 KB23:59:36
8news.redatomik.org44.2 KB82.1 KB126.3 KB0.0 KB/s3.3 KB23:59:55
9neva.ru39.9 KB300.9 KB340.8 KB0.0 KB/s2.3 KB23:59:55
10xmission38.7 KB0.0 KB38.7 KB0.0 KB/s2.0 KB23:59:49
11erje37.5 KB11.9 KB49.5 KB0.0 KB/s2.6 KB23:59:45
12news.swapon.de29.9 KB0.0 KB29.9 KB0.0 KB/s1.9 KB23:49:50
13eternal-september29.9 KB0.0 KB29.9 KB0.0 KB/s1.9 KB23:59:29
14news.mixmin.net29.3 KB1.1 KB30.4 KB0.0 KB/s1.9 KB23:59:44
15news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:10:21
TOTAL: 1517.8 MB6.5 MB24.3 MB0.0 KB/s6.1 KB356:57:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp130-06-70-55-78-197.dsl.bell.ca 50 313854.5 KB 41 0 000:22:45
2141.168.117.108 46 112318.5 KB 71 0 000:37:58
3a131033.upc-a.chello.nl 82 3054.9 KB 12 0 022:10:28
496-42-18-226.dhcp.mdsn.wi.charter.com 44 2240.7 KB 19 16 1509:25:15
TOTAL: 4 222 4771.2 MB 143 16 1533:53:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 50 313854.5 KB 41 0 000:22:45
2unresolved 47 112318.5 KB 71 0 000:38:00
3*.upc-a.chello.nl 82 3054.9 KB 12 0 022:10:28
4*.dhcp.mdsn.wi.charter.com 44 2240.7 KB 19 16 1509:25:15
5*.dip0.t-ipconnect.de 1 00.0 KB 0 0 000:00:06
6*.ph.ph.cox.net 4 00.0 KB 0 0 001:00:06
7*.cust.centrio.cz 4 00.0 KB 0 0 000:16:20
TOTAL: 7 232 4771.2 MB 143 16 1533:53:03

NNRP auth users [Top 20]:

UserConn
moussa 46
ohlandl 15
ctomczyk 4
TOTAL: 3 65

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
a131033.upc-a.chello.nl 6.886 1.319 0.00022:10:28
96-42-18-226.dhcp.mdsn.wi.charter.com 4.193 0.805 0.08309:25:15
ip72-222-200-59.ph.ph.cox.net 0.230 0.054 0.00001:00:06
141.168.117.108 5.055 1.072 0.87000:37:58
mtrlpq2314w-lp130-06-70-55-78-197.dsl.bell.ca 5.713 2.388 0.00000:22:45
194-73-239-109.cust.centrio.cz 0.243 0.056 0.01200:16:20
p4fc9768d.dip0.t-ipconnect.de 0.107 0.054 0.00000:00:06
94.167.253.236 0.080 0.016 0.00000:00:02
TOTAL: 8 22.507 5.764 0.96533:53:03

Curious NNRP server explorers [Top 20]:

SystemConn
ip72-222-200-59.ph.ph.cox.net 4
194-73-239-109.cust.centrio.cz 4
94.167.253.236 1
p4fc9768d.dip0.t-ipconnect.de 1
TOTAL: 4 10

NNRP client timeouts [Top 20]:

SystemConnPeer
mtrlpq2314w-lp130-06-70-55-78-197.dsl.bell.ca 6 6
96-42-18-226.dhcp.mdsn.wi.charter.com 5 0
ip72-222-200-59.ph.ph.cox.net 2 0
TOTAL: 3 13 6

Newsgroup request counts (by category):

CategoryCountPct
1alt 303 63.5%
2comp 138 28.9%
3uk 20 4.2%
4aus 7 1.5%
5rec 4 0.8%
6talk 2 0.4%
7soc 2 0.4%
8sci 1 0.2%
TOTAL: 8 477100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 74
2alt.atheism 48
3alt.comp.freeware 31
4comp.os.vms 30
5alt.humor.puns 23
6alt.philosophy.taoism 22
7alt.messianic 22
8alt.home.repair 21
9alt.life.sucks 20
10comp.arch 19
11alt.global-warming 18
12alt.os.linux.slackware 15
13alt.happy.valley 13
14alt.os.linux.ubuntu 12
15alt.gossip.celebrities 12
16alt.obituaries 10
17alt.os.development 7
18alt.os.linux 7
19aus.cars 7
20uk.media.radio.archers 7
21alt.os.linux.mageia 6
22alt.music.michael-jackson 6
23alt.society.liberalism 5
24uk.legal 5
25uk.d-i-y 4
26comp.sys.ibm.pc.hardware.chips 3
27comp.ai.philosophy 3
28talk.politics.guns 2
29alt.folklore.computers 2
30comp.os.os2.advocacy 2
31rec.arts.tv 2
32uk.comp.sys.mac 1
33comp.unix.aix 1
34sci.engr.joining.welding 1
35uk.tech.digital-tv 1
36comp.mobile.ipad 1
37soc.culture.china 1
38comp.os.cpm 1
39comp.misc 1
40rec.boats 1
41comp.lang.python 1
42comp.sys.mac.system 1
43comp.sys.ibm.pc.games.action 1
44alt.support.depression 1
45rec.food.cooking 1
46alt.guitar 1
47uk.rec.gardening 1
48soc.culture.lebanon 1
49uk.rec.sheds 1
50alt.autos.hyundai 1
TOTAL: 50 477