Daily Usenet report for csiph.com

Jan 4 04:15:00 -- Jan 5 04:15:00

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Jan 4 08:01:55 csiph nnrpd[27318]: 91.187.33.87 rejected Expiring process 20895
Jan 4 09:22:07 csiph nnrpd[31624]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 4 09:22:07 csiph nnrpd[31624]: 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 4 18:52:14 csiph nnrpd[62883]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 4 18:52:14 csiph nnrpd[62883]: 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 4 23:05:59 csiph nnrpd[76699]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Jan 4 23:05:59 csiph nnrpd[76699]: 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 20148 50.9%5.1 MB 65.7%
innd 13890 35.1%1.8 MB 23.6%
innfeed 3605 9.1%629.4 KB 8.0%
nnrpd 1878 4.7%211.3 KB 2.7%
nocem 39 0.1%4.5 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 39561 100.0%7.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 302960 50.1%
Negative hits 281630 46.6%
Do not exist 19552 3.2%
Cache misses 447 0.1%
TOTAL: 4 604589 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.485 0.0%31 0.000 15.645 48.667
article cleanup00:00:00.118 0.0%19373 0.000 0.006 0.043
article logging00:00:00.755 0.0%19909 0.000 0.038 1.100
article parse00:00:01.456 0.0%61890 0.000 0.024 0.568
article write00:01:11.276 0.1%16065 0.325 4.437 77.212
artlog/artcncl00:00:00.000 0.0%31 0.000 0.000 0.000
artlog/artparse00:00:00.003 0.0%248 0.000 0.012 0.500
data move00:00:00.183 0.0%569493 0.000 0.000 0.002
hisgrep/artcncl00:00:00.005 0.0%30 0.000 0.167 1.000
hishave/artcncl00:00:00.000 0.0%31 0.000 0.000 0.000
hishave/artparse00:00:00.000 0.0%239 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:55.350 0.1%607449 0.002 0.091 0.509
history sync00:00:01.335 0.0%368 0.000 3.628 61.333
history write00:01:16.435 0.1%19380 0.723 3.944 18.229
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.894 0.0%239 0.000 3.741 78.500
idle23:54:06.896 99.5%562573 80.848 152.952 696.168
nntp read00:00:02.279 0.0%573303 0.002 0.004 0.011
overview write00:02:11.376 0.2%16065 0.106 8.178 176.833
perl filter00:00:29.056 0.0%19371 0.889 1.500 8.640
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.259 0.0%32176 0.000 0.008 0.042
TOTAL: 24:00:55.56424:00:18.161100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%16129 0.000 0.002 0.020
article prepare00:00:00.001 0.0%15224 0.000 0.000 0.005
article read00:00:00.559 0.0%1719 0.000 0.325 27.000
backlog stats00:00:00.205 0.0%352548 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.252 0.0%276751 0.000 0.005 0.010
data write00:00:01.695 0.0%263959 0.001 0.006 0.014
idle23:54:26.807100.0%352548 135.324 244.128 984.840
status file00:00:00.540 0.0%319 0.000 1.693 38.000
TOTAL: 23:54:37.64823:54:31.088100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle44:09:36.093 99.5%992 54.000160258.158900039.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.014 0.0%2318 0.000 0.006 0.167
readart00:00:00.125 0.0%3 41.000 41.667 42.000
TOTAL: 44:22:03.54344:09:36.232 99.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.xs4all.nl 0 7724 4450 1653 1621 57%75:23:39
2feeder.eternal-september.org 12 4916 2515 2352 49 51%25:45:06
3news-out.mixmin.net 3 17246 2118 14840 288 12%24:11:57
4csiph-out.news.weretis.net 5 44633 1267 43045 321 2%61:23:40
5csiph-out.feeder.erje.net 1440 79250 1213 77686 351 1%118:47:40
6newsfeeds.xmission.com 3 13862 1062 12767 33 7%20:30:42
7newsfeed.fu-berlin.de 23 15067 898 13911 258 5%25:36:30
8newsfeed.neva.ru 137 10369 830 9184 355 8%70:46:42
9csiph-out.feed.uzoreto.com 863 26537 447 25784 306 1%71:06:39
10news-out.neodome.net 1 17353 433 16904 16 2%23:59:52
11news-out.aioe.org 2 15641 357 15213 71 2%24:09:03
12news.fcku.it 12 1601 217 1374 10 13%22:42:17
13nntp.pasdenom.info 1 10920 153 10759 8 1%23:59:54
14news.swapon.de 6 1461 43 1418 0 2%22:53:11
15news.freedyn.net 1 18955 19 18902 34 0%23:59:58
16csiph-out.news.tnetconsulting.net 1 3922 13 3907 2 0%09:20:33
17news.samoylyk.net 1 15669 5 15662 2 0%23:59:52
18news.bbs.nz 2 14501 4 14497 0 0%23:59:50
19localhost 26 0 0 0 0 0%00:00:02
20xanadu-bbs.net 26 369 0 369 0 0%20:56:05
TOTAL: 20 2565 319996 16044 300227 3725 5%713:33:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.xs4all.nl13.1 MB0.0 KB12.5 MB25.6 MB 51%4.3 KB
2feeder.eternal-september.org6.7 MB0.0 KB307.8 KB7.0 MB 95%2.8 KB
3csiph-out.feeder.erje.net5.9 MB0.0 KB2.2 MB8.1 MB 72%5.3 KB
4news-out.mixmin.net5.2 MB0.0 KB1.1 MB6.3 MB 82%2.7 KB
5csiph-out.news.weretis.net4.0 MB9.3 KB3.4 MB7.4 MB 53%4.8 KB
6newsfeeds.xmission.com3.4 MB0.0 KB2.0 MB5.4 MB 62%5.1 KB
7newsfeed.neva.ru2.4 MB0.0 KB878.4 KB3.2 MB 73%2.8 KB
8newsfeed.fu-berlin.de2.2 MB0.0 KB804.6 KB3.0 MB 73%2.6 KB
9csiph-out.feed.uzoreto.com1.6 MB0.0 KB5.3 MB6.8 MB 23%9.3 KB
10news-out.aioe.org1.6 MB0.0 KB132.6 KB1.7 MB 92%4.1 KB
11news-out.neodome.net1.4 MB17.0 KB52.1 KB1.4 MB 95%3.3 KB
12news.fcku.it373.3 KB0.0 KB15.5 KB388.8 KB 96%1.7 KB
13nntp.pasdenom.info360.4 KB0.0 KB9.3 KB369.7 KB 97%2.3 KB
14news.freedyn.net210.7 KB17.0 KB2.3 MB2.5 MB 8%48.1 KB
15news.swapon.de128.3 KB0.0 KB0.0 KB128.3 KB100%3.0 KB
16csiph-out.news.tnetconsulting.net47.5 KB0.0 KB4.6 KB52.1 KB 91%3.5 KB
17news.samoylyk.net15.0 KB0.0 KB62.7 KB77.8 KB 19%11.1 KB
18news.bbs.nz9.1 KB0.0 KB0.0 KB9.1 KB100%2.3 KB
19localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2048.5 MB43.2 KB31.0 MB79.5 MB 60%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 4 04:15:00 - 04:59:59 215 1.3% 0.08710.9 KB 1.4% 0.26
Jan 4 05:00:00 - 05:59:59 322 2.0% 0.092.0 MB 4.2% 0.57
Jan 4 06:00:00 - 06:59:59 349 2.2% 0.101.4 MB 2.8% 0.38
Jan 4 07:00:00 - 07:59:59 373 2.3% 0.101.2 MB 2.4% 0.34
Jan 4 08:00:00 - 08:59:59 524 3.3% 0.151.3 MB 2.8% 0.38
Jan 4 09:00:00 - 09:59:59 752 4.7% 0.212.4 MB 5.0% 0.69
Jan 4 10:00:00 - 10:59:59 773 4.8% 0.212.0 MB 4.1% 0.57
Jan 4 11:00:00 - 11:59:59 734 4.6% 0.202.0 MB 4.1% 0.57
Jan 4 12:00:00 - 12:59:59 702 4.4% 0.202.0 MB 4.1% 0.56
Jan 4 13:00:00 - 13:59:59 832 5.2% 0.232.1 MB 4.4% 0.60
Jan 4 14:00:00 - 14:59:59 974 6.1% 0.272.4 MB 5.1% 0.69
Jan 4 15:00:00 - 15:59:59 1034 6.5% 0.292.7 MB 5.6% 0.77
Jan 4 16:00:00 - 16:59:59 1004 6.3% 0.282.8 MB 5.7% 0.78
Jan 4 17:00:00 - 17:59:59 1027 6.4% 0.293.1 MB 6.4% 0.88
Jan 4 18:00:00 - 18:59:59 1007 6.3% 0.283.0 MB 6.1% 0.84
Jan 4 19:00:00 - 19:59:59 774 4.8% 0.212.5 MB 5.1% 0.70
Jan 4 20:00:00 - 20:59:59 780 4.9% 0.222.4 MB 4.9% 0.67
Jan 4 21:00:00 - 21:59:59 709 4.4% 0.202.1 MB 4.3% 0.59
Jan 4 22:00:00 - 22:59:59 773 4.8% 0.212.3 MB 4.8% 0.66
Jan 4 23:00:00 - 23:59:59 652 4.1% 0.182.1 MB 4.4% 0.60
Jan 5 00:00:00 - 00:59:59 571 3.6% 0.161.9 MB 3.9% 0.54
Jan 5 01:00:00 - 01:59:59 457 2.9% 0.131.7 MB 3.5% 0.49
Jan 5 02:00:00 - 02:59:59 343 2.1% 0.101.1 MB 2.3% 0.31
Jan 5 03:00:00 - 03:59:59 287 1.8% 0.08935.7 KB 1.9% 0.26
Jan 5 04:00:00 - 04:15:00 63 0.4% 0.07282.9 KB 0.6% 0.31
TOTAL: 24:00:00 16031 100.0% 0.1948.3 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1641 89 0 0 0 0 0 0 1552
2newsfeed.fu-berlin.de 707 33 0 0 0 0 0 0 674
3newsfeed.neva.ru 362 86 0 0 0 0 0 0 276
4csiph-out.news.weretis.net 315 89 0 0 0 0 0 0 226
5csiph-out.feed.uzoreto.com 308 19 0 0 0 0 0 0 289
6news-out.mixmin.net 294 3 0 0 0 0 0 0 291
7csiph-out.feeder.erje.net 171 57 0 0 0 0 0 0 114
8news-out.aioe.org 73 67 0 0 0 0 0 0 6
9feeder.eternal-september.org 52 19 0 0 0 0 0 0 33
10newsfeeds.xmission.com 45 2 0 0 0 0 0 0 43
11news.freedyn.net 37 0 0 1 0 0 0 0 36
12news-out.neodome.net 34 2 0 1 0 0 0 0 31
13news.swapon.de 23 0 0 0 0 0 0 0 23
14news.fcku.it 10 9 0 0 0 0 0 0 1
15nntp.pasdenom.info 8 0 0 0 0 0 0 0 8
16news.samoylyk.net 4 0 0 0 0 0 0 0 4
17csiph-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
18news.bbs.nz 1 0 0 0 0 0 0 0 1
TOTAL: 18 4086 475 0 2 0 0 0 0 3609

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 70
scinet.stats 54
it-alt.sport.calcio.juventus 35
spline.eisfair 35
alt.computer.workshop 28
mozilla.general 23
alt.politics 17
alt.survival 15
alt.bbs.synchronet 13
alt.job 12
mozilla.support.firefox 11
alt.binaries.pictures.purebeauty 9
at.jobs 8
spline.eisfair.dev 8
scinet.bbs.mystic 8
alt.politics.usa 7
alt.philosophy 7
scinet.gaming 6
aus.jobs 6
scinet.bbs.software 6
TOTAL: 73 475

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1740
EMP (phn path) 499
EMP (phn nph) 267
0 161
Too many newsgroups 66
EMP (phl) 46
Scoring filter 30
HTML Multipart 7
Binary: misplaced binary 5
Binary Payload 4
Too many newsgroups (meow) 2
HTML post 1
TOTAL: 12 2828

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 50
csiph-out.feed.uzoreto.com 2
csiph-out.news.xs4all.nl 1
TOTAL: 3 53
Huge articles
csiph-out.news.xs4all.nl 64
csiph-out.feeder.erje.net 36
csiph-out.feed.uzoreto.com 34
news.freedyn.net 29
newsfeeds.xmission.com 25
csiph-out.news.weretis.net 22
news-out.neodome.net 15
news.samoylyk.net 3
newsfeed.fu-berlin.de 2
feeder.eternal-september.org 2
TOTAL: 12 234
Including strange strings
newsfeed.fu-berlin.de 444
csiph-out.news.xs4all.nl 29
news.swapon.de 23
newsfeeds.xmission.com 15
csiph-out.news.weretis.net 9
news-out.mixmin.net 5
newsfeed.neva.ru 5
csiph-out.feed.uzoreto.com 3
feeder.eternal-september.org 2
news-out.neodome.net 1
TOTAL: 12 538
No colon-space in header
csiph-out.news.xs4all.nl 7
csiph-out.feed.uzoreto.com 2
TOTAL: 2 9
TOTAL: 4 834

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 18354 994 15032 6 0 0 5%23:59:56
2news.bbs.nz 29735 681 14852 53 0 0 2%23:56:04
3fu-berlin.de 14831 407 14424 0 0 0 2%23:50:54
4news.samoylyk.net 16390 401 15578 11 0 0 2%23:50:05
5tnet 17414 280 15312 5 0 0 1%23:59:00
6xmission 16858 145 14123 6 0 0 0%23:50:06
7erje 16580 131 14161 308 0 0 0%23:50:05
8neva.ru 14592 86 14256 119 0 0 0%23:50:06
9newsfeed.xs4all.nl 12020 59 11457 2 0 106 0%23:54:27
10usenet.pasdenom.info 15830 13 15383 46 0 0 0%23:59:50
11news.freedyn.net 14634 9 14306 27 0 0 0%23:50:05
12aioe 12918 5 12576 0 0 0 0%23:52:35
13news.uzoreto.com 15111 2 14772 8 0 0 0%23:57:20
14news.swapon.de 1484 1 1472 0 0 0 0%23:17:32
15news.fcku.it 1279 0 1279 0 0 0 0%21:33:23
16neodome.net 15855 0 15483 0 0 0 0%23:50:05
17news.mixmin.net 13467 0 13125 0 0 0 0%23:54:37
18eternal-september 0 0 0 0 0 12949 0%23:50:06
19weretis.net 14505 0 14279 0 0 0 0%23:50:06
TOTAL: 19 261857 3214 231870 591 0 13055 1%450:56:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs5.3 MB52.7 KB5.4 MB0.1 KB/s5.5 KB23:59:56
2fu-berlin.de3.8 MB0.0 KB3.8 MB0.0 KB/s9.6 KB23:50:54
3news.samoylyk.net3.8 MB10.3 KB3.8 MB0.0 KB/s9.5 KB23:50:05
4news.bbs.nz1.8 MB272.8 KB2.0 MB0.0 KB/s2.8 KB23:56:04
5tnet625.1 KB11.5 KB636.5 KB0.0 KB/s2.2 KB23:59:00
6xmission369.2 KB12.3 KB381.5 KB0.0 KB/s2.5 KB23:50:06
7erje278.9 KB975.6 KB1.2 MB0.0 KB/s2.9 KB23:50:05
8neva.ru178.4 KB256.8 KB435.2 KB0.0 KB/s2.1 KB23:50:06
9newsfeed.xs4all.nl144.9 KB20.4 KB165.3 KB0.0 KB/s2.7 KB23:54:27
10usenet.pasdenom.info55.1 KB70.6 KB125.7 KB0.0 KB/s2.1 KB23:59:50
11news.freedyn.net41.2 KB244.3 KB285.5 KB0.0 KB/s7.9 KB23:50:05
12aioe7.1 KB0.0 KB7.1 KB0.0 KB/s1.4 KB23:52:35
13news.uzoreto.com3.4 KB35.6 KB39.0 KB0.0 KB/s3.9 KB23:57:20
14news.swapon.de1.9 KB0.0 KB1.9 KB0.0 KB/s1.9 KB23:17:32
15news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:33:23
16neodome.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:05
17news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:37
18eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:06
19weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:06
TOTAL: 1916.4 MB1.9 MB18.3 MB0.0 KB/s4.9 KB450:56:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
191.187.33.87 221 27.0 KB 2 0 029:19:41
2a131033.upc-a.chello.nl 42 13.3 KB 1 0 009:31:03
TOTAL: 2 263 310.3 KB 3 0 044:22:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 223 27.0 KB 2 0 029:49:54
2*.upc-a.chello.nl 42 13.3 KB 1 0 009:31:03
3*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
4*.range31-50.btcentralplus.com 2 00.0 KB 0 0 000:10:09
5*.net.upcbroadband.cz 59 00.0 KB 0 0 004:50:53
TOTAL: 5 328 310.3 KB 3 0 044:22:01

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 14.044 3.392 0.00029:19:41
a131033.upc-a.chello.nl 2.682 0.627 0.00009:31:03
ip-78-102-198-192.net.upcbroadband.cz 3.710 0.838 0.00004:50:53
183.129.159.245 0.063 0.016 0.00000:30:02
host31-50-220-99.range31-50.btcentralplus.com 0.139 0.023 0.00000:10:09
159.203.33.77 0.061 0.017 0.00000:00:10
scanner-09.ch1.censys-scanner.com 0.128 0.023 0.00000:00:00
TOTAL: 7 20.827 4.936 0.00044:22:01

Curious NNRP server explorers [Top 20]:

SystemConn
ip-78-102-198-192.net.upcbroadband.cz 59
host31-50-220-99.range31-50.btcentralplus.com 2
scanner-09.ch1.censys-scanner.com 2
183.129.159.245 1
159.203.33.77 1
TOTAL: 5 65

NNRP unrecognized commands (by host):

SystemConn
183.129.159.245 1
scanner-09.ch1.censys-scanner.com 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
GET / HTTP/1.0 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
183.129.159.245 1 0
TOTAL: 1 1 1

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