Daily Usenet report for csiph.com

Jan 12 04:15:00 -- Jan 13 04:15:00

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jan 12 10:42:59 csiph nnrpd[43877]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 12 10:42:59 csiph nnrpd[43877]: 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 12 15:06:23 csiph nnrpd[58268]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 12 15:06:23 csiph nnrpd[58268]: 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 21170 51.1%5.3 MB 65.9%
innd 14510 35.0%1.9 MB 23.4%
innfeed 3591 8.7%655.8 KB 8.0%
nnrpd 2121 5.1%223.7 KB 2.7%
nocem 13 0.0%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 41406 100.0%8.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 323566 54.2%
Negative hits 252844 42.3%
Do not exist 20560 3.4%
Cache misses 398 0.1%
TOTAL: 4 597368 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.684 0.0%35 0.000 19.543 44.333
article cleanup00:00:00.118 0.0%19931 0.000 0.006 0.034
article logging00:00:00.518 0.0%20464 0.000 0.025 1.024
article parse00:00:01.900 0.0%73930 0.000 0.026 0.165
article write00:00:45.337 0.1%16456 0.169 2.755 89.605
artlog/artcncl00:00:00.003 0.0%35 0.000 0.086 1.000
artlog/artparse00:00:00.008 0.0%689 0.000 0.012 0.500
data move00:00:00.251 0.0%576051 0.000 0.000 0.003
hisgrep/artcncl00:00:00.040 0.0%35 0.000 1.143 9.333
hishave/artcncl00:00:00.015 0.0%35 0.000 0.429 6.500
hishave/artparse00:00:00.000 0.0%678 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:27.410 0.0%598611 0.000 0.046 0.622
history sync00:00:01.390 0.0%376 0.000 3.697 50.500
history write00:00:37.083 0.0%19931 0.685 1.861 12.855
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:01.156 0.0%678 0.000 1.705 8.200
idle23:55:36.198 99.6%572440 80.033 150.472 452.302
nntp read00:00:02.511 0.0%578295 0.001 0.004 0.095
overview write00:02:20.792 0.2%16456 0.195 8.556 920.062
perl filter00:00:29.061 0.0%19920 1.110 1.459 2.133
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.281 0.0%32925 0.000 0.009 0.038
TOTAL: 24:01:02.44924:00:24.756100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.039 0.0%16526 0.000 0.002 0.025
article prepare00:00:00.001 0.0%11556 0.000 0.000 0.006
article read00:00:00.357 0.0%1318 0.000 0.271 10.750
backlog stats00:00:00.247 0.0%361371 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.424 0.0%283965 0.001 0.005 0.010
data write00:00:01.702 0.0%270449 0.001 0.006 0.017
idle23:55:07.951100.0%361371 137.385 238.281 691.592
status file00:00:00.312 0.0%311 0.000 1.003 58.000
TOTAL: 23:55:18.73223:55:12.033100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle56:36:56.395 99.5%1141 3.667178629.619600163.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.935 0.0%48082 0.000 0.061 0.167
readart00:00:00.000 0.0%1 0.000 0.000 0.000
TOTAL: 56:53:26.47956:36:59.330 99.5%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 131
pause 3
paused 2
reload 2
reserve 2
TOTAL: 10 152

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 0 9405 4311 3230 1864 45%72:52:33
2newsfeeds.xmission.com 3 15516 3008 12484 24 19%23:46:01
3feeder.eternal-september.org 45 6774 2559 4102 113 37%39:56:45
4news-out.mixmin.net 3 17907 1753 15818 336 9%24:08:45
5newsfeed.fu-berlin.de 19 16488 910 15024 554 5%25:21:31
6csiph-out.feeder.erje.net 1439 82862 835 81407 620 1%118:46:12
7newsfeed.neva.ru 146 18283 713 17361 209 3%71:34:23
8csiph-out.news.weretis.net 4 21259 709 20368 182 3%32:45:03
9news.fcku.it 13 1870 348 1515 7 18%22:31:20
10news-out.aioe.org 1 15889 306 15520 63 1%23:59:57
11news-out.neodome.net 1 18663 300 18330 33 1%23:59:55
12csiph-out.feed.uzoreto.com 864 26256 295 25678 283 1%71:16:55
13nntp.pasdenom.info 2 11265 188 11069 8 1%23:59:35
14news.swapon.de 3 1690 51 1639 0 3%24:43:45
15csiph-out.news.tnetconsulting.net 1 17372 45 17277 50 0%23:59:54
16news.freedyn.net 1 19312 13 19178 121 0%23:59:56
17news.samoylyk.net 2 16002 8 15990 4 0%23:59:04
18news.bbs.nz 1 16903 8 16895 0 0%23:59:53
19localhost 27 1 1 0 0 100%00:00:03
20xanadu-bbs.net 21 685 0 683 2 0%23:55:18
TOTAL: 20 2596 334402 16361 313568 4473 4%719:36:48
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl11.3 MB0.0 KB16.7 MB28.0 MB 40%4.6 KB
2newsfeeds.xmission.com8.9 MB27.3 KB838.0 KB9.7 MB 91%3.3 KB
3feeder.eternal-september.org6.6 MB0.0 KB737.6 KB7.3 MB 90%2.8 KB
4csiph-out.feeder.erje.net6.4 MB5.4 KB11.0 MB17.5 MB 36%12.3 KB
5news-out.mixmin.net4.3 MB29.2 KB2.1 MB6.4 MB 67%3.1 KB
6newsfeed.fu-berlin.de2.0 MB0.0 KB11.3 MB13.3 MB 15%9.3 KB
7newsfeed.neva.ru1.9 MB0.0 KB680.3 KB2.6 MB 74%2.9 KB
8csiph-out.news.weretis.net1.8 MB2.4 KB1.7 MB3.6 MB 51%4.1 KB
9news-out.aioe.org1.3 MB0.0 KB115.2 KB1.4 MB 91%3.8 KB
10csiph-out.feed.uzoreto.com1.1 MB0.0 KB8.9 MB10.1 MB 11%17.9 KB
11news-out.neodome.net862.1 KB27.3 KB1.6 MB2.5 MB 33%7.7 KB
12news.fcku.it547.7 KB0.0 KB11.3 KB558.9 KB 97%1.6 KB
13nntp.pasdenom.info406.3 KB0.0 KB11.4 KB417.7 KB 97%2.1 KB
14csiph-out.news.tnetconsulting.net148.5 KB0.0 KB2.7 MB2.8 MB 5%30.5 KB
15news.swapon.de123.5 KB0.0 KB0.0 KB123.5 KB100%2.4 KB
16news.freedyn.net58.7 KB27.3 KB6.2 MB6.3 MB 0%48.3 KB
17news.samoylyk.net25.6 KB27.2 KB215.9 KB268.7 KB 9%22.4 KB
18news.bbs.nz16.1 KB0.0 KB0.0 KB16.1 KB100%2.0 KB
19localhost1.8 KB0.0 KB0.0 KB1.8 KB100%1.8 KB
20xanadu-bbs.net0.0 KB0.0 KB6.6 KB6.6 KB 0%3.3 KB
TOTAL: 2047.9 MB146.0 KB64.9 MB112.9 MB 42%5.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 12 04:15:00 - 04:59:59 238 1.4% 0.09708.4 KB 1.4% 0.26
Jan 12 05:00:00 - 05:59:59 385 2.3% 0.112.3 MB 4.7% 0.65
Jan 12 06:00:00 - 06:59:59 361 2.2% 0.101.2 MB 2.5% 0.35
Jan 12 07:00:00 - 07:59:59 526 3.2% 0.151.3 MB 2.7% 0.37
Jan 12 08:00:00 - 08:59:59 665 4.0% 0.181.7 MB 3.4% 0.47
Jan 12 09:00:00 - 09:59:59 759 4.6% 0.212.4 MB 4.9% 0.67
Jan 12 10:00:00 - 10:59:59 764 4.6% 0.211.9 MB 3.9% 0.54
Jan 12 11:00:00 - 11:59:59 780 4.7% 0.222.0 MB 4.0% 0.56
Jan 12 12:00:00 - 12:59:59 808 4.9% 0.222.0 MB 4.2% 0.58
Jan 12 13:00:00 - 13:59:59 765 4.7% 0.211.9 MB 3.9% 0.53
Jan 12 14:00:00 - 14:59:59 854 5.2% 0.242.3 MB 4.7% 0.65
Jan 12 15:00:00 - 15:59:59 1035 6.3% 0.293.5 MB 7.2% 0.99
Jan 12 16:00:00 - 16:59:59 1009 6.1% 0.282.7 MB 5.6% 0.77
Jan 12 17:00:00 - 17:59:59 1019 6.2% 0.283.1 MB 6.5% 0.89
Jan 12 18:00:00 - 18:59:59 1057 6.4% 0.292.8 MB 5.8% 0.80
Jan 12 19:00:00 - 19:59:59 967 5.9% 0.273.0 MB 6.3% 0.86
Jan 12 20:00:00 - 20:59:59 859 5.2% 0.242.5 MB 5.3% 0.72
Jan 12 21:00:00 - 21:59:59 805 4.9% 0.222.3 MB 4.8% 0.66
Jan 12 22:00:00 - 22:59:59 699 4.2% 0.192.3 MB 4.8% 0.67
Jan 12 23:00:00 - 23:59:59 534 3.2% 0.151.5 MB 3.1% 0.43
Jan 13 00:00:00 - 00:59:59 470 2.9% 0.131.6 MB 3.3% 0.45
Jan 13 01:00:00 - 01:59:59 286 1.7% 0.08946.7 KB 1.9% 0.26
Jan 13 02:00:00 - 02:59:59 294 1.8% 0.08944.8 KB 1.9% 0.26
Jan 13 03:00:00 - 03:59:59 425 2.6% 0.121.2 MB 2.5% 0.34
Jan 13 04:00:00 - 04:15:00 85 0.5% 0.09374.7 KB 0.8% 0.42
TOTAL: 24:00:00 16449 100.0% 0.1948.4 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1818 121 0 0 1 0 0 0 1696
2newsfeed.fu-berlin.de 983 44 0 0 0 0 0 0 939
3csiph-out.feeder.erje.net 394 78 0 3 0 0 0 0 313
4news-out.mixmin.net 328 11 0 2 0 0 0 0 315
5csiph-out.feed.uzoreto.com 286 18 0 0 0 0 0 0 268
6csiph-out.news.weretis.net 239 108 0 1 0 0 0 0 130
7newsfeed.neva.ru 221 85 0 0 0 0 0 0 136
8feeder.eternal-september.org 114 82 0 0 0 0 0 0 32
9news.freedyn.net 100 0 0 1 0 0 0 0 99
10news-out.aioe.org 60 48 0 0 0 0 0 0 12
11newsfeeds.xmission.com 36 12 0 1 0 0 0 0 23
12news-out.neodome.net 35 2 0 1 0 0 0 0 32
13news.swapon.de 27 0 0 0 0 0 0 0 27
14csiph-out.news.tnetconsulting.net 24 5 0 1 0 0 0 0 18
15nntp.pasdenom.info 8 5 0 0 0 0 0 0 3
16news.fcku.it 7 6 0 0 0 0 0 0 1
17news.samoylyk.net 4 0 0 1 0 0 0 0 3
18xanadu-bbs.net 2 0 0 0 0 0 0 0 2
TOTAL: 18 4686 625 0 11 1 0 0 0 4049

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 142
lada.talk 57
alt.binaries.pictures.purebeauty 45
scinet.sysop 36
alt.politics 33
spline.eisfair 31
scinet.stats 27
fr.misc.automobile.electrique 24
mozilla.support.seamonkey 18
alt.survival 16
lada.auto 15
mozilla.general 13
scinet.general.chatter 13
alt.bbs.synchronet 13
oesterreich.tratsch 11
it-alt.sport.calcio.juventus 9
alt.job 9
at.jobs 8
scinet.bbs.software 8
alt.politics.usa 7
TOTAL: 71 625

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

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1682
EMP (phn path) 374
Binary: misplaced binary 222
EMP (phn nph) 184
Binary Payload 126
Too many newsgroups 99
EMP (phl) 82
0 32
HTML Multipart 12
Scoring filter 11
Too many newsgroups (meow) 3
HTML post 2
TOTAL: 12 2829

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 55
csiph-out.feed.uzoreto.com 3
csiph-out.news.xs4all.nl 2
TOTAL: 3 60
Huge articles
csiph-out.news.xs4all.nl 178
csiph-out.feeder.erje.net 159
newsfeed.fu-berlin.de 116
csiph-out.feed.uzoreto.com 95
news.freedyn.net 57
news-out.neodome.net 27
csiph-out.news.tnetconsulting.net 15
newsfeeds.xmission.com 11
csiph-out.news.weretis.net 10
news-out.mixmin.net 4
TOTAL: 12 679
Including strange strings
newsfeed.fu-berlin.de 425
news.swapon.de 27
csiph-out.news.xs4all.nl 26
newsfeed.neva.ru 12
newsfeeds.xmission.com 12
news-out.mixmin.net 10
csiph-out.news.weretis.net 10
csiph-out.feeder.erje.net 3
csiph-out.feed.uzoreto.com 3
feeder.eternal-september.org 2
TOTAL: 11 531
No colon-space in header
csiph-out.news.xs4all.nl 6
csiph-out.feeder.erje.net 4
TOTAL: 2 10
TOTAL: 4 1280

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 19370 808 15640 1 0 0 4%23:59:47
2fu-berlin.de 15213 530 14683 0 0 0 3%23:50:07
3news.samoylyk.net 16932 519 15869 8 0 0 3%23:50:07
4news.bbs.nz 30891 376 15505 19 0 0 1%23:57:50
5neva.ru 14967 144 14563 75 0 0 0%23:50:07
6xmission 15440 59 12745 9 0 0 0%23:50:07
7tnet 17114 53 15821 0 0 0 0%23:50:07
8newsfeed.xs4all.nl 12620 42 11940 3 0 96 0%23:54:27
9news.uzoreto.com 15621 21 15249 46 0 0 0%23:50:07
10usenet.pasdenom.info 16221 17 15675 36 0 0 0%23:59:43
11erje 15960 15 15289 22 0 0 0%23:50:07
12news.mixmin.net 14357 13 13904 1 0 0 0%23:53:24
13neodome.net 16518 11 15959 0 0 0 0%23:50:07
14news.freedyn.net 15005 10 14574 29 0 0 0%23:54:27
15weretis.net 15322 10 15003 1 0 0 0%23:50:07
16aioe 13897 8 13339 0 0 0 0%23:56:30
17news.swapon.de 1747 1 1713 0 0 0 0%23:50:46
18eternal-september 0 0 0 0 0 13185 0%23:50:07
19news.fcku.it 1461 0 1453 0 0 0 0%22:07:54
TOTAL: 19 268656 2637 238924 250 0 13281 0%451:55:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.1 MB19.6 KB6.2 MB0.1 KB/s7.8 KB23:59:47
2fu-berlin.de5.5 MB0.0 KB5.5 MB0.1 KB/s10.7 KB23:50:07
3news.samoylyk.net5.4 MB58.1 KB5.5 MB0.1 KB/s10.7 KB23:50:07
4news.bbs.nz912.1 KB70.7 KB982.9 KB0.0 KB/s2.5 KB23:57:50
5neva.ru283.6 KB143.9 KB427.6 KB0.0 KB/s2.0 KB23:50:07
6xmission132.4 KB15.5 KB147.9 KB0.0 KB/s2.2 KB23:50:07
7tnet111.0 KB0.0 KB111.0 KB0.0 KB/s2.1 KB23:50:07
8newsfeed.xs4all.nl102.1 KB7.9 KB110.0 KB0.0 KB/s2.4 KB23:54:27
9usenet.pasdenom.info33.9 KB59.1 KB92.9 KB0.0 KB/s1.8 KB23:59:43
10news.uzoreto.com32.5 KB117.5 KB150.0 KB0.0 KB/s2.2 KB23:50:07
11erje26.7 KB102.0 KB128.7 KB0.0 KB/s3.5 KB23:50:07
12neodome.net26.6 KB0.0 KB26.6 KB0.0 KB/s2.4 KB23:50:07
13news.mixmin.net25.8 KB3.4 KB29.2 KB0.0 KB/s2.1 KB23:53:24
14news.freedyn.net23.2 KB403.6 KB426.8 KB0.0 KB/s10.9 KB23:54:27
15aioe22.9 KB0.0 KB22.9 KB0.0 KB/s2.9 KB23:56:30
16weretis.net12.3 KB3.4 KB15.7 KB0.0 KB/s1.4 KB23:50:07
17news.swapon.de1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:50:46
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:07
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:07:54
TOTAL: 1918.8 MB1004.5 KB19.8 MB0.0 KB/s7.0 KB451:55:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172.83.100.213 6 11.8 KB 1 1 102:26:01
TOTAL: 1 6 11.8 KB 1 1 156:53:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 300 11.8 KB 1 1 151:03:29
2*.upc-a.chello.nl 32 00.0 KB 0 0 005:18:05
3*.range86-138.btcentralplus.com 2 00.0 KB 0 0 000:01:39
4*.w90-20.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:05
5*.security.ipip.net 1 00.0 KB 0 0 000:00:00
6*.subs.proxad.net 1 00.0 KB 0 0 000:30:01
7*.internet-census.org 5 00.0 KB 0 0 000:00:00
TOTAL: 7 342 11.8 KB 1 1 156:53:24

NNRP auth users [Top 20]:

UserConn
kev009 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 18.253 4.287 0.00047:37:04
a131033.upc-a.chello.nl 2.050 0.345 0.00005:18:05
172.83.100.213 0.553 0.157 0.00402:26:01
208.72.53.154 0.132 0.023 0.00001:00:04
91-165-244-119.subs.proxad.net 0.066 0.008 0.00000:30:01
host86-138-214-35.range86-138.btcentralplus.com 0.113 0.051 0.00000:01:39
45.227.255.224 0.066 0.009 0.00000:00:10
192.241.207.142 0.051 0.025 0.00000:00:09
aorleans-654-1-12-115.w90-20.abo.wanadoo.fr 0.120 0.060 0.00000:00:05
sh-phx-us-gp1-wk108.internet-census.org 0.301 0.080 0.00000:00:00
scan-141.security.ipip.net 0.062 0.015 0.00000:00:00
TOTAL: 11 21.767 5.060 0.00456:53:24

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 290
a131033.upc-a.chello.nl 32
sh-phx-us-gp1-wk108.internet-census.org 5
host86-138-214-35.range86-138.btcentralplus.com 2
208.72.53.154 2
91-165-244-119.subs.proxad.net 1
192.241.207.142 1
45.227.255.224 1
scan-141.security.ipip.net 1
aorleans-654-1-12-115.w90-20.abo.wanadoo.fr 1
TOTAL: 10 336

NNRP unrecognized commands (by host):

SystemConn
sh-phx-us-gp1-wk108.internet-census.org 10
scan-141.security.ipip.net 4
TOTAL: 2 14

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 2
^V^C^A 2
Host: 69.160.37.58:119 2
^A 2
SSH-2.0-Go 1
Connection: close 1
User-Agent: HTTP Banner Detection (https... 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Accept-Encoding: gzip 1
Accept: */* 1
TOTAL: 10 14

NNRP client timeouts [Top 20]:

SystemConnPeer
172.83.100.213 4 0
208.72.53.154 2 0
91-165-244-119.subs.proxad.net 1 0
TOTAL: 3 7 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 1100.0%
TOTAL: 1 1100.0%

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

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