Daily Usenet report for csiph.com

Mar 3 04:15:00 -- Mar 4 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Mar 3 15:30:03 csiph pgpverify[12911]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 26446 54.1%5.5 MB 67.8%
innd 12318 25.2%1.5 MB 18.5%
nnrpd 7125 14.6%639.3 KB 7.6%
innfeed 2891 5.9%489.5 KB 5.8%
nocem 134 0.3%15.9 KB 0.2%
controlchan 12 0.0%2.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 48927 100.0%8.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 292738 57.2%
Negative hits 193081 37.7%
Do not exist 25519 5.0%
Cache misses 284 0.1%
TOTAL: 4 511622 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.543 0.0%269 0.000 2.019 32.000
article cleanup00:00:00.146 0.0%25234 0.000 0.006 0.033
article logging00:00:00.445 0.0%25815 0.000 0.017 0.231
article parse00:00:01.500 0.0%72184 0.000 0.021 0.181
article write00:00:08.502 0.0%18677 0.213 0.455 6.338
artlog/artcncl00:00:00.008 0.0%206 0.000 0.039 0.857
artlog/artparse00:00:00.012 0.0%366 0.000 0.033 1.000
data move00:00:00.183 0.0%500718 0.000 0.000 0.002
hisgrep/artcncl00:00:00.247 0.0%267 0.000 0.925 32.000
hishave/artcncl00:00:00.062 0.0%269 0.000 0.230 3.929
hishave/artparse00:00:00.005 0.0%363 0.000 0.014 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:28.081 0.0%512330 0.002 0.055 0.453
history sync00:00:01.488 0.0%364 0.000 4.088 55.333
history write00:00:40.633 0.0%25211 0.276 1.612 11.127
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
hiswrite/artparse00:00:00.568 0.0%362 0.000 1.569 10.000
idle23:39:40.068 99.2%505321 100.147 168.566 561.596
nntp read00:00:02.470 0.0%507987 0.002 0.005 0.011
overview write00:08:26.188 0.6%18677 0.341 27.102 4105.424
perl filter00:00:45.254 0.1%24911 1.239 1.817 2.725
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.334 0.0%37484 0.000 0.009 0.038
TOTAL: 23:50:59.73923:50:16.737 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.049 0.0%18733 0.000 0.003 0.026
article prepare00:00:00.001 0.0%22416 0.000 0.000 0.003
article read00:00:00.442 0.0%2617 0.000 0.169 12.333
backlog stats00:00:00.198 0.0%359214 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.762 0.0%269201 0.001 0.007 0.012
data write00:00:01.518 0.0%255053 0.001 0.006 0.015
idle23:54:12.289100.0%359214 149.206 239.557 718.216
status file00:00:00.225 0.0%264 0.000 0.852 16.000
TOTAL: 23:54:26.35123:54:16.484100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle27:04:23.882100.0%8145 86.889 11966.100600198.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.112 0.0%16711 0.000 0.007 0.167
readart00:00:01.806 0.0%236 0.000 7.653 60.000
TOTAL: 27:05:03.17827:04:25.800100.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 5 36600 6203 30017 380 16%46:34:09
2csiph-out.feeder.erje.net 1152 80730 2960 74624 3146 3%94:56:47
3newsfeeds.xmission.com 3 18111 2242 15865 4 12%25:29:24
4feeder.eternal-september.org 2 21122 2211 18809 102 10%23:59:44
5news-out.aioe.org 4 18165 1420 16708 37 7%24:09:35
6newsfeed.fu-berlin.de 16 17443 1079 16231 133 6%26:23:53
7newsfeed.neva.ru 141 24664 1027 21317 2320 4%71:47:40
8news.fcku.it 2 8076 647 7211 218 8%23:59:41
9news.redatomik.org 2 17817 428 17350 39 2%24:07:26
10news-out.mixmin.net 1 19682 351 18896 435 1%23:59:49
11news.swapon.de 7 1595 52 1543 0 3%24:37:52
12nntp.pasdenom.info 3 16725 24 16696 5 0%23:58:46
13news.freedyn.net 2 20821 23 20730 68 0%25:36:39
14localhost 48 16 16 0 0 100%00:00:05
15news.bbs.geek.nz 2 19483 1 19482 0 0%23:59:43
16xanadu-bbs.net 22 507 1 504 2 0%21:55:42
TOTAL: 16 1412 321557 18685 295983 6889 5%505:36:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.weretis.net18.5 MB5.3 KB8.0 MB26.6 MB 69%4.1 KB
2csiph-out.feeder.erje.net14.5 MB22.7 KB14.2 MB28.7 MB 50%4.8 KB
3newsfeeds.xmission.com6.2 MB0.0 KB182.3 KB6.4 MB 97%2.9 KB
4feeder.eternal-september.org5.6 MB0.0 KB3.0 MB8.6 MB 64%3.8 KB
5news-out.aioe.org3.4 MB0.0 KB54.2 KB3.4 MB 98%2.4 KB
6newsfeed.neva.ru3.0 MB46.0 KB25.2 MB28.3 MB 10%8.7 KB
7newsfeed.fu-berlin.de2.6 MB0.0 KB311.2 KB2.9 MB 89%2.4 KB
8news.fcku.it1.6 MB0.0 KB6.2 MB7.9 MB 20%9.3 KB
9news-out.mixmin.net1.3 MB2.2 KB1.2 MB2.5 MB 50%3.2 KB
10news.redatomik.org976.4 KB0.0 KB1.5 MB2.4 MB 39%5.3 KB
11news.swapon.de128.4 KB0.0 KB0.0 KB128.4 KB100%2.5 KB
12news.freedyn.net101.4 KB0.0 KB208.7 KB310.1 KB 32%3.4 KB
13nntp.pasdenom.info64.7 KB0.0 KB9.4 KB74.1 KB 87%2.6 KB
14localhost47.0 KB0.0 KB0.0 KB47.0 KB100%2.9 KB
15xanadu-bbs.net2.1 KB0.0 KB4.1 KB6.2 KB 33%2.1 KB
16news.bbs.geek.nz0.5 KB0.0 KB0.0 KB0.5 KB100%0.5 KB
TOTAL: 1658.0 MB76.2 KB60.1 MB118.1 MB 49%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 3 04:15:00 - 04:59:59 253 1.4% 0.09708.9 KB 1.2% 0.26
Mar 3 05:00:00 - 05:59:59 381 2.0% 0.111.1 MB 1.9% 0.31
Mar 3 06:00:00 - 06:59:59 500 2.7% 0.141.5 MB 2.6% 0.44
Mar 3 07:00:00 - 07:59:59 490 2.6% 0.141.7 MB 2.9% 0.48
Mar 3 08:00:00 - 08:59:59 778 4.2% 0.222.2 MB 3.7% 0.61
Mar 3 09:00:00 - 09:59:59 907 4.8% 0.253.0 MB 5.1% 0.85
Mar 3 10:00:00 - 10:59:59 1094 5.8% 0.304.7 MB 8.0% 1.32
Mar 3 11:00:00 - 11:59:59 1031 5.5% 0.293.3 MB 5.7% 0.95
Mar 3 12:00:00 - 12:59:59 849 4.5% 0.242.5 MB 4.2% 0.71
Mar 3 13:00:00 - 13:59:59 939 5.0% 0.262.9 MB 4.9% 0.82
Mar 3 14:00:00 - 14:59:59 1050 5.6% 0.293.5 MB 5.9% 0.98
Mar 3 15:00:00 - 15:59:59 1072 5.7% 0.303.7 MB 6.3% 1.05
Mar 3 16:00:00 - 16:59:59 978 5.2% 0.272.6 MB 4.4% 0.73
Mar 3 17:00:00 - 17:59:59 968 5.2% 0.272.6 MB 4.4% 0.73
Mar 3 18:00:00 - 18:59:59 1005 5.4% 0.282.7 MB 4.6% 0.76
Mar 3 19:00:00 - 19:59:59 894 4.8% 0.252.7 MB 4.6% 0.76
Mar 3 20:00:00 - 20:59:59 939 5.0% 0.262.7 MB 4.6% 0.77
Mar 3 21:00:00 - 21:59:59 993 5.3% 0.282.9 MB 4.9% 0.82
Mar 3 22:00:00 - 22:59:59 853 4.6% 0.242.8 MB 4.9% 0.81
Mar 3 23:00:00 - 23:59:59 644 3.4% 0.182.1 MB 3.5% 0.59
Mar 4 00:00:00 - 00:59:59 610 3.3% 0.171.9 MB 3.2% 0.53
Mar 4 01:00:00 - 01:59:59 459 2.5% 0.131.4 MB 2.5% 0.41
Mar 4 02:00:00 - 02:59:59 593 3.2% 0.162.0 MB 3.4% 0.56
Mar 4 03:00:00 - 03:59:59 373 2.0% 0.101.4 MB 2.4% 0.39
Mar 4 04:00:00 - 04:15:00 76 0.4% 0.08235.6 KB 0.4% 0.26
TOTAL: 24:00:00 18729 100.0% 0.2258.4 MB 100.0% 0.69
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 3176 107 0 10 0 0 0 0 3059
2newsfeed.neva.ru 2324 174 0 13 0 0 0 0 2137
3newsfeed.fu-berlin.de 619 18 0 0 0 0 0 0 601
4news-out.mixmin.net 444 0 0 2 0 0 0 0 442
5csiph-out.news.weretis.net 442 94 0 1 0 0 0 0 347
6news.fcku.it 222 2 0 0 0 0 0 0 220
7feeder.eternal-september.org 102 49 0 0 0 0 0 0 53
8news.freedyn.net 64 0 0 0 0 0 0 0 64
9news.redatomik.org 46 0 0 0 0 0 0 0 46
10news-out.aioe.org 40 21 0 0 0 0 0 0 19
11news.swapon.de 17 0 0 0 0 0 0 0 17
12nntp.pasdenom.info 5 3 0 0 0 0 0 0 2
13news.bbs.geek.nz 4 4 0 0 0 0 0 0 0
14newsfeeds.xmission.com 4 1 0 0 0 0 0 0 3
15xanadu-bbs.net 2 0 0 0 0 0 0 0 2
TOTAL: 15 7511 473 0 26 0 0 0 0 7012

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 147
alt.windows7.general 42
it-alt.sport.calcio.juventus 35
alt.binaries.erotica-underground 20
alt.survival 14
alt.bbs.synchronet 13
mpc.lists.freebsd.gnome 13
lada.commerce 12
mpc.lists.freebsd.office 10
mozilla.support.bugzilla 10
mpc.lists.nanog 8
lada.auto 8
cakewalk.audio 8
oesterreich.tratsch 6
biz.mlm 6
lada.soft 4
mozilla.support.thunderbird 4
alt.politics.usa 4
spline.eisfair 4
gmane.comp.gis.openstreetmap.imports 4
TOTAL: 91 473

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4039
Binary: misplaced rar 648
EMP (fsl) 412
EMP (phn path) 318
EMP (phl) 105
EMP (phn nph) 70
Scoring filter (9) 35
Too many newsgroups 27
Binary Payload 24
Binary: misplaced par2 19
HTML Multipart 18
User-issued cancel 18
Binary: misplaced txt 12
Scoring filter (10) 6
Scoring filter (14) 6
Too many newsgroups (meow) 2
Scoring filter (11) 2
Binary Image: misplaced jpg 1
HTML Image Tags 1
User-issued spam cancel 1
TOTAL: 20 5764

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com5806666
TOTAL: 158716666

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 297
TOTAL: 1 297
Bad Message-ID's offered
csiph-out.feeder.erje.net 8
TOTAL: 1 8
Huge articles
csiph-out.feeder.erje.net 180
csiph-out.news.weretis.net 96
news.fcku.it 62
news-out.mixmin.net 10
feeder.eternal-september.org 7
news.redatomik.org 6
newsfeeds.xmission.com 2
TOTAL: 7 363
Including strange strings
newsfeed.fu-berlin.de 466
csiph-out.news.weretis.net 50
csiph-out.feeder.erje.net 29
news.swapon.de 17
news.redatomik.org 7
feeder.eternal-september.org 4
newsfeed.neva.ru 4
news-out.aioe.org 3
news-out.mixmin.net 2
news.fcku.it 2
TOTAL: 10 584
No colon-space in header
csiph-out.feeder.erje.net 3
TOTAL: 1 3
TOTAL: 5 1255

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 20831 1065 17663 0 0 0 5%23:59:50
2news.freedyn.net 19865 914 17776 20 0 1 4%23:59:25
3news.bbs.geek.nz 33933 900 17103 6 0 2 2%23:59:49
4fu-berlin.de 17524 684 16838 0 0 0 3%23:59:53
5usenet.pasdenom.info 20440 154 17282 1268 0 11 0%23:59:53
6aioe 16212 97 15382 0 0 0 0%23:59:44
7eternal-september 19294 57 15568 57 0 0 0%23:59:53
8erje 16433 38 15611 35 0 10 0%23:59:40
9news.redatomik.org 18663 29 17572 0 0 17 0%23:59:53
10neva.ru 17180 23 16626 190 0 0 0%23:59:53
11weretis.net 12906 23 11078 6 0 0 0%23:59:34
12xmission 17800 20 15772 3 0 0 0%23:59:11
13news.swapon.de 1619 11 1590 0 0 0 0%23:41:54
14news.mixmin.net 17192 11 16771 5 0 0 0%23:59:39
15news.fcku.it 1319 0 1315 0 0 0 0%22:01:51
TOTAL: 15 251211 4026 213947 1590 0 41 1%357:40:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs9.4 MB0.0 KB9.4 MB0.1 KB/s9.0 KB23:59:50
2news.freedyn.net8.9 MB99.6 KB9.0 MB0.1 KB/s9.9 KB23:59:25
3fu-berlin.de8.3 MB0.0 KB8.3 MB0.1 KB/s12.5 KB23:59:53
4news.bbs.geek.nz3.1 MB18.3 KB3.1 MB0.0 KB/s3.5 KB23:59:49
5usenet.pasdenom.info468.9 KB9.2 MB9.7 MB0.1 KB/s7.0 KB23:59:53
6aioe215.1 KB0.0 KB215.1 KB0.0 KB/s2.2 KB23:59:44
7eternal-september200.4 KB187.6 KB388.1 KB0.0 KB/s3.4 KB23:59:53
8erje139.0 KB54.9 KB193.9 KB0.0 KB/s2.7 KB23:59:40
9weretis.net91.6 KB22.3 KB113.9 KB0.0 KB/s3.9 KB23:59:34
10news.redatomik.org76.6 KB0.0 KB76.6 KB0.0 KB/s2.6 KB23:59:53
11xmission56.8 KB40.4 KB97.2 KB0.0 KB/s4.2 KB23:59:11
12neva.ru47.3 KB408.8 KB456.1 KB0.0 KB/s2.1 KB23:59:53
13news.mixmin.net41.9 KB5.1 KB47.1 KB0.0 KB/s2.9 KB23:59:39
14news.swapon.de27.8 KB0.0 KB27.8 KB0.0 KB/s2.5 KB23:41:54
15news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:01:51
TOTAL: 1531.0 MB10.0 MB41.0 MB0.0 KB/s7.5 KB357:40:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1141.168.117.108 47 78266.7 KB 55 0 000:40:35
2194-73-239-109.cust.centrio.cz 22 35121.4 KB 16 6 003:04:23
396-42-18-226.dhcp.mdsn.wi.charter.com 24 1023.0 KB 10 10 1006:58:54
4a131033.upc-a.chello.nl 37 68.3 KB 2 0 011:30:51
5cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 4 35.3 KB 2 0 001:08:11
6tempe0.bbox.io 10 211.5 KB 2 0 003:37:59
7mtrlpq2314w-lp130-05-70-55-71-209.dsl.bell.ca 50 211.6 KB 2 0 000:04:05
TOTAL: 7 194 136447.9 KB 89 16 1027:05:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 47 78266.7 KB 55 0 000:40:35
2*.cust.centrio.cz 22 35121.4 KB 16 6 003:04:23
3*.dhcp.mdsn.wi.charter.com 24 1023.0 KB 10 10 1006:58:54
4*.upc-a.chello.nl 37 68.3 KB 2 0 011:30:51
5*.19-1.cable.virginm.net 4 35.3 KB 2 0 001:08:11
6*.bbox.io 10 211.5 KB 2 0 003:37:59
7*.dsl.bell.ca 50 211.6 KB 2 0 000:04:05
TOTAL: 7 194 136447.9 KB 89 16 1027:05:01

NNRP auth users [Top 20]:

UserConn
moussa 47
ctomczyk 20
ohlandl 10
TOTAL: 3 77

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
a131033.upc-a.chello.nl 2.862 0.500 0.00011:30:51
96-42-18-226.dhcp.mdsn.wi.charter.com 2.468 0.488 0.03706:58:54
tempe0.bbox.io 1.012 0.226 0.00003:37:59
194-73-239-109.cust.centrio.cz 2.535 0.435 0.07103:04:23
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 0.468 0.062 0.00001:08:11
141.168.117.108 5.025 1.086 0.15800:40:35
mtrlpq2314w-lp130-05-70-55-71-209.dsl.bell.ca 5.036 0.811 0.00000:04:05
TOTAL: 7 19.406 3.608 0.26627:05:01

NNRP client timeouts [Top 20]:

SystemConnPeer
96-42-18-226.dhcp.mdsn.wi.charter.com 9 0
tempe0.bbox.io 5 0
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 2 0
194-73-239-109.cust.centrio.cz 2 0
TOTAL: 4 18 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 83 61.0%
2pl 34 25.0%
3alt 16 11.8%
4muc 2 1.5%
5sci 1 0.7%
TOTAL: 5 136100.0%

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

NewsgroupCount
1pl.comp.lang.javascript 33
2comp.sys.ibm.ps2.hardware 27
3alt.comp.freeware 16
4comp.os.vms 14
5comp.ai.philosophy 13
6comp.arch 8
7comp.os.msdos.programmer 5
8comp.sys.ibm.pc.games.action 3
9comp.os.os2.misc 3
10comp.lang.pl1 3
11comp.arch.fpga 2
12comp.bbs.misc 2
13muc.lists.freebsd.current 2
14comp.ai.nat-lang 1
15sci.logic 1
16comp.lang.javascript 1
17comp.arch.embedded 1
18pl.comp.www 1
TOTAL: 18 136