Daily Usenet report for csiph.com

Oct 10 04:15:00 -- Oct 11 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 10 13:11:39 csiph nnrpd[56730]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Oct 10 13:11:39 csiph nnrpd[56730]: 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 17749 47.2%4.6 MB 62.4%
innd 15318 40.8%2.0 MB 27.4%
innfeed 3488 9.3%649.5 KB 8.7%
nnrpd 983 2.6%108.8 KB 1.5%
nocem 31 0.1%3.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 37570 100.0%7.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 285857 56.1%
Negative hits 203331 39.9%
Do not exist 17014 3.3%
Cache misses 3045 0.6%
TOTAL: 4 509247 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.864 0.0%19 1.000 45.474 59.000
article cleanup00:00:00.121 0.0%16746 0.000 0.007 0.034
article logging00:00:00.295 0.0%17321 0.000 0.017 0.317
article parse00:00:01.189 0.0%52323 0.000 0.023 0.568
article write00:00:13.661 0.0%14522 0.141 0.941 42.451
artlog/artcncl00:00:00.002 0.0%19 0.000 0.105 0.200
artlog/artparse00:00:00.017 0.0%390 0.000 0.044 2.167
data move00:00:00.144 0.0%484016 0.000 0.000 0.002
hisgrep/artcncl00:00:00.109 0.0%18 0.000 6.056 7.800
hishave/artcncl00:00:00.105 0.0%19 0.000 5.526 9.200
hishave/artparse00:00:00.001 0.0%369 0.000 0.003 0.033
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.701 0.0%511838 0.001 0.027 0.238
history sync00:00:00.837 0.0%375 0.000 2.232 10.333
history write00:00:17.818 0.0%16763 0.033 1.063 10.204
hiswrite/artcncl00:00:00.030 0.0%1 30.000 30.000 30.000
hiswrite/artparse00:00:00.692 0.0%369 0.000 1.875 22.062
idle23:57:58.258 99.8%490028 84.393 176.068 496.540
nntp read00:00:01.971 0.0%492007 0.001 0.004 0.008
overview write00:01:17.189 0.1%14522 0.111 5.315 340.068
perl filter00:00:24.391 0.0%16742 1.148 1.457 2.294
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.211 0.0%29074 0.000 0.007 0.032
TOTAL: 24:01:06.08524:00:31.606100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.042 0.0%24226 0.000 0.002 0.049
article prepare00:00:00.002 0.0%15628 0.000 0.000 0.011
article read00:00:00.404 0.0%1970 0.000 0.205 36.333
backlog stats00:00:00.170 0.0%326309 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.132 0.0%254994 0.001 0.004 0.010
data write00:00:01.472 0.0%241597 0.001 0.006 0.012
idle23:54:37.268100.0%326309 91.487 263.791 726.412
status file00:00:00.188 0.0%271 0.000 0.694 2.000
TOTAL: 23:54:46.82623:54:40.678100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle50:19:55.918 99.9%639 42.000283561.687418558.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.008 0.0%1459 0.000 0.005 0.167
readart00:00:00.212 0.0%24 0.000 8.833 52.000
TOTAL: 50:23:55.27250:19:56.138 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeeds.xmission.com 2 13054 2992 10019 43 22%23:59:27
2csiph-out.news.xs4all.nl 591 16245 2539 12172 1534 15%67:11:46
3feeder.eternal-september.org 2 15475 1781 13632 62 11%23:15:10
4news-out.mixmin.net 3 14881 1752 12950 179 11%24:08:19
5news-out.aioe.org 3 13524 1693 11730 101 12%24:09:27
6csiph-out.feeder.erje.net 1440 71076 1017 69916 143 1%118:46:44
7newsfeed.fu-berlin.de 4 14059 847 13198 14 6%24:32:40
8csiph-out.news.weretis.net 3 30930 841 29999 90 2%53:27:33
9newsfeed.neva.ru 146 13345 414 12735 196 3%72:23:23
10news-out.neodome.net 1 15592 187 15403 2 1%23:59:54
11nntp.pasdenom.info 2 8498 155 8333 10 1%23:58:47
12csiph-out.feed.uzoreto.com 864 22938 121 22638 179 0%71:11:47
13news.fcku.it 15 1096 97 998 1 8%21:39:01
14csiph-out.news.tnetconsulting.net 5 23367 60 23299 8 0%23:26:53
15news.swapon.de 2 1298 46 1251 1 3%23:18:14
16news.freedyn.net 2 16952 25 16888 39 0%23:59:42
17news.samoylyk.net 2 13593 4 13589 0 0%23:59:52
18news.bbs.nz 2 14247 3 14244 0 0%23:59:48
19localhost 29 3 3 0 0 100%00:00:04
20xanadu-bbs.net 27 328 0 328 0 0%19:25:24
TOTAL: 20 3145 320501 14577 303322 2602 4%710:53:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com8.7 MB0.0 KB2.2 MB10.8 MB 80%3.7 KB
2csiph-out.feeder.erje.net8.4 MB0.0 KB2.4 MB10.8 MB 78%9.5 KB
3csiph-out.news.xs4all.nl6.3 MB0.0 KB14.4 MB20.7 MB 30%5.2 KB
4feeder.eternal-september.org4.9 MB1.4 KB585.9 KB5.4 MB 89%3.0 KB
5news-out.aioe.org4.6 MB1.4 KB340.7 KB5.0 MB 93%2.8 KB
6news-out.mixmin.net3.8 MB1.3 KB335.6 KB4.2 MB 92%2.2 KB
7csiph-out.news.weretis.net2.1 MB0.0 KB815.9 KB2.9 MB 72%3.2 KB
8newsfeed.fu-berlin.de1.9 MB0.0 KB47.0 KB2.0 MB 97%2.4 KB
9newsfeed.neva.ru1.2 MB1.5 KB515.5 KB1.7 MB 69%2.8 KB
10csiph-out.feed.uzoreto.com417.0 KB0.0 KB7.1 MB7.5 MB 5%25.6 KB
11news-out.neodome.net409.9 KB0.0 KB2.6 KB412.5 KB 99%2.2 KB
12nntp.pasdenom.info353.2 KB0.0 KB12.8 KB366.0 KB 96%2.2 KB
13csiph-out.news.tnetconsulting.net182.9 KB0.0 KB105.0 KB287.9 KB 63%4.2 KB
14news.fcku.it161.0 KB0.0 KB2.0 KB163.0 KB 98%1.7 KB
15news.freedyn.net152.3 KB0.0 KB557.3 KB709.6 KB 21%11.1 KB
16news.swapon.de110.3 KB0.0 KB80.3 KB190.6 KB 57%4.1 KB
17news.samoylyk.net47.7 KB0.0 KB0.0 KB47.7 KB100%11.9 KB
18news.bbs.nz11.8 KB0.0 KB0.0 KB11.8 KB100%3.9 KB
19localhost3.4 KB0.0 KB0.0 KB3.4 KB100%1.1 KB
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2043.7 MB5.7 KB29.4 MB73.1 MB 59%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 04:15:00 - 04:59:59 278 1.9% 0.10854.2 KB 1.9% 0.32
Oct 10 05:00:00 - 05:59:59 320 2.2% 0.09901.4 KB 2.0% 0.25
Oct 10 06:00:00 - 06:59:59 479 3.3% 0.132.4 MB 5.5% 0.68
Oct 10 07:00:00 - 07:59:59 705 4.9% 0.203.4 MB 7.7% 0.95
Oct 10 08:00:00 - 08:59:59 642 4.4% 0.182.3 MB 5.2% 0.64
Oct 10 09:00:00 - 09:59:59 780 5.4% 0.222.0 MB 4.5% 0.56
Oct 10 10:00:00 - 10:59:59 752 5.2% 0.211.8 MB 4.1% 0.51
Oct 10 11:00:00 - 11:59:59 783 5.4% 0.222.0 MB 4.6% 0.58
Oct 10 12:00:00 - 12:59:59 636 4.4% 0.181.7 MB 3.8% 0.48
Oct 10 13:00:00 - 13:59:59 870 6.0% 0.242.3 MB 5.4% 0.67
Oct 10 14:00:00 - 14:59:59 802 5.5% 0.222.2 MB 5.0% 0.63
Oct 10 15:00:00 - 15:59:59 918 6.3% 0.263.5 MB 8.0% 0.99
Oct 10 16:00:00 - 16:59:59 859 5.9% 0.242.5 MB 5.8% 0.72
Oct 10 17:00:00 - 17:59:59 817 5.6% 0.232.2 MB 5.1% 0.64
Oct 10 18:00:00 - 18:59:59 687 4.7% 0.191.7 MB 3.9% 0.48
Oct 10 19:00:00 - 19:59:59 642 4.4% 0.181.6 MB 3.6% 0.45
Oct 10 20:00:00 - 20:59:59 711 4.9% 0.202.1 MB 4.7% 0.59
Oct 10 21:00:00 - 21:59:59 671 4.6% 0.191.9 MB 4.4% 0.55
Oct 10 22:00:00 - 22:59:59 499 3.4% 0.141.4 MB 3.1% 0.39
Oct 10 23:00:00 - 23:59:59 364 2.5% 0.101012.3 KB 2.3% 0.28
Oct 11 00:00:00 - 00:59:59 284 2.0% 0.08857.5 KB 1.9% 0.24
Oct 11 01:00:00 - 01:59:59 333 2.3% 0.091.1 MB 2.6% 0.32
Oct 11 02:00:00 - 02:59:59 268 1.8% 0.07658.6 KB 1.5% 0.18
Oct 11 03:00:00 - 03:59:59 334 2.3% 0.091.2 MB 2.7% 0.34
Oct 11 04:00:00 - 04:15:00 101 0.7% 0.11259.9 KB 0.6% 0.29
TOTAL: 24:00:00 14535 100.0% 0.1743.7 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1588 82 0 0 1 0 0 0 1505
2newsfeed.fu-berlin.de 410 12 0 0 0 0 0 0 398
3news-out.mixmin.net 238 14 0 1 0 0 0 0 223
4newsfeed.neva.ru 196 60 0 1 0 0 0 0 135
5csiph-out.feed.uzoreto.com 179 7 0 0 0 0 0 0 172
6news-out.aioe.org 154 90 0 1 0 0 0 0 63
7csiph-out.feeder.erje.net 129 40 0 0 0 0 0 0 89
8csiph-out.news.weretis.net 104 39 0 0 0 0 0 0 65
9feeder.eternal-september.org 63 35 0 1 0 0 0 0 27
10newsfeeds.xmission.com 52 5 0 0 0 0 0 0 47
11news.freedyn.net 39 0 0 0 0 0 0 0 39
12news.swapon.de 15 0 0 0 0 0 0 0 15
13csiph-out.news.tnetconsulting.net 13 12 0 0 0 0 0 0 1
14nntp.pasdenom.info 10 0 0 0 0 0 0 0 10
15news-out.neodome.net 4 0 0 0 0 0 0 0 4
16news.fcku.it 1 1 0 0 0 0 0 0 0
TOTAL: 16 3195 397 0 4 1 0 0 0 2793

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 59
alt.bbs.synchronet 52
alt.computer.workshop 47
alt.windows7.general 27
alt.politics 18
mozilla.support.thunderbird 15
alt.binaries.pictures.purebeauty 15
free.it.religioni.scientology 11
scinet.stats 10
spline.eisfair 10
alt.survival 9
alt.job 9
at.jobs 8
alt.philosophy 8
mozilla.support.seamonkey 7
aus.jobs 7
alt.religion 6
alt.hack.nl 6
lada.movies 5
att.jobs 5
TOTAL: 54 397

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

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1483
EMP (phl) 167
Too many newsgroups 89
0 38
HTML Multipart 19
EMP (phn path) 10
Scoring filter 10
Binary: misplaced binary 4
EMP (phn nph) 2
Too many newsgroups (low_xpost) 2
HTML post 1
TOTAL: 11 1825

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 50
csiph-out.feed.uzoreto.com 1
csiph-out.news.xs4all.nl 1
TOTAL: 3 52
Huge articles
csiph-out.news.xs4all.nl 164
csiph-out.feed.uzoreto.com 97
newsfeeds.xmission.com 44
csiph-out.feeder.erje.net 44
news.freedyn.net 9
feeder.eternal-september.org 8
csiph-out.news.weretis.net 6
news.swapon.de 1
TOTAL: 8 373
Including strange strings
newsfeed.fu-berlin.de 396
news-out.mixmin.net 59
news-out.aioe.org 48
csiph-out.news.xs4all.nl 44
news.swapon.de 14
csiph-out.news.weretis.net 5
newsfeeds.xmission.com 3
news-out.neodome.net 2
feeder.eternal-september.org 2
csiph-out.feeder.erje.net 2
TOTAL: 11 576
No colon-space in header
csiph-out.news.xs4all.nl 20
csiph-out.feeder.erje.net 1
TOTAL: 2 21
TOTAL: 4 1022

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 17149 1729 12762 10 0 1 10%23:59:56
2fu-berlin.de 13496 688 12808 0 0 0 5%23:59:55
3news.samoylyk.net 14839 671 13852 7 0 1 4%23:59:53
4news.bbs.nz 26994 315 13479 30 0 1 1%23:59:54
5neva.ru 13422 87 13125 39 0 0 0%23:58:58
6news.freedyn.net 14303 83 13982 0 0 0 0%23:59:55
7tnet 14203 52 13781 0 0 9728 0%23:59:56
8newsfeed.xs4all.nl 12274 34 11821 0 0 0 0%23:59:55
9xmission 13525 22 10692 10 0 0 0%23:59:54
10news.mixmin.net 12071 10 11850 0 0 0 0%23:59:55
11usenet.pasdenom.info 14097 9 13666 1 0 6 0%23:59:55
12neodome.net 14698 8 14316 0 0 0 0%23:59:45
13erje 13429 5 13184 69 0 0 0%23:59:55
14news.uzoreto.com 13503 5 13306 8 0 0 0%23:59:51
15aioe 9909 5 9591 0 0 0 0%23:59:47
16eternal-september 12148 5 11926 0 0 0 0%23:59:55
17weretis.net 13038 5 12857 0 0 0 0%23:59:55
18news.swapon.de 1272 4 1257 0 0 0 0%23:49:48
19news.fcku.it 952 0 952 0 0 0 0%21:08:06
TOTAL: 19 245322 3737 219207 174 0 9737 1%452:55:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs10.4 MB40.6 KB10.5 MB0.1 KB/s6.2 KB23:59:56
2fu-berlin.de7.6 MB0.0 KB7.6 MB0.1 KB/s11.3 KB23:59:55
3news.samoylyk.net7.5 MB55.3 KB7.6 MB0.1 KB/s11.4 KB23:59:53
4news.freedyn.net1.3 MB0.0 KB1.3 MB0.0 KB/s16.1 KB23:59:55
5news.bbs.nz796.5 KB67.1 KB863.5 KB0.0 KB/s2.5 KB23:59:54
6neva.ru164.7 KB86.0 KB250.7 KB0.0 KB/s2.0 KB23:58:58
7tnet110.2 KB0.0 KB110.2 KB0.0 KB/s2.1 KB23:59:56
8newsfeed.xs4all.nl102.4 KB0.0 KB102.4 KB0.0 KB/s3.0 KB23:59:55
9xmission84.1 KB21.8 KB106.0 KB0.0 KB/s3.3 KB23:59:54
10news.mixmin.net45.8 KB0.0 KB45.8 KB0.0 KB/s4.6 KB23:59:55
11weretis.net14.0 KB0.0 KB14.0 KB0.0 KB/s2.8 KB23:59:55
12neodome.net12.6 KB0.0 KB12.6 KB0.0 KB/s1.6 KB23:59:45
13usenet.pasdenom.info9.9 KB2.2 KB12.2 KB0.0 KB/s1.2 KB23:59:55
14eternal-september8.3 KB0.0 KB8.3 KB0.0 KB/s1.7 KB23:59:55
15erje8.2 KB173.9 KB182.1 KB0.0 KB/s2.5 KB23:59:55
16aioe6.8 KB0.0 KB6.8 KB0.0 KB/s1.4 KB23:59:47
17news.swapon.de5.3 KB0.0 KB5.3 KB0.0 KB/s1.3 KB23:49:48
18news.uzoreto.com5.0 KB76.4 KB81.4 KB0.0 KB/s6.3 KB23:59:51
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:08:06
TOTAL: 1928.2 MB523.4 KB28.7 MB0.0 KB/s7.5 KB452:55:08
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1024-178-046-028.res.spectrum.com 9 1629.6 KB 7 3 301:43:22
2a131033.upc-a.chello.nl 73 812.2 KB 3 0 023:30:26
TOTAL: 2 82 2441.8 KB 10 3 350:23:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 9 1629.6 KB 7 3 301:43:22
2*.upc-a.chello.nl 73 812.2 KB 3 0 023:30:26
3*.net.upcbroadband.cz 13 00.0 KB 0 0 004:15:50
4*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
5*.ph.ph.cox.net 4 00.0 KB 0 0 002:00:14
6unresolved 58 00.0 KB 0 0 018:53:58
TOTAL: 6 159 2441.8 KB 10 3 350:23:54

NNRP auth users [Top 20]:

UserConn
ohlandl 3
TOTAL: 1 3

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
a131033.upc-a.chello.nl 4.929 1.016 0.00023:30:26
91.187.33.87 3.921 0.837 0.00018:53:48
ip-78-102-198-192.net.upcbroadband.cz 0.848 0.243 0.00004:15:50
ip72-222-200-117.ph.ph.cox.net 0.422 0.080 0.00002:00:14
024-178-046-028.res.spectrum.com 0.884 0.169 0.02101:43:22
192.241.217.150 0.048 0.032 0.00000:00:09
scanner-04.ch1.censys-scanner.com 0.131 0.026 0.00000:00:00
TOTAL: 7 11.183 2.403 0.02150:23:54

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 57
ip-78-102-198-192.net.upcbroadband.cz 13
ip72-222-200-117.ph.ph.cox.net 4
scanner-04.ch1.censys-scanner.com 2
192.241.217.150 1
TOTAL: 5 77

NNRP unrecognized commands (by host):

SystemConn
scanner-04.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
ip72-222-200-117.ph.ph.cox.net 4 0
024-178-046-028.res.spectrum.com 3 2
TOTAL: 2 7 3

Newsgroup request counts (by category):

CategoryCountPct
1comp 24100.0%
TOTAL: 1 24100.0%

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

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