Daily Usenet report for csiph.com

Oct 20 04:15:00 -- Oct 21 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 20 11:57:16 csiph nnrpd[68209]: unable to get certificate from '/usr/local/news/etc/cert.pem'
Oct 20 11:57:16 csiph nnrpd[68209]: 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
nnrpd 24204 37.4%2.9 MB 27.1%
inn 19663 30.4%5.0 MB 46.9%
innd 17374 26.8%2.2 MB 20.7%
innfeed 3484 5.4%571.0 KB 5.2%
nocem 37 0.1%4.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 64763 100.0%10.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 286600 56.4%
Negative hits 202677 39.9%
Do not exist 18961 3.7%
Cache misses 225 0.0%
TOTAL: 4 508463 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.748 0.0%72 0.000 10.389 86.000
article cleanup00:00:00.117 0.0%18732 0.000 0.006 0.031
article logging00:00:00.389 0.0%19232 0.000 0.020 0.471
article parse00:00:01.592 0.0%58893 0.000 0.027 1.595
article write00:02:28.741 0.2%15520 0.545 9.584 43.095
artlog/artcncl00:00:00.000 0.0%60 0.000 0.000 0.000
artlog/artparse00:00:00.004 0.0%287 0.000 0.014 0.500
data move00:00:00.111 0.0%474835 0.000 0.000 0.002
hisgrep/artcncl00:00:00.020 0.0%71 0.000 0.282 6.000
hishave/artcncl00:00:00.001 0.0%72 0.000 0.014 0.111
hishave/artparse00:00:00.002 0.0%282 0.000 0.007 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:42.700 0.0%509861 0.002 0.084 1.378
history sync00:00:00.887 0.0%380 0.000 2.334 29.500
history write00:00:43.918 0.1%18736 0.182 2.344 19.056
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:01.120 0.0%281 0.000 3.986 64.286
idle23:51:00.144 99.3%477421 92.267 179.842 754.409
nntp read00:00:02.426 0.0%483123 0.001 0.005 0.052
overview write00:04:02.498 0.3%15520 1.650 15.625 798.131
perl filter00:00:37.908 0.0%18731 1.470 2.024 4.524
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.261 0.0%31074 0.000 0.008 0.037
TOTAL: 24:01:02.97223:59:43.587 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.049 0.0%16008 0.000 0.003 0.030
article prepare00:00:00.005 0.0%19588 0.000 0.000 0.003
article read00:00:04.259 0.0%1628 0.000 2.616 28.800
backlog stats00:00:00.215 0.0%336101 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.415 0.0%255794 0.001 0.006 0.016
data write00:00:01.605 0.0%243528 0.002 0.007 0.012
idle23:53:58.184100.0%336101 126.688 255.989 978.327
status file00:00:01.894 0.0%339 0.000 5.587 125.000
TOTAL: 23:54:15.22423:54:07.626100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle55:35:31.624 89.1%1066732 0.000 187.612900020.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:14.042 0.0%2569730 0.000 0.005 5.214
readart06:38:54.733 10.7%1029917 0.000 23.239 702.000
TOTAL: 62:21:37.64862:14:40.399 99.8%----

Control commands to INND:

CommandNumber
L 1
flush 5
flushlogs 2
go 2
logmode 2
mode 14
pause 2
paused 2
reload 2
reserve 2
TOTAL: 10 34

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeeds.xmission.com 3 14638 3443 11184 11 23%24:13:03
2feeder.eternal-september.org 5 18066 1906 16071 89 10%26:03:19
3news.freedyn.net 3 18167 1853 15501 813 10%24:08:55
4news-out.mixmin.net 4 17472 1529 15265 678 8%23:47:31
5csiph-out.news.xs4all.nl 864 17421 1434 15264 723 8%71:10:34
6csiph-out.feeder.erje.net 1440 76144 1427 74362 355 1%118:41:35
7news-out.aioe.org 2 14683 1265 13411 7 8%23:59:53
8newsfeed.neva.ru 140 16086 779 15012 295 4%71:29:11
9newsfeed.fu-berlin.de 13 16518 759 15523 236 4%27:36:31
10csiph-out.news.weretis.net 2 18180 698 17389 93 3%31:45:28
11csiph-out.feed.uzoreto.com 864 26711 223 26316 172 0%71:16:24
12news.fcku.it 18 1307 116 1190 1 8%22:24:36
13nntp.pasdenom.info 2 9564 53 9497 14 0%23:58:21
14localhost 45 15 15 0 0 100%00:00:08
15news.swapon.de 10 1283 14 1265 4 1%24:07:27
16news.samoylyk.net 2 14772 14 14755 3 0%24:55:30
17news.bbs.nz 2 13717 0 13717 0 0%23:59:46
18xanadu-bbs.net 28 387 0 387 0 0%21:16:07
TOTAL: 18 3447 295131 15528 276109 3494 5%654:54:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net10.3 MB18.7 KB11.6 MB21.9 MB 46%12.6 KB
2newsfeeds.xmission.com9.9 MB0.0 KB537.9 KB10.4 MB 94%3.1 KB
3feeder.eternal-september.org5.2 MB0.0 KB579.2 KB5.8 MB 90%3.0 KB
4news.freedyn.net4.8 MB0.0 KB3.1 MB7.9 MB 60%3.1 KB
5news-out.mixmin.net4.3 MB0.0 KB3.6 MB7.9 MB 54%3.7 KB
6csiph-out.news.xs4all.nl4.2 MB0.0 KB5.2 MB9.4 MB 44%4.5 KB
7news-out.aioe.org2.9 MB0.0 KB11.0 KB2.9 MB 99%2.3 KB
8newsfeed.neva.ru2.1 MB0.0 KB918.3 KB3.0 MB 70%2.9 KB
9csiph-out.news.weretis.net2.0 MB0.0 KB1.1 MB3.1 MB 64%4.0 KB
10newsfeed.fu-berlin.de1.9 MB0.0 KB506.8 KB2.4 MB 78%2.4 KB
11csiph-out.feed.uzoreto.com785.8 KB0.0 KB3.2 MB3.9 MB 19%10.2 KB
12news.fcku.it203.6 KB0.0 KB3.6 KB207.2 KB 98%1.8 KB
13nntp.pasdenom.info138.9 KB0.0 KB21.0 KB159.8 KB 86%2.4 KB
14news.samoylyk.net53.3 KB0.0 KB1.8 MB1.9 MB 2%112.9 KB
15news.swapon.de35.0 KB0.0 KB2.7 MB2.7 MB 1%154.5 KB
16localhost23.1 KB0.0 KB0.0 KB23.1 KB100%1.5 KB
17news.bbs.nz0.0 KB0.0 KB0.0 KB0.0 KB 0%0
18xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1848.7 MB18.7 KB34.8 MB83.6 MB 58%4.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 20 04:15:00 - 04:59:59 189 1.2% 0.07528.9 KB 1.1% 0.20
Oct 20 05:00:00 - 05:59:59 290 1.9% 0.081.0 MB 2.1% 0.29
Oct 20 06:00:00 - 06:59:59 437 2.8% 0.121.9 MB 3.8% 0.53
Oct 20 07:00:00 - 07:59:59 643 4.1% 0.182.9 MB 6.0% 0.83
Oct 20 08:00:00 - 08:59:59 586 3.8% 0.161.5 MB 3.1% 0.43
Oct 20 09:00:00 - 09:59:59 740 4.8% 0.212.9 MB 6.0% 0.83
Oct 20 10:00:00 - 10:59:59 711 4.6% 0.202.5 MB 5.1% 0.71
Oct 20 11:00:00 - 11:59:59 799 5.1% 0.222.1 MB 4.3% 0.60
Oct 20 12:00:00 - 12:59:59 745 4.8% 0.212.0 MB 4.1% 0.57
Oct 20 13:00:00 - 13:59:59 808 5.2% 0.222.3 MB 4.7% 0.65
Oct 20 14:00:00 - 14:59:59 796 5.1% 0.222.5 MB 5.1% 0.71
Oct 20 15:00:00 - 15:59:59 871 5.6% 0.242.7 MB 5.4% 0.75
Oct 20 16:00:00 - 16:59:59 772 5.0% 0.212.2 MB 4.5% 0.63
Oct 20 17:00:00 - 17:59:59 954 6.1% 0.273.0 MB 6.1% 0.84
Oct 20 18:00:00 - 18:59:59 935 6.0% 0.263.1 MB 6.3% 0.87
Oct 20 19:00:00 - 19:59:59 907 5.8% 0.252.3 MB 4.7% 0.65
Oct 20 20:00:00 - 20:59:59 809 5.2% 0.222.1 MB 4.2% 0.59
Oct 20 21:00:00 - 21:59:59 813 5.2% 0.232.4 MB 5.0% 0.70
Oct 20 22:00:00 - 22:59:59 708 4.5% 0.202.5 MB 5.1% 0.71
Oct 20 23:00:00 - 23:59:59 479 3.1% 0.131.3 MB 2.6% 0.36
Oct 21 00:00:00 - 00:59:59 457 2.9% 0.131.3 MB 2.6% 0.36
Oct 21 01:00:00 - 01:59:59 365 2.3% 0.101.0 MB 2.1% 0.30
Oct 21 02:00:00 - 02:59:59 339 2.2% 0.091.3 MB 2.6% 0.36
Oct 21 03:00:00 - 03:59:59 254 1.6% 0.07766.5 KB 1.5% 0.21
Oct 21 04:00:00 - 04:15:00 165 1.1% 0.18948.0 KB 1.9% 1.05
TOTAL: 24:00:00 15572 100.0% 0.1848.8 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.freedyn.net 817 2 0 0 0 0 0 0 815
2csiph-out.news.xs4all.nl 761 48 0 0 0 0 0 0 713
3news-out.mixmin.net 701 6 0 0 0 0 0 0 695
4newsfeed.fu-berlin.de 628 79 0 0 0 0 0 0 549
5csiph-out.feeder.erje.net 370 57 0 1 0 0 0 0 312
6newsfeed.neva.ru 299 91 0 0 0 0 0 0 208
7csiph-out.feed.uzoreto.com 175 13 0 0 0 0 0 0 162
8csiph-out.news.weretis.net 148 67 0 0 0 0 0 0 81
9feeder.eternal-september.org 75 13 0 0 0 0 0 0 62
10newsfeeds.xmission.com 24 2 0 0 0 0 0 0 22
11nntp.pasdenom.info 14 0 0 0 0 0 0 0 14
12news-out.aioe.org 9 7 0 0 0 0 0 0 2
13news.swapon.de 7 0 0 0 0 0 0 0 7
14news.samoylyk.net 3 0 0 0 0 0 0 0 3
TOTAL: 14 4031 385 0 1 0 0 0 0 3645

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 67
spline.eisfair 56
alt.computer.workshop 49
lada.auto 17
alt.windows7.general 17
it-alt.sport.calcio.juventus 14
alt.pl.nieruchomosci.gielda 11
rocksolid.shared.test 11
alt.binaries.ella.virginia.model 9
oesterreich.tratsch 9
alt.binaries.pictures.purebeauty 7
mozilla.general 6
rocksolid.shared.security 5
mozilla.support.thunderbird 5
alt.binaries.ctb 5
alt.survival 4
alt.forsale.seattle 4
alt.arts.poetry 4
alt.math.undergrad 4
alt.tv.star-trek 4
TOTAL: 73 385

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2345
EMP (phn path) 193
EMP (phn nph) 105
EMP (phl) 71
Too many newsgroups 43
User-issued cancel 33
HTML Multipart 11
User-issued spam cancel 11
Binary Payload 8
Scoring filter (9) 5
Scoring filter (8) 4
Binary: misplaced rar 3
Scoring filter (11) 3
Binary: misplaced zip 2
Scoring filter (15) 2
Scoring filter (13) 2
Too many newsgroups (meow) 1
Binary: misplaced par2 1
Binary: misplaced obj 1
Scoring filter (10) 1
TOTAL: 22 2847

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1702121
TOTAL: 117172121

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 210
csiph-out.news.xs4all.nl 22
news.freedyn.net 15
csiph-out.feed.uzoreto.com 13
csiph-out.news.weretis.net 10
newsfeeds.xmission.com 8
news-out.mixmin.net 5
feeder.eternal-september.org 4
news.swapon.de 4
news.samoylyk.net 3
TOTAL: 10 294
Including strange strings
newsfeed.fu-berlin.de 379
csiph-out.news.weretis.net 32
csiph-out.news.xs4all.nl 31
news-out.mixmin.net 21
newsfeeds.xmission.com 13
csiph-out.feeder.erje.net 8
newsfeed.neva.ru 4
csiph-out.feed.uzoreto.com 3
news.swapon.de 3
feeder.eternal-september.org 2
TOTAL: 12 499
No colon-space in header
csiph-out.news.xs4all.nl 3
csiph-out.feeder.erje.net 2
TOTAL: 2 5
TOTAL: 4 843

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 19255 1299 14265 8 0 4 6%23:59:19
2news.samoylyk.net 15924 672 14882 4 0 30 4%23:59:55
3news.freedyn.net 13982 655 12990 37 0 0 4%23:59:53
4fu-berlin.de 14652 647 14005 0 0 0 4%23:59:55
5news.bbs.nz 28507 415 14483 6 0 1 1%23:59:48
6usenet.pasdenom.info 15960 139 14713 668 0 12 0%23:59:55
7newsfeed.xs4all.nl 14300 43 13672 6 0 86 0%23:59:54
8erje 15459 38 13962 13 0 0 0%23:59:45
9news.uzoreto.com 15323 25 14967 41 0 49 0%23:59:55
10neva.ru 14132 24 13848 128 0 0 0%23:59:55
11aioe 13363 24 12900 0 0 0 0%23:59:40
12news.mixmin.net 13552 19 13110 0 0 328 0%23:59:55
13xmission 15005 18 11454 1 0 0 0%23:59:55
14eternal-september 13421 16 12966 0 0 0 0%23:59:55
15news.swapon.de 1316 15 1291 0 0 0 1%23:17:55
16weretis.net 14090 15 13935 6 0 0 0%23:59:55
17news.redatomik.org 0 0 0 0 0 14910 0%23:59:55
18news.fcku.it 1136 0 1133 0 0 0 0%21:58:38
TOTAL: 18 239377 4064 208576 918 0 15420 1%429:14:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs9.8 MB18.1 KB9.8 MB0.1 KB/s7.7 KB23:59:19
2news.freedyn.net8.1 MB87.2 KB8.2 MB0.1 KB/s12.1 KB23:59:53
3news.samoylyk.net8.0 MB45.3 KB8.1 MB0.1 KB/s12.2 KB23:59:55
4fu-berlin.de8.0 MB0.0 KB8.0 MB0.1 KB/s12.7 KB23:59:55
5news.bbs.nz1005.4 KB20.9 KB1.0 MB0.0 KB/s2.4 KB23:59:48
6usenet.pasdenom.info322.2 KB8.1 MB8.4 MB0.1 KB/s10.6 KB23:59:55
7newsfeed.xs4all.nl202.4 KB12.3 KB214.7 KB0.0 KB/s4.4 KB23:59:54
8news.uzoreto.com97.9 KB347.0 KB444.9 KB0.0 KB/s6.7 KB23:59:55
9erje89.8 KB64.7 KB154.5 KB0.0 KB/s3.0 KB23:59:45
10neva.ru43.9 KB254.5 KB298.5 KB0.0 KB/s2.0 KB23:59:55
11aioe41.6 KB0.0 KB41.6 KB0.0 KB/s1.7 KB23:59:40
12xmission29.6 KB1.1 KB30.7 KB0.0 KB/s1.6 KB23:59:55
13news.mixmin.net29.3 KB0.0 KB29.3 KB0.0 KB/s1.5 KB23:59:55
14eternal-september28.1 KB0.0 KB28.1 KB0.0 KB/s1.8 KB23:59:55
15news.swapon.de23.1 KB0.0 KB23.1 KB0.0 KB/s1.5 KB23:17:55
16weretis.net23.1 KB32.6 KB55.7 KB0.0 KB/s2.7 KB23:59:55
17news.redatomik.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
18news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:58:38
TOTAL: 1835.8 MB8.9 MB44.7 MB0.0 KB/s9.2 KB429:14:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2320w-lp130-01-184-146-237-6.dsl.bell.ca3841218072544.0 MB 3308 0 039:15:17
224.178.47.147 31 2637.1 KB 18 15 1406:03:42
3a131033.upc-a.chello.nl 57 2536.7 KB 12 0 015:06:55
TOTAL: 33929218123544.0 MB 3338 15 1462:20:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca3841218072544.0 MB 3308 0 039:15:17
2unresolved 37 2637.1 KB 18 15 1406:33:57
3*.upc-a.chello.nl 57 2536.7 KB 12 0 015:06:55
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
5*.cust.centrio.cz 3 00.0 KB 0 0 001:24:05
6*.hinet-ip.hinet.net 1 00.0 KB 0 0 000:00:11
TOTAL: 63940218123544.0 MB 3338 15 1462:20:28

NNRP auth users [Top 20]:

UserConn
ohlandl 14
ctomczyk 3
TOTAL: 2 17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2320w-lp130-01-184-146-237-6.dsl.bell.ca 363.839 161.795 0.00039:15:17
a131033.upc-a.chello.nl 4.745 1.235 0.00015:06:55
24.178.47.147 2.988 0.736 0.12806:03:42
208-71-239-109.cust.centrio.cz 0.226 0.090 0.00901:24:05
115.238.34.19 0.076 0.008 0.00000:30:00
164.52.24.176 0.207 0.047 0.00000:00:11
59-127-102-17.hinet-ip.hinet.net 0.063 0.021 0.00000:00:11
94.160.244.64 0.068 0.017 0.00000:00:01
94.167.111.82 0.073 0.015 0.00000:00:01
scan-141.security.ipip.net 0.069 0.015 0.00000:00:00
TOTAL: 10 372.354 163.979 0.13762:20:28

Curious NNRP server explorers [Top 20]:

SystemConn
208-71-239-109.cust.centrio.cz 3
164.52.24.176 3
115.238.34.19 1
94.160.244.64 1
94.167.111.82 1
59-127-102-17.hinet-ip.hinet.net 1
scan-141.security.ipip.net 1
TOTAL: 7 11

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
164.52.24.176 2
115.238.34.19 1
TOTAL: 3 7

NNRP unrecognized commands (by command):

CommandCount
Connection: close 1
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
GET / HTTP/1.0 1
^V^C^A^A"^A 1
Host: 69.160.37.58:119 1
À/À+À'À#À^SÀ\x09 1
TOTAL: 7 7

NNRP client timeouts [Top 20]:

SystemConnPeer
24.178.47.147 4 0
208-71-239-109.cust.centrio.cz 2 0
164.52.24.176 1 1
115.238.34.19 1 0
TOTAL: 4 8 1

Newsgroup request counts (by category):

CategoryCountPct
1alt 217932 99.9%
2comp 64 0.0%
3uk 33 0.0%
4fr 32 0.0%
5sci 27 0.0%
6soc 15 0.0%
7rec 9 0.0%
8aus 6 0.0%
9talk 2 0.0%
10can 2 0.0%
11misc 1 0.0%
TOTAL: 11 218123100.0%

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

NewsgroupCount
1alt.arts.poetry.comments 217498
2alt.atheism 369
3comp.sys.ibm.ps2.hardware 51
4fr.soc.politique 20
5alt.bible.prophecy 20
6uk.politics.misc 12
7uk.d-i-y 11
8alt.comp.freeware 10
9sci.physics.relativity 9
10alt.sixtyplus 8
11uk.radio.amateur 6
12comp.os.linux.advocacy 5
13sci.math 5
14fr.usenet.abus.nocem 4
15aus.politics 4
16soc.culture.indian 4
17soc.culture.china 4
18alt.politics.economics 4
19alt.slack 4
20sci.lang 3
21uk.tech.broadcast 3
22alt.politics.trump 3
23alt.society.liberalism 3
24alt.war.vietnam 3
25alt.russian.z1 3
26sci.med.cardiology 3
27sci.physics 3
28alt.christnet.christianlife 3
29soc.culture.netherlands 2
30comp.lang.tcl 2
31fr.comp.os.mac-os.x 2
32sci.logic 2
33talk.origins 2
34alt.messianic 2
35alt.astronomy 2
36rec.arts.sf.written 2
37can.politics 2
38fr.rec.photo 2
39soc.retirement 2
40aus.legal 2
41comp.lang.forth 1
42fr.sci.maths 1
43rec.music.classical.guitar 1
44rec.radio.amateur.dx 1
45fr.lettres.langue.francaise 1
46fr.soc.economie 1
47comp.lang.c 1
48comp.sys.acorn.apps 1
49comp.sys.apple2 1
50rec.radio.amateur.moderated 1
51soc.culture.brazil 1
52rec.sport.cricket 1
53rec.music.rock-pop-r+b.1950s 1
54soc.genealogy.benelux 1
55uk.comp.homebuilt 1
56sci.med.pharmacy 1
57fr.rec.philatelie 1
58misc.news.internet.discuss 1
59rec.radio.amateur.misc 1
60soc.culture.usa 1
61comp.sys.ibm.pc.games.action 1
62rec.gambling.lottery 1
63sci.crypt 1
64comp.sys.raspberry-pi 1
TOTAL: 64 218123