Daily Usenet report for csiph.com

Jan 10 04:15:00 -- Jan 11 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Jan 10 15:41:17 csiph nnrpd[2345]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 10 15:41:17 csiph nnrpd[2345]: error initializing TLS: [CA_file: ] [CA_path: /usr/local/news/etc] [cert_file: /usr/local/news/etc/cert.pem] [key_file: /usr/local/news/etc/key.pem]
Jan 10 19:46:28 csiph nnrpd[15949]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 10 19:46:28 csiph nnrpd[15949]: error initializing TLS: [CA_file: ] [CA_path: /usr/local/news/etc] [cert_file: /usr/local/news/etc/cert.pem] [key_file: /usr/local/news/etc/key.pem]
Jan 10 20:08:14 csiph nnrpd[17073]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 10 20:08:14 csiph nnrpd[17073]: error initializing TLS: [CA_file: ] [CA_path: /usr/local/news/etc] [cert_file: /usr/local/news/etc/cert.pem] [key_file: /usr/local/news/etc/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
inn 19636 50.1%4.9 MB 64.8%
innd 13974 35.6%1.8 MB 24.2%
innfeed 3632 9.3%639.2 KB 8.3%
nnrpd 1953 5.0%215.8 KB 2.8%
nocem 17 0.0%2.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 39213 100.0%7.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 297702 52.8%
Negative hits 246972 43.8%
Do not exist 18964 3.4%
Cache misses 589 0.1%
TOTAL: 4 564227 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.453 0.0%24 0.000 18.875 40.857
article cleanup00:00:00.098 0.0%18621 0.000 0.005 0.034
article logging00:00:00.413 0.0%19188 0.000 0.022 0.360
article parse00:00:01.651 0.0%62855 0.000 0.026 0.742
article write00:00:35.808 0.0%15280 0.153 2.343 82.096
artlog/artcncl00:00:00.015 0.0%24 0.000 0.625 2.143
artlog/artparse00:00:00.170 0.0%361 0.000 0.471 38.000
data move00:00:00.230 0.0%543539 0.000 0.000 0.003
hisgrep/artcncl00:00:00.008 0.0%24 0.000 0.333 1.000
hishave/artcncl00:00:00.000 0.0%24 0.000 0.000 0.000
hishave/artparse00:00:00.001 0.0%350 0.000 0.003 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:28.535 0.0%564871 0.001 0.051 0.301
history sync00:00:01.198 0.0%354 0.000 3.384 55.333
history write00:00:45.781 0.1%18624 0.607 2.458 12.837
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.904 0.0%350 0.000 2.583 23.000
idle23:46:28.473 99.7%540650 88.156 158.307 615.030
nntp read00:00:02.169 0.0%546768 0.001 0.004 0.009
overview write00:01:26.281 0.1%15280 0.104 5.647 192.577
perl filter00:00:27.414 0.0%18605 1.135 1.473 2.185
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.243 0.0%30577 0.000 0.008 0.036
TOTAL: 23:50:56.21723:50:19.845100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%15423 0.000 0.002 0.021
article prepare00:00:00.002 0.0%14860 0.000 0.000 0.013
article read00:00:00.270 0.0%1657 0.000 0.163 22.000
backlog stats00:00:00.228 0.0%339612 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.286 0.0%265379 0.000 0.005 0.015
data write00:00:01.665 0.0%252036 0.000 0.007 0.014
idle23:54:37.835100.0%339612 149.502 253.459 1039.015
status file00:00:00.281 0.0%325 0.000 0.865 18.000
TOTAL: 23:54:48.08223:54:41.597100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle36:07:07.754 99.3%1038 60.667125267.586450757.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.024 0.0%2459 0.000 0.010 0.333
readart00:00:00.082 0.0%3 0.000 27.333 41.000
TOTAL: 36:23:01.13936:07:07.860 99.3%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 130
pause 2
paused 2
reload 2
reserve 2
TOTAL: 10 150

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 0 26056 4012 20090 1954 15%76:28:26
2newsfeeds.xmission.com 3 14689 2692 11963 34 18%25:02:16
3feeder.eternal-september.org 11 6086 2526 3415 145 41%27:18:12
4news-out.mixmin.net 3 16843 1620 14808 415 9%24:08:52
5newsfeed.fu-berlin.de 12 19094 1065 17798 231 5%32:17:01
6csiph-out.feeder.erje.net 1441 78529 1003 77072 454 1%118:40:32
7csiph-out.news.weretis.net 3 19618 757 18672 189 3%33:59:03
8newsfeed.neva.ru 148 13671 561 12926 184 4%71:49:22
9news-out.aioe.org 2 14595 335 14186 74 2%23:59:56
10csiph-out.feed.uzoreto.com 864 25158 282 24667 209 1%71:12:12
11news-out.neodome.net 2 16992 254 16719 19 1%24:05:55
12nntp.pasdenom.info 2 9824 170 9641 13 1%23:58:29
13news.fcku.it 14 1395 150 1244 1 10%22:19:08
14news.swapon.de 5 1658 40 1618 0 2%23:18:47
15csiph-out.news.tnetconsulting.net 1 14833 35 14733 65 0%23:59:56
16news.freedyn.net 2 18020 29 17957 34 0%23:59:49
17news.bbs.nz 1 14412 10 14402 0 0%23:59:52
18news.samoylyk.net 2 14665 7 14657 1 0%23:59:46
19xanadu-bbs.net 24 435 0 435 0 0%21:03:21
20localhost 26 0 0 0 0 0%00:00:00
TOTAL: 20 2566 326573 15548 307003 4022 4%715:40:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl10.7 MB0.0 KB14.8 MB25.5 MB 41%4.4 KB
2newsfeeds.xmission.com7.9 MB0.0 KB716.9 KB8.6 MB 91%3.2 KB
3csiph-out.feeder.erje.net7.6 MB5.6 KB3.7 MB11.3 MB 67%7.9 KB
4feeder.eternal-september.org6.8 MB0.0 KB1.5 MB8.3 MB 81%3.2 KB
5news-out.mixmin.net3.8 MB0.0 KB3.2 MB7.0 MB 54%3.5 KB
6newsfeed.fu-berlin.de2.5 MB0.0 KB619.9 KB3.1 MB 80%2.4 KB
7csiph-out.news.weretis.net2.1 MB11.6 KB2.2 MB4.3 MB 48%4.7 KB
8newsfeed.neva.ru1.5 MB0.0 KB744.3 KB2.2 MB 66%3.0 KB
9news-out.aioe.org1.4 MB0.0 KB115.6 KB1.5 MB 92%3.8 KB
10csiph-out.feed.uzoreto.com1.3 MB0.0 KB5.5 MB6.8 MB 18%14.2 KB
11news-out.neodome.net744.1 KB29.7 KB176.3 KB950.1 KB 78%3.5 KB
12nntp.pasdenom.info376.1 KB0.0 KB16.3 KB392.4 KB 95%2.1 KB
13news.fcku.it268.8 KB0.0 KB2.0 KB270.8 KB 99%1.8 KB
14news.freedyn.net217.9 KB11.5 KB1.8 MB2.1 MB 10%33.6 KB
15csiph-out.news.tnetconsulting.net187.5 KB0.0 KB5.1 MB5.3 MB 3%54.3 KB
16news.samoylyk.net106.7 KB18.1 KB18.1 KB142.9 KB 74%17.9 KB
17news.swapon.de88.2 KB0.0 KB0.0 KB88.2 KB100%2.2 KB
18news.bbs.nz13.9 KB0.0 KB0.0 KB13.9 KB100%1.4 KB
19xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2047.4 MB76.5 KB40.2 MB87.7 MB 54%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 10 04:15:00 - 04:59:59 193 1.3% 0.07662.0 KB 1.4% 0.25
Jan 10 05:00:00 - 05:59:59 253 1.6% 0.071.0 MB 2.2% 0.29
Jan 10 06:00:00 - 06:59:59 251 1.6% 0.07766.5 KB 1.6% 0.21
Jan 10 07:00:00 - 07:59:59 315 2.1% 0.09890.7 KB 1.9% 0.25
Jan 10 08:00:00 - 08:59:59 469 3.1% 0.131.2 MB 2.5% 0.34
Jan 10 09:00:00 - 09:59:59 667 4.3% 0.192.6 MB 5.6% 0.75
Jan 10 10:00:00 - 10:59:59 706 4.6% 0.202.2 MB 4.7% 0.63
Jan 10 11:00:00 - 11:59:59 785 5.1% 0.222.1 MB 4.6% 0.61
Jan 10 12:00:00 - 12:59:59 816 5.3% 0.232.5 MB 5.3% 0.71
Jan 10 13:00:00 - 13:59:59 825 5.4% 0.232.3 MB 5.0% 0.66
Jan 10 14:00:00 - 14:59:59 876 5.7% 0.243.1 MB 6.7% 0.89
Jan 10 15:00:00 - 15:59:59 920 6.0% 0.263.3 MB 7.1% 0.94
Jan 10 16:00:00 - 16:59:59 950 6.2% 0.262.8 MB 6.0% 0.81
Jan 10 17:00:00 - 17:59:59 899 5.9% 0.252.4 MB 5.1% 0.68
Jan 10 18:00:00 - 18:59:59 872 5.7% 0.242.3 MB 4.9% 0.65
Jan 10 19:00:00 - 19:59:59 910 5.9% 0.252.6 MB 5.6% 0.75
Jan 10 20:00:00 - 20:59:59 823 5.4% 0.232.4 MB 5.1% 0.68
Jan 10 21:00:00 - 21:59:59 726 4.7% 0.202.0 MB 4.2% 0.57
Jan 10 22:00:00 - 22:59:59 710 4.6% 0.202.3 MB 5.0% 0.66
Jan 10 23:00:00 - 23:59:59 608 4.0% 0.171.8 MB 3.9% 0.52
Jan 11 00:00:00 - 00:59:59 482 3.1% 0.131.4 MB 2.9% 0.39
Jan 11 01:00:00 - 01:59:59 421 2.7% 0.121.4 MB 2.9% 0.38
Jan 11 02:00:00 - 02:59:59 385 2.5% 0.111.3 MB 2.7% 0.36
Jan 11 03:00:00 - 03:59:59 370 2.4% 0.101.1 MB 2.4% 0.33
Jan 11 04:00:00 - 04:15:00 105 0.7% 0.12408.5 KB 0.8% 0.45
TOTAL: 24:00:00 15337 100.0% 0.1846.9 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1938 86 0 0 2 0 0 0 1850
2newsfeed.fu-berlin.de 645 14 0 0 0 0 0 0 631
3news-out.mixmin.net 448 2 0 0 0 0 0 0 446
4csiph-out.feeder.erje.net 233 98 0 3 0 0 0 0 132
5csiph-out.news.weretis.net 225 67 0 1 0 0 0 0 157
6csiph-out.feed.uzoreto.com 215 8 0 0 0 0 0 0 207
7newsfeed.neva.ru 186 57 0 0 0 0 0 0 129
8feeder.eternal-september.org 146 85 0 0 0 8 0 0 53
9news-out.aioe.org 78 61 0 0 0 0 0 0 17
10newsfeeds.xmission.com 50 28 0 0 0 0 0 0 22
11news.freedyn.net 35 0 0 1 0 0 0 0 34
12csiph-out.news.tnetconsulting.net 22 22 0 0 0 0 0 0 0
13news-out.neodome.net 21 5 0 2 0 0 0 0 14
14news.swapon.de 18 0 0 0 0 0 0 0 18
15nntp.pasdenom.info 13 0 0 0 0 0 0 0 13
16news.samoylyk.net 1 0 0 1 0 0 0 0 0
17news.fcku.it 1 1 0 0 0 0 0 0 0
TOTAL: 17 4275 534 0 8 2 8 0 0 3723

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 82
alt.binaries.pictures.purebeauty 52
alt.politics 52
lada.talk 40
scinet.general.chatter 34
mozilla.support.seamonkey 33
it-alt.sport.calcio.juventus 26
scinet.stats 21
mozilla.support.thunderbird 15
alt.survival 14
mozilla.general 14
scinet.gaming 12
alt.politics.usa 9
alt.philosophy 9
oesterreich.tratsch 9
alt.tv.comedy-central.daily-show 9
spline.eisfair 8
scinet.sysop 6
alt.religion 5
mozilla.support.firefox 5
TOTAL: 71 534

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

GroupsCount
uk.legal.moderated 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1856
EMP (phn path) 506
EMP (phl) 133
EMP (phn nph) 96
Too many newsgroups 92
0 49
Binary: misplaced binary 34
Too many newsgroups (meow) 9
HTML Multipart 8
Scoring filter 6
HTML post 2
TOTAL: 11 2791

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.news.xs4all.nl 152
csiph-out.feeder.erje.net 64
csiph-out.feed.uzoreto.com 63
news.freedyn.net 23
csiph-out.news.weretis.net 21
feeder.eternal-september.org 11
news-out.mixmin.net 9
newsfeeds.xmission.com 6
news-out.neodome.net 3
TOTAL: 9 352
Including strange strings
newsfeed.fu-berlin.de 469
csiph-out.news.xs4all.nl 34
news.swapon.de 18
newsfeeds.xmission.com 16
csiph-out.news.weretis.net 13
csiph-out.feed.uzoreto.com 6
news-out.mixmin.net 5
csiph-out.feeder.erje.net 3
feeder.eternal-september.org 3
newsfeed.neva.ru 2
TOTAL: 10 569
No colon-space in header
csiph-out.news.xs4all.nl 11
TOTAL: 1 11
TOTAL: 4 977

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 18128 1219 14117 1 0 0 6%23:59:44
2fu-berlin.de 14161 543 13617 0 0 0 3%23:54:35
3news.samoylyk.net 15918 528 14752 7 0 0 3%23:53:00
4news.bbs.nz 28533 415 14245 23 0 0 1%23:50:03
5xmission 13718 146 11870 6 0 0 1%23:59:38
6tnet 15829 121 14574 0 0 0 0%23:50:04
7newsfeed.xs4all.nl 12019 95 11198 0 0 111 0%23:54:27
8usenet.pasdenom.info 15167 20 14516 52 0 10 0%23:59:55
9erje 14146 15 13735 279 0 0 0%23:58:25
10news.freedyn.net 14107 15 13581 29 0 0 0%23:50:03
11aioe 12797 11 12145 0 0 0 0%23:50:03
12news.mixmin.net 13297 7 12772 0 0 0 0%23:59:12
13neodome.net 15591 4 14953 0 0 0 0%23:55:20
14news.uzoreto.com 14590 3 14160 11 0 0 0%23:50:03
15neva.ru 14247 2 13823 163 0 0 0%23:59:49
16news.swapon.de 1687 1 1675 0 0 0 0%23:45:03
17weretis.net 13969 0 13710 0 0 0 0%23:50:04
18eternal-september 0 0 0 0 0 12138 0%23:59:56
19news.fcku.it 1178 0 1178 0 0 0 0%21:47:49
TOTAL: 19 249082 3145 220621 571 0 12259 1%452:07:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs7.9 MB18.9 KB7.9 MB0.1 KB/s6.7 KB23:59:44
2fu-berlin.de6.2 MB0.0 KB6.2 MB0.1 KB/s11.7 KB23:54:35
3news.samoylyk.net6.2 MB8.7 KB6.2 MB0.1 KB/s11.8 KB23:53:00
4news.bbs.nz1.0 MB135.7 KB1.2 MB0.0 KB/s2.8 KB23:50:03
5tnet304.2 KB0.0 KB304.2 KB0.0 KB/s2.5 KB23:50:04
6xmission291.0 KB14.9 KB305.9 KB0.0 KB/s2.0 KB23:59:38
7newsfeed.xs4all.nl222.7 KB0.0 KB222.7 KB0.0 KB/s2.3 KB23:54:27
8usenet.pasdenom.info43.9 KB91.3 KB135.2 KB0.0 KB/s1.9 KB23:59:55
9news.freedyn.net43.5 KB438.9 KB482.4 KB0.0 KB/s11.0 KB23:50:03
10aioe28.2 KB0.0 KB28.2 KB0.0 KB/s2.6 KB23:50:03
11erje25.0 KB742.4 KB767.4 KB0.0 KB/s2.6 KB23:58:25
12news.mixmin.net11.4 KB0.0 KB11.4 KB0.0 KB/s1.6 KB23:59:12
13neodome.net10.6 KB0.0 KB10.6 KB0.0 KB/s2.6 KB23:55:20
14news.uzoreto.com7.7 KB24.6 KB32.3 KB0.0 KB/s2.3 KB23:50:03
15neva.ru6.2 KB430.9 KB437.1 KB0.0 KB/s2.6 KB23:59:49
16news.swapon.de2.4 KB0.0 KB2.4 KB0.0 KB/s2.4 KB23:45:03
17weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:04
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:47:49
TOTAL: 1922.3 MB1.9 MB24.1 MB0.0 KB/s6.7 KB452:07:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
191.187.33.87 290 11.8 KB 1 0 030:41:34
2172.83.100.205 6 11.8 KB 1 0 002:00:28
3a131033.upc-a.chello.nl 8 11.8 KB 1 0 002:09:36
TOTAL: 3 304 35.4 KB 3 0 036:22:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 299 23.6 KB 2 0 033:42:24
2*.upc-a.chello.nl 8 11.8 KB 1 0 002:09:36
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.range86-139.btcentralplus.com 2 00.0 KB 0 0 000:00:53
5*.hsd1.wa.comcast.net 1 00.0 KB 0 0 000:30:03
TOTAL: 5 311 35.4 KB 3 0 036:22:58

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 18.437 4.016 0.00030:41:34
a131033.upc-a.chello.nl 0.596 0.110 0.00002:09:36
172.83.100.205 0.397 0.085 0.00002:00:28
172.83.100.218 0.202 0.046 0.00001:00:11
c-73-140-175-55.hsd1.wa.comcast.net 0.058 0.017 0.00000:30:03
host86-139-107-71.range86-139.btcentralplus.com 0.121 0.040 0.00000:00:53
139.59.13.157 0.054 0.023 0.00000:00:10
scanner-05.ch1.censys-scanner.com 0.071 0.008 0.00000:00:00
TOTAL: 8 19.936 4.345 0.00036:22:58

Curious NNRP server explorers [Top 20]:

SystemConn
host86-139-107-71.range86-139.btcentralplus.com 2
172.83.100.218 2
139.59.13.157 1
c-73-140-175-55.hsd1.wa.comcast.net 1
scanner-05.ch1.censys-scanner.com 1
TOTAL: 5 7

NNRP unrecognized commands (by host):

SystemConn
scanner-05.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
172.83.100.205 4 0
172.83.100.218 2 0
c-73-140-175-55.hsd1.wa.comcast.net 1 0
TOTAL: 3 7 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 3100.0%
TOTAL: 1 3100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 3
TOTAL: 1 3