Daily Usenet report for csiph.com

Dec 29 04:15:00 -- Dec 30 04:15:00

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Dec 29 15:11:20 csiph nnrpd[59966]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 29 15:11:20 csiph nnrpd[59973]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 29 15:11:20 csiph nnrpd[59966]: 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]
Dec 29 15:11:20 csiph nnrpd[59973]: 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]
Dec 29 15:11:45 csiph nnrpd[60010]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Dec 29 15:11:45 csiph nnrpd[60010]: 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 18166 46.6%4.7 MB 61.8%
innd 17005 43.6%2.2 MB 29.4%
innfeed 3458 8.9%648.1 KB 8.3%
nnrpd 325 0.8%35.0 KB 0.4%
nocem 22 0.1%2.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 38977 100.0%7.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 296138 57.0%
Negative hits 205382 39.5%
Do not exist 17626 3.4%
Cache misses 201 0.0%
TOTAL: 4 519347 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.200 0.0%18 0.000 11.111 19.000
article cleanup00:00:00.090 0.0%17418 0.000 0.005 0.053
article logging00:00:00.281 0.0%17892 0.000 0.016 0.304
article parse00:00:00.819 0.0%51679 0.000 0.016 0.123
article write00:00:10.855 0.0%14631 0.140 0.742 33.481
artlog/artcncl00:00:00.000 0.0%18 0.000 0.000 0.000
artlog/artparse00:00:00.005 0.0%267 0.000 0.019 1.000
data move00:00:00.135 0.0%488970 0.000 0.000 0.002
hisgrep/artcncl00:00:00.018 0.0%17 0.000 1.059 11.000
hishave/artcncl00:00:00.019 0.0%18 0.000 1.056 18.000
hishave/artparse00:00:00.000 0.0%261 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:28.822 0.0%520644 0.001 0.055 0.595
history sync00:00:00.717 0.0%367 0.000 1.954 11.000
history write00:00:24.610 0.0%17424 0.441 1.412 8.000
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
hiswrite/artparse00:00:00.359 0.0%261 0.000 1.375 16.000
idle23:56:33.437 99.7%493371 99.243 174.703 625.154
nntp read00:00:01.808 0.0%496640 0.001 0.004 0.007
overview write00:02:29.435 0.2%14631 0.100 10.214 1930.061
perl filter00:00:23.546 0.0%17418 1.031 1.352 2.278
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.245 0.0%29284 0.000 0.008 0.031
TOTAL: 24:01:03.72924:00:35.402100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%14678 0.000 0.002 0.032
article prepare00:00:00.001 0.0%12496 0.000 0.000 0.004
article read00:00:00.198 0.0%1221 0.000 0.162 7.500
backlog stats00:00:00.201 0.0%345207 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.238 0.0%271063 0.001 0.005 0.009
data write00:00:01.488 0.0%258121 0.003 0.006 0.015
idle23:53:45.590100.0%345207 137.386 249.200 770.095
status file00:00:00.200 0.0%264 0.000 0.758 2.750
TOTAL: 23:53:56.52623:53:48.945100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:04.203 0.0%2475 1.415 1.698 1.981
idle09:15:22.753 99.9%2729 0.000 12210.609600087.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.714 0.0%100586 0.000 0.007 0.167
readart00:00:00.151 0.0%25 0.000 6.040 41.000
TOTAL: 09:15:42.49709:15:27.821100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeeds.xmission.com 3 14175 3503 10626 46 24%24:48:36
2news-out.aioe.org 3 14027 3360 10611 56 23%24:09:34
3feeder.eternal-september.org 2 16254 1823 14141 290 11%24:38:01
4csiph-out.feeder.erje.net 1442 70739 1100 69342 297 1%118:49:33
5csiph-out.news.xs4all.nl 860 16179 821 14494 864 5%71:33:51
6csiph-out.news.weretis.net 3 27181 809 26211 161 2%45:27:09
7news-out.mixmin.net 1 15293 731 14219 343 4%23:59:49
8newsfeed.fu-berlin.de 7 12763 644 12063 56 5%23:21:31
9csiph-out.news.tnetconsulting.net 4 24635 453 24146 36 1%39:32:40
10newsfeed.neva.ru 147 16235 451 15389 395 2%71:51:35
11news.freedyn.net 1 16878 354 16434 90 2%23:59:56
12csiph-out.feed.uzoreto.com 864 23017 200 22476 341 0%71:19:41
13news-out.neodome.net 2 15222 181 15022 19 1%23:59:53
14nntp.pasdenom.info 1 8694 104 8561 29 1%23:59:51
15news.fcku.it 13 1069 81 985 3 7%20:41:42
16news.swapon.de 5 1210 35 1174 1 2%22:35:08
17news.samoylyk.net 2 14090 6 14084 0 0%23:59:42
18news.bbs.nz 1 13103 2 13101 0 0%23:59:53
19xanadu-bbs.net 24 464 0 464 0 0%22:47:48
20localhost 26 0 0 0 0 0%00:00:05
TOTAL: 20 3411 321228 14658 303543 3027 4%725:35:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com10.8 MB0.0 KB2.3 MB13.2 MB 82%3.8 KB
2news-out.aioe.org8.6 MB0.0 KB156.2 KB8.7 MB 98%2.6 KB
3csiph-out.feeder.erje.net7.2 MB0.0 KB10.1 MB17.3 MB 41%12.7 KB
4feeder.eternal-september.org5.3 MB0.0 KB923.0 KB6.2 MB 85%3.0 KB
5csiph-out.news.xs4all.nl2.4 MB0.0 KB6.1 MB8.4 MB 28%5.1 KB
6csiph-out.news.weretis.net2.3 MB0.0 KB1.3 MB3.5 MB 64%3.7 KB
7news-out.mixmin.net2.1 MB0.0 KB812.4 KB2.8 MB 72%2.7 KB
8news.freedyn.net1.7 MB0.0 KB292.1 KB2.0 MB 85%4.6 KB
9newsfeed.fu-berlin.de1.4 MB0.0 KB641.6 KB2.1 MB 69%3.0 KB
10csiph-out.news.tnetconsulting.net1.4 MB0.0 KB142.0 KB1.5 MB 91%3.2 KB
11newsfeed.neva.ru1.3 MB0.0 KB1.6 MB2.9 MB 44%3.5 KB
12csiph-out.feed.uzoreto.com759.7 KB0.0 KB3.2 MB3.9 MB 18%7.4 KB
13news-out.neodome.net591.8 KB0.0 KB450.7 KB1.0 MB 56%5.2 KB
14nntp.pasdenom.info222.5 KB0.0 KB37.2 KB259.7 KB 85%2.0 KB
15news.fcku.it169.8 KB0.0 KB3.9 KB173.7 KB 97%2.1 KB
16news.swapon.de96.3 KB0.0 KB43.2 KB139.5 KB 69%3.9 KB
17news.samoylyk.net14.5 KB0.0 KB0.0 KB14.5 KB100%2.4 KB
18news.bbs.nz3.5 KB0.0 KB0.0 KB3.5 KB100%1.8 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: 2046.3 MB0.0 KB28.0 MB74.2 MB 62%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 29 04:15:00 - 04:59:59 234 1.6% 0.09758.3 KB 1.6% 0.28
Dec 29 05:00:00 - 05:59:59 298 2.0% 0.08981.9 KB 2.1% 0.27
Dec 29 06:00:00 - 06:59:59 257 1.8% 0.07798.0 KB 1.7% 0.22
Dec 29 07:00:00 - 07:59:59 359 2.5% 0.101.5 MB 3.3% 0.43
Dec 29 08:00:00 - 08:59:59 503 3.4% 0.141.4 MB 3.0% 0.39
Dec 29 09:00:00 - 09:59:59 574 3.9% 0.161.6 MB 3.6% 0.47
Dec 29 10:00:00 - 10:59:59 667 4.6% 0.192.9 MB 6.4% 0.84
Dec 29 11:00:00 - 11:59:59 777 5.3% 0.222.8 MB 6.1% 0.80
Dec 29 12:00:00 - 12:59:59 627 4.3% 0.172.0 MB 4.4% 0.58
Dec 29 13:00:00 - 13:59:59 584 4.0% 0.161.4 MB 3.1% 0.40
Dec 29 14:00:00 - 14:59:59 831 5.7% 0.232.2 MB 4.8% 0.64
Dec 29 15:00:00 - 15:59:59 806 5.5% 0.222.7 MB 5.9% 0.77
Dec 29 16:00:00 - 16:59:59 828 5.7% 0.232.1 MB 4.6% 0.60
Dec 29 17:00:00 - 17:59:59 911 6.2% 0.252.6 MB 5.6% 0.74
Dec 29 18:00:00 - 18:59:59 845 5.8% 0.232.5 MB 5.4% 0.71
Dec 29 19:00:00 - 19:59:59 881 6.0% 0.242.7 MB 5.8% 0.77
Dec 29 20:00:00 - 20:59:59 811 5.5% 0.232.2 MB 4.7% 0.62
Dec 29 21:00:00 - 21:59:59 921 6.3% 0.263.1 MB 6.6% 0.87
Dec 29 22:00:00 - 22:59:59 720 4.9% 0.202.5 MB 5.4% 0.71
Dec 29 23:00:00 - 23:59:59 565 3.9% 0.162.0 MB 4.3% 0.56
Dec 30 00:00:00 - 00:59:59 437 3.0% 0.121.4 MB 3.0% 0.39
Dec 30 01:00:00 - 01:59:59 436 3.0% 0.121.4 MB 3.0% 0.40
Dec 30 02:00:00 - 02:59:59 371 2.5% 0.101023.5 KB 2.2% 0.28
Dec 30 03:00:00 - 03:59:59 319 2.2% 0.091.3 MB 2.8% 0.37
Dec 30 04:00:00 - 04:15:00 64 0.4% 0.07267.7 KB 0.6% 0.30
TOTAL: 24:00:00 14626 100.0% 0.1746.1 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 864 21 0 0 0 0 0 0 843
2newsfeed.fu-berlin.de 409 17 0 0 0 0 0 0 392
3newsfeed.neva.ru 393 28 0 0 0 0 0 0 365
4news-out.mixmin.net 345 1 0 0 0 0 0 0 344
5csiph-out.feed.uzoreto.com 342 6 0 0 0 0 0 0 336
6csiph-out.feeder.erje.net 303 43 0 0 0 0 0 0 260
7feeder.eternal-september.org 295 19 0 0 0 0 0 0 276
8csiph-out.news.weretis.net 191 33 0 0 0 0 0 0 158
9news-out.aioe.org 159 33 0 0 0 0 0 0 126
10news.freedyn.net 94 3 0 0 0 0 0 0 91
11newsfeeds.xmission.com 48 4 0 0 0 0 0 0 44
12nntp.pasdenom.info 29 0 0 0 0 0 0 0 29
13csiph-out.news.tnetconsulting.net 28 20 0 0 0 0 0 0 8
14news-out.neodome.net 13 0 0 0 0 0 0 0 13
15news.swapon.de 6 0 0 0 0 0 0 0 6
16news.fcku.it 3 0 0 0 0 0 0 0 3
TOTAL: 16 3522 228 0 0 0 0 0 0 3294

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.survival 20
lada.talk 15
alt.windows7.general 14
alt.binaries.pictures.purebeauty 12
mozilla.general 9
it-alt.sport.calcio.juventus 9
alt.bbs.synchronet 8
lada.auto 7
alt.binaries.ebooks 7
alt.music.pink-floyd.publius 7
alt.politics 6
alt.computer.workshop 6
alt.english.usage 5
oesterreich.test 5
alt.politics.usa 5
mozilla.support.firefox 5
alt.eunuchs 5
fido7.ru.android 4
oesterreich.tratsch 4
mozilla.support.thunderbird 4
TOTAL: 74 228

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2157
EMP (phn path) 243
0 61
Too many newsgroups 39
Binary: misplaced binary 27
HTML Multipart 16
EMP (phl) 4
Binary Payload 3
Too many newsgroups (meow) 2
U2 violation - invalid distribution 1
Scoring filter 1
TOTAL: 11 2554

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 45
TOTAL: 1 45
Huge articles
csiph-out.feeder.erje.net 189
newsfeeds.xmission.com 38
csiph-out.news.weretis.net 11
csiph-out.news.xs4all.nl 5
news-out.mixmin.net 5
csiph-out.feed.uzoreto.com 4
newsfeed.fu-berlin.de 3
feeder.eternal-september.org 3
news.swapon.de 1
csiph-out.news.tnetconsulting.net 1
TOTAL: 10 260
Including strange strings
newsfeed.fu-berlin.de 340
news-out.aioe.org 103
csiph-out.news.weretis.net 9
csiph-out.feeder.erje.net 6
news.swapon.de 5
newsfeeds.xmission.com 4
news-out.mixmin.net 3
news.freedyn.net 3
csiph-out.feed.uzoreto.com 1
TOTAL: 9 474
No colon-space in header
csiph-out.news.xs4all.nl 6
TOTAL: 1 6
TOTAL: 4 785

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 18981 876 13750 0 0 0 4%23:59:53
2news.samoylyk.net 15021 488 14129 3 0 0 3%23:59:54
3fu-berlin.de 13835 463 13372 0 0 0 3%23:59:54
4news.freedyn.net 14514 457 13757 34 0 0 3%23:59:54
5news.bbs.nz 27451 324 13807 3 0 0 1%23:59:54
6usenet.pasdenom.info 14395 73 13938 20 0 0 0%23:59:49
7newsfeed.xs4all.nl 14029 40 13634 3 0 64 0%23:59:53
8neva.ru 13750 23 13463 91 0 0 0%23:59:54
9tnet 15456 21 14116 0 0 12 0%23:59:54
10news.uzoreto.com 14055 13 13815 134 0 0 0%23:59:13
11aioe 10212 12 9880 0 0 0 0%23:59:53
12erje 13627 9 13347 29 0 0 0%23:59:51
13neodome.net 14743 9 14373 0 0 0 0%23:59:53
14xmission 13836 3 10671 2 0 0 0%23:59:07
15news.mixmin.net 13583 1 13180 0 0 0 0%23:59:54
16weretis.net 13345 1 13147 5 0 0 0%23:59:52
17news.swapon.de 1327 0 1313 0 0 0 0%23:44:20
18news.fcku.it 884 0 879 0 0 0 0%20:19:44
19eternal-september 12556 0 12198 3 0 0 0%23:59:44
TOTAL: 19 255600 2813 226769 327 0 76 1%452:00:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.5 MB0.0 KB6.5 MB0.1 KB/s7.6 KB23:59:53
2news.samoylyk.net5.4 MB3.7 KB5.4 MB0.1 KB/s11.2 KB23:59:54
3fu-berlin.de5.3 MB0.0 KB5.3 MB0.1 KB/s11.8 KB23:59:54
4news.freedyn.net5.3 MB66.6 KB5.4 MB0.1 KB/s11.2 KB23:59:54
5news.bbs.nz817.3 KB30.0 KB847.3 KB0.0 KB/s2.6 KB23:59:54
6usenet.pasdenom.info171.1 KB69.1 KB240.2 KB0.0 KB/s2.6 KB23:59:49
7newsfeed.xs4all.nl119.5 KB22.7 KB142.2 KB0.0 KB/s3.3 KB23:59:53
8neodome.net51.9 KB0.0 KB51.9 KB0.0 KB/s5.8 KB23:59:53
9neva.ru50.6 KB190.4 KB241.0 KB0.0 KB/s2.1 KB23:59:54
10tnet40.5 KB0.0 KB40.5 KB0.0 KB/s1.9 KB23:59:54
11aioe29.4 KB0.0 KB29.4 KB0.0 KB/s2.4 KB23:59:53
12news.uzoreto.com22.5 KB421.5 KB444.0 KB0.0 KB/s3.0 KB23:59:13
13erje20.3 KB70.1 KB90.4 KB0.0 KB/s2.4 KB23:59:51
14xmission9.2 KB4.0 KB13.1 KB0.0 KB/s2.6 KB23:59:07
15weretis.net4.5 KB6.2 KB10.7 KB0.0 KB/s1.8 KB23:59:52
16news.mixmin.net2.5 KB0.0 KB2.5 KB0.0 KB/s2.5 KB23:59:54
17news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:44:20
18news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:19:44
19eternal-september0.0 KB11.2 KB11.2 KB0.0 KB/s3.7 KB23:59:44
TOTAL: 1923.8 MB895.3 KB24.7 MB0.0 KB/s8.1 KB452:00:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1c-73-36-53-32.hsd1.il.comcast.net 1 1038.0 KB 2 0 000:15:07
269.160.37.57 1 69.8 KB 1 0 000:01:57
371-90-73-253.dhcp.ftbg.wi.charter.com 10 510.8 KB 3 0 004:32:31
4a131033.upc-a.chello.nl 11 36.2 KB 3 0 001:45:04
571-13-20-234.dhcp.dlth.mn.charter.com 1 12.7 KB 1 0 000:26:07
TOTAL: 5 24 2567.3 KB 10 0 009:15:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.hsd1.il.comcast.net 1 1038.0 KB 2 0 000:15:07
2unresolved 4 69.8 KB 1 0 000:02:01
3*.dhcp.ftbg.wi.charter.com 10 510.8 KB 3 0 004:32:31
4*.upc-a.chello.nl 11 36.2 KB 3 0 001:45:04
5*.dhcp.dlth.mn.charter.com 1 12.7 KB 1 0 000:26:07
6*.census.shodan.io 2 00.0 KB 0 0 000:00:02
7*.res.spectrum.com 2 00.0 KB 0 0 000:14:25
8*.ip-51-68-180.eu 7 00.0 KB 0 0 000:00:08
9*.ph.ph.cox.net 4 00.0 KB 0 0 002:00:12
TOTAL: 9 42 2567.3 KB 10 0 009:15:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
71-90-73-253.dhcp.ftbg.wi.charter.com 0.690 0.218 0.00004:32:31
ip72-222-200-117.ph.ph.cox.net 0.393 0.094 0.00002:00:12
a131033.upc-a.chello.nl 0.852 0.151 0.00001:45:04
71-13-20-234.dhcp.dlth.mn.charter.com 0.100 0.018 0.00000:26:07
c-73-36-53-32.hsd1.il.comcast.net 0.104 0.017 0.00000:15:07
172-221-041-102.res.spectrum.com 0.165 0.252 0.00000:14:25
69.160.37.57 0.427 1.086 0.00000:01:57
ns3121859.ip-51-68-180.eu 0.444 0.094 0.00000:00:08
hat.census.shodan.io 0.059 0.017 0.00000:00:01
94.165.96.58 0.072 0.008 0.00000:00:01
94.165.58.250 0.075 0.000 0.00000:00:01
94.166.91.15 0.060 0.017 0.00000:00:01
dojo.census.shodan.io 0.061 0.015 0.00000:00:00
TOTAL: 13 3.502 1.987 0.00009:15:42

Curious NNRP server explorers [Top 20]:

SystemConn
ns3121859.ip-51-68-180.eu 7
ip72-222-200-117.ph.ph.cox.net 4
172-221-041-102.res.spectrum.com 2
hat.census.shodan.io 1
94.165.58.250 1
94.166.91.15 1
94.165.96.58 1
dojo.census.shodan.io 1
TOTAL: 8 18

NNRP client timeouts [Top 20]:

SystemConnPeer
71-90-73-253.dhcp.ftbg.wi.charter.com 7 0
ip72-222-200-117.ph.ph.cox.net 4 0
TOTAL: 2 11 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 24 96.0%
2muc 1 4.0%
TOTAL: 2 25100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 15
2comp.databases.ibm-db2 9
3muc.lists.freebsd.questions 1
TOTAL: 3 25