Daily Usenet report for csiph.com

Jan 6 04:15:00 -- Jan 7 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 7 02:15:02 csiph pgpverify[51545]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 43555 50.7%8.2 MB 63.6%
innd 23614 27.5%2.5 MB 19.5%
nnrpd 15404 17.9%1.6 MB 12.7%
innfeed 3206 3.7%536.3 KB 4.1%
nocem 100 0.1%11.0 KB 0.1%
controlchan 3 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 85883 100.0%12.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 436478 54.9%
Negative hits 315259 39.7%
Do not exist 42334 5.3%
Cache misses 693 0.1%
TOTAL: 4 794764 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.941 0.0%385 0.000 2.444 34.000
article cleanup00:00:00.235 0.0%42496 0.000 0.006 0.024
article logging00:00:03.169 0.0%43150 0.000 0.073 0.667
article parse00:00:03.109 0.0%139077 0.000 0.022 0.443
article write00:01:50.720 0.1%24134 0.176 4.588 17.784
artlog/artcncl00:00:00.036 0.0%220 0.000 0.164 3.833
artlog/artparse00:00:00.024 0.0%207 0.000 0.116 2.250
data move00:00:00.258 0.0%710495 0.000 0.000 0.002
hisgrep/artcncl00:00:00.091 0.0%334 0.000 0.272 15.500
hishave/artcncl00:00:00.007 0.0%385 0.000 0.018 1.000
hishave/artparse00:00:00.001 0.0%204 0.000 0.005 0.091
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:19.055 0.1%796777 0.002 0.099 0.446
history sync00:00:04.930 0.0%347 0.000 14.207 82.667
history write00:03:02.855 0.2%42179 0.062 4.335 22.228
hiswrite/artcncl00:00:00.404 0.0%51 0.000 7.922 34.000
hiswrite/artparse00:00:01.467 0.0%204 0.000 7.191 32.750
idle23:47:34.999 99.1%700358 67.575 122.302 406.307
nntp read00:00:03.241 0.0%721906 0.002 0.004 0.007
overview write00:03:47.831 0.3%24134 0.526 9.440 93.106
perl filter00:01:43.091 0.1%42176 1.469 2.444 3.985
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.440 0.0%48363 0.000 0.009 0.035
TOTAL: 24:00:48.08223:59:36.904 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.057 0.0%24423 0.000 0.002 0.030
article prepare00:00:00.009 0.0%44532 0.000 0.000 0.004
article read00:00:02.982 0.0%7542 0.000 0.395 14.162
backlog stats00:00:00.218 0.0%429641 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.090 0.0%335329 0.002 0.006 0.014
data write00:00:01.998 0.0%322318 0.001 0.006 0.014
idle23:53:42.883100.0%429641 109.165 200.220 557.335
status file00:00:00.248 0.0%309 0.000 0.803 16.000
TOTAL: 23:54:02.00623:53:50.485100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.192 0.0%87 0.000 2.207 86.000
idle79:34:57.900 99.7%82764 82.413 3461.625900219.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:31.245 0.0%211032 0.000 0.148 142.500
readart00:04:02.956 0.1%110490 0.000 2.199 60.000
TOTAL: 79:49:17.33279:39:32.293 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
moderator@dana.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 131549 6236 116260 9053 4%94:57:49
2csiph-out.news.weretis.net 5 47719 5808 41126 785 12%47:28:33
3feeder.eternal-september.org 2 37893 3704 28975 5214 9%24:02:39
4news-out.aioe.org 3 23023 3241 19752 30 14%24:09:51
5newsfeed.fu-berlin.de 68 25988 1381 24377 230 5%38:35:25
6newsfeed.neva.ru 146 50765 1038 46941 2786 2%71:28:35
7newsfeeds.xmission.com 4 21052 770 20267 15 3%21:39:18
8news-out.mixmin.net 2 25677 762 24730 185 2%24:08:41
9news.redatomik.org 1 18034 607 17423 4 3%18:08:20
10news.bbs.geek.nz 2 17283 161 17095 27 0%23:59:34
11news.freedyn.net 3 25710 136 25427 147 0%23:20:12
12news.fcku.it 2 9143 120 9016 7 1%24:41:48
13xanadu-bbs.net 13 666 85 581 0 12%23:07:55
14news.swapon.de 1 2252 75 2175 2 3%24:28:22
15nntp.pasdenom.info 2 36194 22 36151 21 0%24:09:03
16localhost 37 4 4 0 0 100%00:00:10
TOTAL: 16 1443 472952 24150 430296 18506 5%508:26:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net22.6 MB1.7 MB54.3 MB78.5 MB 28%5.3 KB
2csiph-out.news.weretis.net17.0 MB17.8 KB13.1 MB30.1 MB 56%4.7 KB
3feeder.eternal-september.org10.6 MB1.0 MB65.7 MB77.3 MB 13%8.9 KB
4news-out.aioe.org9.2 MB29.6 KB81.0 KB9.4 MB 98%2.9 KB
5news-out.mixmin.net4.4 MB16.9 KB918.5 KB5.3 MB 82%5.8 KB
6newsfeed.fu-berlin.de3.3 MB0.0 KB607.0 KB3.9 MB 84%2.5 KB
7newsfeed.neva.ru2.8 MB1.1 MB22.7 MB26.6 MB 10%7.1 KB
8newsfeeds.xmission.com2.2 MB0.0 KB103.7 KB2.3 MB 95%3.0 KB
9news.redatomik.org1.5 MB6.1 KB136.8 KB1.7 MB 91%2.8 KB
10news.freedyn.net544.8 KB4.0 KB780.9 KB1.3 MB 40%4.7 KB
11news.bbs.geek.nz340.0 KB78.0 KB78.8 KB496.7 KB 68%2.6 KB
12news.fcku.it270.0 KB0.0 KB70.4 KB340.4 KB 79%2.7 KB
13news.swapon.de220.0 KB0.0 KB23.3 KB243.4 KB 90%3.2 KB
14xanadu-bbs.net199.2 KB0.0 KB0.0 KB199.2 KB100%2.3 KB
15nntp.pasdenom.info43.6 KB13.0 KB48.8 KB105.4 KB 41%2.5 KB
16localhost5.5 KB0.0 KB0.0 KB5.5 KB100%1.4 KB
TOTAL: 1675.2 MB4.0 MB158.6 MB237.7 MB 31%5.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 6 04:15:00 - 04:59:59 423 1.8% 0.161.5 MB 2.0% 0.56
Jan 6 05:00:00 - 05:59:59 460 1.9% 0.131.6 MB 2.2% 0.47
Jan 6 06:00:00 - 06:59:59 605 2.5% 0.172.0 MB 2.7% 0.57
Jan 6 07:00:00 - 07:59:59 539 2.2% 0.151.8 MB 2.4% 0.52
Jan 6 08:00:00 - 08:59:59 822 3.4% 0.232.8 MB 3.7% 0.80
Jan 6 09:00:00 - 09:59:59 959 4.0% 0.272.6 MB 3.5% 0.75
Jan 6 10:00:00 - 10:59:59 1138 4.7% 0.323.1 MB 4.2% 0.89
Jan 6 11:00:00 - 11:59:59 1166 4.8% 0.324.1 MB 5.5% 1.18
Jan 6 12:00:00 - 12:59:59 1128 4.7% 0.313.6 MB 4.9% 1.04
Jan 6 13:00:00 - 13:59:59 1143 4.7% 0.323.3 MB 4.5% 0.95
Jan 6 14:00:00 - 14:59:59 1250 5.2% 0.353.5 MB 4.6% 0.99
Jan 6 15:00:00 - 15:59:59 1407 5.8% 0.394.8 MB 6.4% 1.38
Jan 6 16:00:00 - 16:59:59 1408 5.8% 0.394.2 MB 5.7% 1.21
Jan 6 17:00:00 - 17:59:59 1398 5.8% 0.394.9 MB 6.6% 1.40
Jan 6 18:00:00 - 18:59:59 1442 6.0% 0.404.5 MB 6.0% 1.28
Jan 6 19:00:00 - 19:59:59 1372 5.7% 0.383.8 MB 5.0% 1.07
Jan 6 20:00:00 - 20:59:59 1324 5.5% 0.373.7 MB 5.0% 1.07
Jan 6 21:00:00 - 21:59:59 1278 5.3% 0.353.7 MB 4.9% 1.05
Jan 6 22:00:00 - 22:59:59 1283 5.3% 0.364.1 MB 5.4% 1.15
Jan 6 23:00:00 - 23:59:59 1048 4.3% 0.293.3 MB 4.4% 0.94
Jan 7 00:00:00 - 00:59:59 705 2.9% 0.201.9 MB 2.6% 0.55
Jan 7 01:00:00 - 01:59:59 623 2.6% 0.171.9 MB 2.5% 0.54
Jan 7 02:00:00 - 02:59:59 572 2.4% 0.162.1 MB 2.8% 0.60
Jan 7 03:00:00 - 03:59:59 513 2.1% 0.141.6 MB 2.1% 0.46
Jan 7 04:00:00 - 04:15:00 124 0.5% 0.14378.5 KB 0.5% 0.42
TOTAL: 24:00:00 24130 100.0% 0.2875.1 MB 100.0% 0.89
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 9093 283 0 137 2 0 0 0 8671
2feeder.eternal-september.org 5209 36 0 80 0 0 0 0 5093
3newsfeed.neva.ru 2843 443 0 62 0 0 0 0 2338
4csiph-out.news.weretis.net 822 169 0 3 0 0 0 0 650
5newsfeed.fu-berlin.de 727 36 0 0 0 0 0 0 691
6news-out.mixmin.net 192 0 0 3 0 0 0 0 189
7news.freedyn.net 147 16 0 1 0 0 0 0 130
8news-out.aioe.org 67 18 0 5 0 0 0 0 44
9news.bbs.geek.nz 26 0 0 26 0 0 0 0 0
10newsfeeds.xmission.com 23 0 0 0 0 0 0 0 23
11nntp.pasdenom.info 20 0 0 2 0 0 0 0 18
12news.fcku.it 17 0 0 0 0 0 0 0 17
13news.swapon.de 11 0 0 0 0 0 0 0 11
14news.redatomik.org 8 0 0 1 0 0 0 0 7
TOTAL: 14 19205 1001 0 320 2 0 0 017882

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 299
ut.test 70
lada.auto 65
mpc.lists.freebsd.ports.bugs 52
it-alt.sport.calcio.juventus 48
gmane.linux.alsa.devel 23
lada.movies 20
gmane.comp.gis.openstreetmap 17
mozilla.support.seamonkey 17
oesterreich.tratsch 17
hk.politics 16
test.post 15
mozilla.dev.platform 14
eagle.support.eng 12
alt.computer.workshop 12
alt.survival 12
gmane.comp.freedesktop.xorg.drivers.intel 12
abg.test 11
mpc.lists.nanog 10
alabam.test 9
TOTAL: 130 1001

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

GroupsCount
nz.politics.announce 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 15025
EMP (phn path) 1242
EMP (phl) 479
Too many newsgroups 70
Scoring filter (10) 21
Binary Payload 17
HTML Multipart 15
User-issued cancel 15
Scoring filter (8) 12
Scoring filter (14) 11
Binary: misplaced nfo 10
Binary: misplaced par2 10
Scoring filter (11) 9
Binary: misplaced sfv 9
Scoring filter (9) 9
Scoring filter (12) 6
Scoring filter (19) 6
EMP (phn nph) 5
Binary: misplaced r29 3
Cancel for rejected article 3
TOTAL: 55 17022

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com940174174
TOTAL: 1940174174

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
csiph-out.news.weretis.net 87
feeder.eternal-september.org 85
news-out.mixmin.net 14
news.fcku.it 10
news.redatomik.org 4
newsfeeds.xmission.com 2
news.freedyn.net 1
TOTAL: 7 203
Including strange strings
newsfeed.fu-berlin.de 520
csiph-out.feeder.erje.net 39
news-out.aioe.org 37
csiph-out.news.weretis.net 19
feeder.eternal-september.org 17
news.swapon.de 9
newsfeed.neva.ru 8
news-out.mixmin.net 2
news.redatomik.org 2
news.fcku.it 1
TOTAL: 10 654
No colon-space in header
csiph-out.feeder.erje.net 2
TOTAL: 1 2
TOTAL: 3 859

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 40489 5233 17844 124 0 0 12%23:50:02
2xanadu-bbs 26864 859 23183 0 0 16 3%23:59:51
3news.freedyn.net 24654 821 23167 0 0 302 3%23:59:32
4fu-berlin.de 22554 734 21819 0 0 0 3%23:59:12
5weretis.net 16815 234 16249 0 0 0 1%23:50:17
6xmission 26426 220 22278 4 0 0 0%23:59:52
7usenet.pasdenom.info 27262 183 22016 1910 0 0 0%23:59:52
8news.redatomik.org 23340 145 22526 14 0 0 0%23:50:02
9eternal-september 21066 110 19363 3 0 0 0%23:59:24
10news.mixmin.net 21938 84 20854 4 0 0 0%23:55:02
11news.swapon.de 2545 78 2309 49 0 0 3%23:51:35
12erje 17870 59 17600 148 0 0 0%23:56:56
13aioe 19918 42 18682 26 0 0 0%23:50:02
14neva.ru 23298 5 22151 30 0 0 0%23:59:52
15news.fcku.it 1599 1 1566 0 0 16 0%22:00:10
16bwh 0 0 0 0 0 23389 0%23:50:03
17au2pb 0 0 0 0 0 23413 0%23:50:05
TOTAL: 17 316638 8808 271607 2312 0 47136 2%404:41:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.bbs.geek.nz14.3 MB601.0 KB14.9 MB0.2 KB/s2.8 KB23:50:02
2xanadu-bbs7.0 MB0.0 KB7.0 MB0.1 KB/s8.3 KB23:59:51
3news.freedyn.net6.9 MB0.0 KB6.9 MB0.1 KB/s8.6 KB23:59:32
4fu-berlin.de6.6 MB0.0 KB6.6 MB0.1 KB/s9.3 KB23:59:12
5weretis.net546.1 KB0.0 KB546.1 KB0.0 KB/s2.3 KB23:50:17
6usenet.pasdenom.info534.6 KB8.8 MB9.3 MB0.1 KB/s4.6 KB23:59:52
7xmission495.5 KB9.2 KB504.6 KB0.0 KB/s2.3 KB23:59:52
8news.redatomik.org317.9 KB59.9 KB377.8 KB0.0 KB/s2.4 KB23:50:02
9eternal-september232.4 KB6.3 KB238.7 KB0.0 KB/s2.1 KB23:59:24
10news.mixmin.net167.7 KB9.2 KB176.9 KB0.0 KB/s2.0 KB23:55:02
11news.swapon.de159.3 KB103.4 KB262.7 KB0.0 KB/s2.1 KB23:51:35
12erje119.2 KB457.7 KB577.0 KB0.0 KB/s2.8 KB23:56:56
13aioe93.5 KB70.5 KB164.1 KB0.0 KB/s2.4 KB23:50:02
14neva.ru7.2 KB72.2 KB79.4 KB0.0 KB/s2.3 KB23:59:52
15news.fcku.it1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB22:00:10
16bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
17au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:05
TOTAL: 1737.5 MB10.2 MB47.6 MB0.0 KB/s4.4 KB404:41:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca 300 1118558.6 MB 183 0 002:18:17
2194-73-239-109.cust.centrio.cz 32 99337.9 KB 16 2 003:52:28
3tempe0.bbox.io 27 1967.5 KB 6 0 007:36:48
468-185-181-64.dhcp.mdsn.wi.charter.com 10 22.4 KB 2 2 203:30:55
5dhcp-089-099-203-254.chello.nl 80 22.4 KB 2 0 017:53:02
6g235242.upc-g.chello.nl 2 10.9 KB 1 0 000:01:09
791.199.153.3 4 11.3 KB 1 0 000:03:22
TOTAL: 7 455 1130959.0 MB 211 4 279:49:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 300 1118558.6 MB 183 0 002:18:17
2*.cust.centrio.cz 32 99337.9 KB 16 2 003:52:28
3*.bbox.io 27 1967.5 KB 6 0 007:36:48
4*.chello.nl 80 22.4 KB 2 0 017:53:02
5*.dhcp.mdsn.wi.charter.com 10 22.4 KB 2 2 203:30:55
6*.upc-g.chello.nl 2 10.9 KB 1 0 000:01:09
7unresolved 92 11.3 KB 1 0 043:02:44
8*.hsd1.wa.comcast.net 5 00.0 KB 0 0 001:33:46
TOTAL: 8 548 1130959.0 MB 211 4 279:49:12

NNRP auth users [Top 20]:

UserConn
ctomczyk 15
ohlandl 2
moussa 1
TOTAL: 3 18

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
216.239.174.218 6.413 1.332 0.00042:58:26
dhcp-089-099-203-254.chello.nl 6.236 1.246 0.00017:53:02
tempe0.bbox.io 2.641 0.528 0.00007:36:48
194-73-239-109.cust.centrio.cz 2.737 0.489 0.05103:52:28
68-185-181-64.dhcp.mdsn.wi.charter.com 0.771 0.170 0.00703:30:55
mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca 32.434 10.055 0.00002:18:17
c-174-61-130-222.hsd1.wa.comcast.net 0.386 0.024 0.00001:33:46
91.199.153.3 5.429 4.898 0.00000:03:22
g235242.upc-g.chello.nl 0.201 0.039 0.00000:01:09
1.127.49.18 0.063 0.000 0.00300:00:55
TOTAL: 10 57.311 18.781 0.06179:49:12

Curious NNRP server explorers [Top 20]:

SystemConn
216.239.174.218 87
c-174-61-130-222.hsd1.wa.comcast.net 5
1.127.49.18 1
TOTAL: 3 93

NNRP client timeouts [Top 20]:

SystemConnPeer
216.239.174.218 84 0
tempe0.bbox.io 11 0
68-185-181-64.dhcp.mdsn.wi.charter.com 5 0
194-73-239-109.cust.centrio.cz 5 0
c-174-61-130-222.hsd1.wa.comcast.net 3 0
TOTAL: 5 108 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 235 47.0%
2comp 114 22.8%
3uk 59 11.8%
4rec 22 4.4%
5soc 17 3.4%
6muc 17 3.4%
7can 13 2.6%
8talk 5 1.0%
9pl 5 1.0%
10linux 4 0.8%
11misc 4 0.8%
12fr 3 0.6%
13aus 2 0.4%
TOTAL: 13 500100.0%

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

NewsgroupCount
1comp.lang.javascript 95
2alt.politics.economics 45
3alt.christnet.christianlife 45
4alt.free.newsservers 35
5alt.society.liberalism 34
6alt.usage.english 26
7uk.media.radio.archers 16
8muc.lists.freebsd.current 15
9uk.d-i-y 15
10soc.culture.usa 14
11can.politics 13
12comp.lang.python 10
13alt.atheism 10
14uk.legal 10
15alt.home.repair 9
16alt.california 8
17rec.boats 7
18comp.sys.ibm.ps2.hardware 7
19alt.bible.prophecy 6
20rec.arts.tv 6
21pl.comp.lang.javascript 5
22rec.arts.sf.written 4
23misc.survivalism 4
24alt.messianic 4
25linux.kernel 4
26talk.politics.misc 4
27uk.rec.drugs.cannabis 4
28uk.politics.misc 3
29fr.soc.politique 3
30soc.culture.polish 3
31alt.os.linux 2
32rec.sport.tennis 2
33aus.politics 2
34uk.games.video.misc 2
35muc.lists.freebsd.fs 2
36uk.rec.sheds 2
37alt.slack 2
38uk.net.news.moderation 1
39alt.obituaries 1
40rec.motorcycles 1
41alt.rush-limbaugh 1
42alt.russian.z1 1
43talk.origins 1
44alt.buddha.short.fat.guy 1
45uk.sport.cricket 1
46uk.rec.motorcycles 1
47uk.tech.broadcast 1
48uk.rec.cycling 1
49alt.sex.telephone 1
50alt.talk.creationism 1
51alt.war.vietnam 1
52uk.railway 1
53alt.comp.freeware 1
54comp.os.vms 1
55alt.global-warming 1
56comp.mobile.android 1
57uk.radio.amateur 1
58rec.arts.sf.fandom 1
59rec.sport.golf 1
TOTAL: 59 500