Daily Usenet report for csiph.com

Jan 17 04:15:00 -- Jan 18 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 17 12:10:02 csiph pgpverify[71949]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 37181 63.4%7.7 MB 74.9%
innd 16894 28.8%1.9 MB 18.5%
innfeed 3209 5.5%545.8 KB 5.2%
nnrpd 1257 2.1%136.8 KB 1.3%
nocem 74 0.1%7.6 KB 0.1%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 58620 100.0%10.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 412534 56.5%
Negative hits 281301 38.5%
Do not exist 36145 4.9%
Cache misses 590 0.1%
TOTAL: 4 730570 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.598 0.0%237 0.000 2.523 38.000
article cleanup00:00:00.215 0.0%36122 0.000 0.006 0.023
article logging00:00:04.189 0.0%36838 0.000 0.114 0.764
article parse00:00:02.843 0.0%100649 0.003 0.028 0.292
article write00:03:19.441 0.2%24238 0.225 8.228 34.273
artlog/artcncl00:00:00.005 0.0%200 0.000 0.025 0.250
artlog/artparse00:00:00.224 0.0%201 0.000 1.114 51.000
data move00:00:00.330 0.0%669849 0.000 0.000 0.058
hisgrep/artcncl00:00:00.081 0.0%237 0.000 0.342 22.000
hishave/artcncl00:00:00.001 0.0%237 0.000 0.004 1.000
hishave/artparse00:00:00.000 0.0%197 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:19.201 0.2%732696 0.003 0.190 0.841
history sync00:00:04.695 0.0%326 0.000 14.402 73.333
history write00:03:28.097 0.2%36094 0.374 5.765 41.612
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:01.395 0.0%197 0.000 7.081 50.500
idle23:44:17.670 98.9%653824 75.042 130.704 346.922
nntp read00:00:02.931 0.0%684493 0.002 0.004 0.018
overview write00:04:19.758 0.3%24238 1.087 10.717 101.015
perl filter00:01:16.073 0.1%35909 1.442 2.118 3.421
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.425 0.0%48544 0.000 0.009 0.022
TOTAL: 24:00:34.95823:59:18.172 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.055 0.0%24202 0.000 0.002 0.017
article prepare00:00:00.003 0.0%32332 0.000 0.000 0.006
article read00:00:01.168 0.0%5913 0.000 0.198 4.030
backlog stats00:00:00.270 0.0%440356 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.266 0.0%341605 0.002 0.007 0.012
data write00:00:01.983 0.0%324855 0.001 0.006 0.013
idle23:53:50.760100.0%440356 113.696 195.366 511.913
status file00:00:00.294 0.0%295 0.000 0.997 13.000
TOTAL: 23:54:04.96923:53:56.799100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:02.708 0.0%12593 0.000 0.215 75.000
idle71:46:37.274 99.7%23623 0.000 10938.377900257.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.080 0.0%159482 0.000 0.044 0.250
readart00:01:44.799 0.0%19191 0.000 5.461 39.000
TOTAL: 71:58:15.23771:48:31.861 99.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 118803 8951 101890 7962 7%94:57:50
2csiph-out.news.weretis.net 3 50706 4413 45746 547 8%49:18:42
3feeder.eternal-september.org 4 31878 3407 27210 1261 10%24:54:50
4news.redatomik.org 1 26365 2077 24270 18 7%28:50:36
5newsfeed.fu-berlin.de 61 24459 1284 22913 262 5%33:48:14
6newsfeed.neva.ru 140 45844 1226 42949 1669 2%71:15:20
7news-out.mixmin.net 2 26034 1162 24670 202 4%23:59:34
8news-out.aioe.org 3 23657 766 22863 28 3%24:09:59
9newsfeeds.xmission.com 2 26402 588 25810 4 2%27:28:01
10news.freedyn.net 3 26655 272 26257 126 1%24:09:51
11news.swapon.de 2 2440 83 2357 0 3%25:33:50
12xanadu-bbs.net 9 893 67 825 1 7%25:14:29
13news.fcku.it 1 10806 65 10688 53 0%23:59:58
14nntp.pasdenom.info 3 23797 47 23750 0 0%24:08:25
15localhost 38 4 4 0 0 100%00:00:00
16news.bbs.geek.nz 1 19564 3 19561 0 0%23:59:31
TOTAL: 16 1425 458307 24415 421759 12133 5%525:49:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net27.2 MB40.0 KB39.5 MB66.8 MB 40%4.0 KB
2csiph-out.news.weretis.net13.1 MB0.0 KB8.6 MB21.6 MB 60%4.5 KB
3feeder.eternal-september.org9.1 MB7.4 KB19.3 MB28.4 MB 32%6.2 KB
4news-out.mixmin.net5.5 MB14.3 KB894.1 KB6.4 MB 86%4.8 KB
5news.redatomik.org5.0 MB4.9 KB241.8 KB5.2 MB 95%2.6 KB
6newsfeed.neva.ru2.9 MB2.6 KB8.1 MB11.1 MB 26%3.9 KB
7newsfeed.fu-berlin.de2.8 MB0.0 KB780.1 KB3.5 MB 78%2.3 KB
8news-out.aioe.org2.6 MB26.8 KB74.7 KB2.7 MB 96%3.5 KB
9newsfeeds.xmission.com1.6 MB0.0 KB234.7 KB1.8 MB 87%3.2 KB
10news.freedyn.net973.6 KB0.0 KB1.4 MB2.4 MB 40%6.1 KB
11news.swapon.de223.8 KB0.0 KB0.0 KB223.8 KB100%2.7 KB
12xanadu-bbs.net201.8 KB0.0 KB1.9 KB203.8 KB 99%3.0 KB
13news.fcku.it125.0 KB0.0 KB168.2 KB293.2 KB 42%2.5 KB
14nntp.pasdenom.info85.8 KB0.0 KB0.0 KB85.8 KB100%1.8 KB
15news.bbs.geek.nz9.8 KB0.0 KB0.0 KB9.8 KB100%3.3 KB
16localhost4.8 KB0.0 KB0.0 KB4.8 KB100%1.2 KB
TOTAL: 1671.4 MB96.0 KB79.3 MB150.8 MB 47%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 17 04:15:00 - 04:59:59 400 1.6% 0.151.2 MB 1.7% 0.47
Jan 17 05:00:00 - 05:59:59 580 2.4% 0.161.9 MB 2.8% 0.55
Jan 17 06:00:00 - 06:59:59 592 2.4% 0.162.4 MB 3.4% 0.68
Jan 17 07:00:00 - 07:59:59 675 2.8% 0.192.1 MB 2.9% 0.59
Jan 17 08:00:00 - 08:59:59 1022 4.2% 0.282.8 MB 4.0% 0.81
Jan 17 09:00:00 - 09:59:59 1112 4.6% 0.313.0 MB 4.3% 0.87
Jan 17 10:00:00 - 10:59:59 1128 4.7% 0.313.0 MB 4.3% 0.86
Jan 17 11:00:00 - 11:59:59 906 3.7% 0.252.3 MB 3.2% 0.64
Jan 17 12:00:00 - 12:59:59 919 3.8% 0.262.5 MB 3.5% 0.70
Jan 17 13:00:00 - 13:59:59 1167 4.8% 0.323.1 MB 4.3% 0.88
Jan 17 14:00:00 - 14:59:59 1309 5.4% 0.363.9 MB 5.5% 1.12
Jan 17 15:00:00 - 15:59:59 1580 6.5% 0.444.6 MB 6.5% 1.32
Jan 17 16:00:00 - 16:59:59 1435 5.9% 0.404.2 MB 5.9% 1.18
Jan 17 17:00:00 - 17:59:59 1434 5.9% 0.403.8 MB 5.4% 1.09
Jan 17 18:00:00 - 18:59:59 1510 6.2% 0.424.8 MB 6.7% 1.36
Jan 17 19:00:00 - 19:59:59 1348 5.6% 0.373.9 MB 5.6% 1.12
Jan 17 20:00:00 - 20:59:59 1402 5.8% 0.394.2 MB 5.9% 1.19
Jan 17 21:00:00 - 21:59:59 1167 4.8% 0.323.1 MB 4.5% 0.90
Jan 17 22:00:00 - 22:59:59 1150 4.7% 0.323.3 MB 4.7% 0.94
Jan 17 23:00:00 - 23:59:59 930 3.8% 0.262.9 MB 4.1% 0.82
Jan 18 00:00:00 - 00:59:59 751 3.1% 0.212.5 MB 3.5% 0.71
Jan 18 01:00:00 - 01:59:59 599 2.5% 0.171.7 MB 2.4% 0.49
Jan 18 02:00:00 - 02:59:59 538 2.2% 0.151.7 MB 2.3% 0.47
Jan 18 03:00:00 - 03:59:59 467 1.9% 0.131.4 MB 2.0% 0.39
Jan 18 04:00:00 - 04:15:00 123 0.5% 0.14371.7 KB 0.5% 0.41
TOTAL: 24:00:00 24244 100.0% 0.2870.8 MB 100.0% 0.84
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 7985 483 0 18 1 0 0 0 7483
2newsfeed.neva.ru 1681 420 0 1 0 0 0 0 1260
3feeder.eternal-september.org 1250 53 0 2 0 0 0 0 1195
4newsfeed.fu-berlin.de 766 48 0 0 0 0 0 0 718
5csiph-out.news.weretis.net 551 137 0 0 0 0 0 0 414
6news-out.mixmin.net 217 0 0 3 0 0 0 0 214
7news.freedyn.net 126 25 0 0 0 0 0 0 101
8news.fcku.it 53 0 0 0 0 0 0 0 53
9news.redatomik.org 34 0 0 2 0 0 0 0 32
10newsfeeds.xmission.com 32 0 0 0 0 0 0 0 32
11news-out.aioe.org 30 21 0 6 0 0 0 0 3
12news.swapon.de 11 0 0 0 0 0 0 0 11
13xanadu-bbs.net 1 0 0 0 0 0 0 0 1
TOTAL: 13 12737 1187 0 32 1 0 0 011517

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.auto 218
lada.talk 139
ut.test 103
it.annunci.varie 66
it.annunci.immobiliari 63
it.annunci.commerciali 63
it-alt.sport.calcio.juventus 47
alt.windows7.general 41
gmane.linux.alsa.devel 31
mpc.lists.nanog 26
gmane.comp.gis.openstreetmap.tagging 23
mozilla.dev.platform 15
alt.survival 14
gmane.linux.kernel 13
cakewalk.audio 13
spline.eisfair 12
mozilla.support.thunderbird 12
abg.test 11
gmane.linux.drivers.platform.x86.devel 10
mtl.forsale-vendre 10
TOTAL: 117 1187

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

GroupsCount
muc.lists.freebsd.questions 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 8505
EMP (phn path) 896
EMP (phl) 654
EMP (phn nph) 154
Too many newsgroups 103
Scoring filter (8) 15
User-issued cancel 13
Binary Payload 12
HTML post 11
Scoring filter (10) 10
Scoring filter (9) 10
HTML Multipart 10
Scoring filter (13) 6
Scoring filter (18) 5
HTML Image Tags 5
Scoring filter (12) 4
Binary Image: misplaced jpg 3
Too many newsgroups (low_xpost) 1
Scoring filter (17) 1
Scoring filter (11) 1
TOTAL: 20 10419

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com6606969
TOTAL: 16616969

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 181
TOTAL: 1 181
Huge articles
feeder.eternal-september.org 82
csiph-out.news.weretis.net 79
news.freedyn.net 15
news-out.mixmin.net 9
newsfeeds.xmission.com 5
news.redatomik.org 4
newsfeed.fu-berlin.de 2
news.fcku.it 1
TOTAL: 8 197
Including strange strings
newsfeed.fu-berlin.de 513
csiph-out.feeder.erje.net 56
feeder.eternal-september.org 44
newsfeeds.xmission.com 27
csiph-out.news.weretis.net 23
news.redatomik.org 16
news-out.mixmin.net 15
news.swapon.de 11
newsfeed.neva.ru 7
news-out.aioe.org 2
TOTAL: 12 716
No colon-space in header
csiph-out.feeder.erje.net 1
TOTAL: 1 1
TOTAL: 4 1095

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 41589 4948 18639 66 0 0 11%23:59:54
2news.freedyn.net 24822 730 23238 4 0 0 2%23:59:56
3xanadu-bbs 27370 641 23529 1 0 0 2%23:59:56
4fu-berlin.de 22668 548 22120 0 0 0 2%23:59:45
5erje 16023 57 15136 11 0 0 0%23:59:55
6xmission 26694 48 22932 8 0 0 0%23:59:56
7usenet.pasdenom.info 26370 45 23290 857 0 6 0%23:59:56
8aioe 21460 33 20430 3 0 0 0%23:59:56
9news.redatomik.org 22148 23 21572 4 0 0 0%23:59:56
10weretis.net 18362 19 18020 1 0 0 0%23:58:11
11news.mixmin.net 22494 10 21836 0 0 0 0%23:59:55
12eternal-september 21351 10 19983 1 0 0 0%23:59:56
13news.swapon.de 2414 6 2381 0 0 0 0%23:47:09
14neva.ru 23112 3 22002 20 0 0 0%23:59:53
15news.fcku.it 3486 1 3402 0 0 0 0%22:46:37
16au2pb 0 0 0 0 0 23657 0%23:58:43
17bwh 0 0 0 0 0 23643 0%23:58:43
TOTAL: 17 320363 7122 278510 976 0 47306 2%406:28:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.bbs.geek.nz12.8 MB282.7 KB13.0 MB0.2 KB/s2.7 KB23:59:54
2news.freedyn.net5.2 MB17.7 KB5.2 MB0.1 KB/s7.3 KB23:59:56
3xanadu-bbs5.0 MB3.8 KB5.0 MB0.1 KB/s7.9 KB23:59:56
4fu-berlin.de4.8 MB0.0 KB4.8 MB0.1 KB/s8.9 KB23:59:45
5erje238.2 KB33.4 KB271.6 KB0.0 KB/s4.0 KB23:59:55
6xmission133.7 KB16.0 KB149.7 KB0.0 KB/s2.7 KB23:59:56
7usenet.pasdenom.info110.5 KB5.3 MB5.4 MB0.1 KB/s6.1 KB23:59:56
8aioe76.3 KB12.8 KB89.2 KB0.0 KB/s2.5 KB23:59:56
9news.redatomik.org49.2 KB16.8 KB65.9 KB0.0 KB/s2.4 KB23:59:56
10weretis.net43.7 KB1.5 KB45.3 KB0.0 KB/s2.3 KB23:58:11
11eternal-september23.1 KB1.9 KB25.0 KB0.0 KB/s2.3 KB23:59:56
12news.mixmin.net19.0 KB0.0 KB19.0 KB0.0 KB/s1.9 KB23:59:55
13news.swapon.de9.5 KB0.0 KB9.5 KB0.0 KB/s1.6 KB23:47:09
14neva.ru3.1 KB53.3 KB56.4 KB0.0 KB/s2.5 KB23:59:53
15news.fcku.it2.1 KB0.0 KB2.1 KB0.0 KB/s2.1 KB22:46:37
16au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:43
17bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:43
TOTAL: 1728.4 MB5.7 MB34.1 MB0.0 KB/s4.3 KB406:28:17
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1240.132.151.153.ap.dti.ne.jp 2 1036512.1 MB 53 0 000:38:31
2tempe0.bbox.io 11 993.5 KB 2 0 004:31:25
3194-73-239-109.cust.centrio.cz 8 615.4 KB 4 0 003:00:22
468-185-181-64.dhcp.mdsn.wi.charter.com 23 32.7 KB 3 4 405:48:52
5dhcp-089-099-203-254.chello.nl 8 11.0 KB 1 0 001:25:12
TOTAL: 5 52 1038412.2 MB 63 4 471:58:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.132.151.153.ap.dti.ne.jp 2 1036512.1 MB 53 0 000:38:31
2*.bbox.io 11 993.5 KB 2 0 004:31:25
3*.cust.centrio.cz 8 615.4 KB 4 0 003:00:22
4*.dhcp.mdsn.wi.charter.com 23 32.7 KB 3 4 405:48:52
5*.chello.nl 8 11.0 KB 1 0 001:25:12
6unresolved 109 00.0 KB 0 0 054:20:21
7*.136.22.98.dynamic.ip.windstream.net 1 00.0 KB 0 0 002:13:27
TOTAL: 7 162 1038412.2 MB 63 4 471:58:13

NNRP auth users [Top 20]:

UserConn
ctomczyk 6
ohlandl 4
TOTAL: 2 10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
216.239.174.218 8.031 1.380 0.00052:51:27
68-185-181-64.dhcp.mdsn.wi.charter.com 1.958 0.367 0.01405:48:52
tempe0.bbox.io 0.944 0.205 0.00004:31:25
194-73-239-109.cust.centrio.cz 0.632 0.107 0.02403:00:22
h60.136.22.98.dynamic.ip.windstream.net 0.107 0.130 0.00002:13:27
5.51.176.30 0.645 0.670 0.00001:28:23
dhcp-089-099-203-254.chello.nl 0.699 0.065 0.00001:25:12
240.132.151.153.ap.dti.ne.jp 1.130 1.885 0.00000:38:31
196.52.16.43 0.386 1.029 0.00000:00:30
TOTAL: 9 14.532 5.838 0.03871:58:13

Curious NNRP server explorers [Top 20]:

SystemConn
216.239.174.218 104
5.51.176.30 4
196.52.16.43 1
h60.136.22.98.dynamic.ip.windstream.net 1
TOTAL: 4 110

NNRP client timeouts [Top 20]:

SystemConnPeer
216.239.174.218 104 0
tempe0.bbox.io 7 0
194-73-239-109.cust.centrio.cz 6 0
68-185-181-64.dhcp.mdsn.wi.charter.com 5 0
h60.136.22.98.dynamic.ip.windstream.net 1 0
TOTAL: 5 123 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 10365 99.8%
2comp 10 0.1%
3muc 9 0.1%
TOTAL: 3 10384100.0%

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

NewsgroupCount
1alt.books.louis-lamour 6508
2alt.books.reviews 1015
3alt.bread.recipes 979
4alt.books.m-lackey 612
5alt.bored 201
6alt.books.tom-holt 178
7alt.books.arthur-clarke 146
8alt.boomerang 145
9alt.books.inklings 105
10alt.books 64
11alt.books.cs-lewis 57
12alt.books.pratchett 50
13alt.books.isaac-asimov 33
14alt.bonehead.klaas.suck.checkmates.dick 31
15alt.books.beatgeneration 26
16alt.books.stephen-king 23
17alt.books.julian-may 19
18alt.bonsai 18
19alt.boston.unmoderated 14
20alt.books.ghost-fiction 13
21alt.bonehead.jai-maharaj 11
22alt.books.tom-clancy 11
23alt.books.george-orwell 9
24muc.lists.freebsd.current 9
25alt.brain.teasers 8
26alt.japanese.neojapan.fetish.lolita 8
27alt.books.iain-banks 7
28alt.books.larry-niven 6
29comp.lang.javascript 6
30alt.books.james-joyce 5
31alt.japanese.neojapan.lolita 5
32alt.books.roger-zelazny 5
33alt.books.raymond-feist 5
34alt.books.h-g-wells 5
35comp.sys.ibm.ps2.hardware 4
36alt.books.anne-rice 4
37alt.books.moorcock 3
38alt.books.david-gemmell 3
39alt.books.dean-koontz 3
40alt.books.electronic 3
41alt.bonehead.dr-turi 2
42alt.br.test 2
43alt.books.terry-brooks 2
44alt.books.bukowski 2
45alt.books.gor 2
46alt.books.orson-s-card 2
47alt.books.technical 2
48alt.books.david-weber 2
49alt.books.kurt-vonnegut 2
50alt.books.wilbur-smith 2
51alt.books.john-grisham 2
52alt.books.cait-r-kiernan 1
53alt.books.deryni 1
54alt.books.destroyer 1
55alt.books.dylan-thomas 1
56alt.books.outlander 1
TOTAL: 56 10384