Daily Usenet report for csiph.com

Oct 13 04:15:00 -- Oct 14 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 13 18:10:02 csiph controlchan[63439]: Multiple control headers in article <AZwUh-1Dz-5@gated-at.bofh.it>

Log entries by program:

Program nameLines%LinesSize%Size
inn 19125 48.6%4.9 MB 63.4%
innd 15912 40.4%2.1 MB 27.2%
innfeed 3541 9.0%650.3 KB 8.3%
nnrpd 768 2.0%85.4 KB 1.1%
nocem 6 0.0%0.6 KB 0.0%
controlchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 39354 100.0%7.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 315506 57.4%
Negative hits 215068 39.1%
Do not exist 18600 3.4%
Cache misses 301 0.1%
TOTAL: 4 549475 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.334 0.0%33 0.000 10.121 24.143
article cleanup00:00:00.108 0.0%18164 0.000 0.006 0.032
article logging00:00:00.280 0.0%18622 0.000 0.015 0.190
article parse00:00:01.539 0.0%63560 0.000 0.024 0.913
article write00:00:09.303 0.0%15145 0.145 0.614 22.385
artlog/artcncl00:00:00.001 0.0%33 0.000 0.030 0.143
artlog/artparse00:00:00.008 0.0%509 0.000 0.016 0.250
data move00:00:00.198 0.0%523581 0.000 0.000 0.002
hisgrep/artcncl00:00:00.054 0.0%32 0.000 1.688 18.000
hishave/artcncl00:00:00.052 0.0%33 0.000 1.576 7.143
hishave/artparse00:00:00.001 0.0%502 0.000 0.002 0.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:13.701 0.0%550277 0.001 0.025 0.578
history sync00:00:00.888 0.0%382 0.000 2.325 23.000
history write00:00:18.156 0.0%18162 0.067 1.000 12.589
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.952 0.0%502 0.000 1.896 69.750
idle23:58:19.690 99.8%529437 83.289 163.003 418.229
nntp read00:00:01.980 0.0%531033 0.001 0.004 0.008
overview write00:00:59.380 0.1%15145 0.132 3.921 271.086
perl filter00:00:25.596 0.0%18155 1.074 1.410 2.070
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.236 0.0%30296 0.000 0.008 0.038
TOTAL: 24:01:07.78224:00:32.457100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.032 0.0%15268 0.000 0.002 0.020
article prepare00:00:00.000 0.0%12516 0.000 0.000 0.000
article read00:00:00.265 0.0%1561 0.000 0.170 2.222
backlog stats00:00:00.187 0.0%348678 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.233 0.0%277586 0.000 0.004 0.011
data write00:00:01.477 0.0%264106 0.001 0.006 0.015
idle23:54:57.872100.0%348678 145.966 246.927 658.770
status file00:00:00.215 0.0%291 0.000 0.739 2.000
TOTAL: 23:55:08.86623:55:01.281100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle41:02:54.469 99.8%440 7732.000335851.066600112.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.0%964 0.000 0.006 0.286
readart00:00:00.042 0.0%1 42.000 42.000 42.000
TOTAL: 41:07:42.28141:02:54.517 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeeds.xmission.com 2 14307 3450 10809 48 24%24:07:52
2news-out.aioe.org 3 14384 3131 11133 120 21%24:09:55
3csiph-out.news.xs4all.nl 496 17919 2519 13521 1879 14%68:54:12
4feeder.eternal-september.org 4 16894 2109 14683 102 12%24:07:35
5newsfeed.fu-berlin.de 13 16063 775 15191 97 4%28:59:20
6newsfeed.neva.ru 150 18110 656 17167 287 3%72:04:21
7csiph-out.feeder.erje.net 1440 74171 630 73422 119 0%118:46:42
8news-out.mixmin.net 1 16072 601 15374 97 3%23:59:52
9csiph-out.news.weretis.net 3 28879 427 28166 286 1%44:03:58
10news.fcku.it 15 1703 358 1341 4 21%21:21:46
11news-out.neodome.net 2 16533 196 16330 7 1%24:01:57
12csiph-out.feed.uzoreto.com 864 23638 94 23341 203 0%71:11:38
13news.swapon.de 10 1455 76 1379 0 5%24:06:52
14nntp.pasdenom.info 2 10015 47 9959 9 0%23:58:46
15news.freedyn.net 2 18422 19 18265 138 0%23:59:57
16csiph-out.news.tnetconsulting.net 2 14935 18 14904 13 0%23:59:49
17news.samoylyk.net 1 14582 3 14579 0 0%23:59:30
18localhost 26 0 0 0 0 0%00:00:05
19xanadu-bbs.net 35 395 0 395 0 0%20:26:29
20news.bbs.nz 1 14257 0 14257 0 0%23:59:53
TOTAL: 20 3072 332734 15109 314216 3409 4%710:20:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeeds.xmission.com10.5 MB0.0 KB2.9 MB13.4 MB 78%3.9 KB
2news-out.aioe.org7.2 MB0.0 KB353.0 KB7.5 MB 95%2.4 KB
3csiph-out.news.xs4all.nl6.2 MB0.0 KB16.6 MB22.7 MB 27%5.3 KB
4feeder.eternal-september.org5.8 MB6.9 KB3.0 MB8.8 MB 65%4.1 KB
5csiph-out.feeder.erje.net4.6 MB0.0 KB2.4 MB7.0 MB 66%9.6 KB
6news-out.mixmin.net1.9 MB0.0 KB289.4 KB2.2 MB 86%3.2 KB
7newsfeed.fu-berlin.de1.9 MB0.0 KB425.7 KB2.3 MB 81%2.7 KB
8newsfeed.neva.ru1.7 MB0.0 KB510.5 KB2.2 MB 76%2.3 KB
9csiph-out.news.weretis.net1.1 MB1.2 KB2.4 MB3.6 MB 31%5.1 KB
10news.fcku.it542.2 KB1.5 KB5.8 KB549.5 KB 98%1.5 KB
11news-out.neodome.net490.1 KB1.2 KB58.7 KB549.9 KB 89%2.7 KB
12csiph-out.feed.uzoreto.com373.7 KB0.0 KB7.3 MB7.6 MB 4%26.3 KB
13news.freedyn.net269.2 KB1.2 KB17.6 MB17.8 MB 1%116.3 KB
14news.swapon.de170.9 KB0.0 KB0.0 KB170.9 KB100%2.2 KB
15nntp.pasdenom.info110.4 KB0.0 KB11.5 KB122.0 KB 90%2.2 KB
16csiph-out.news.tnetconsulting.net72.7 KB0.0 KB35.5 KB108.2 KB 67%3.5 KB
17news.samoylyk.net5.4 KB0.0 KB0.0 KB5.4 KB100%1.8 KB
18localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
19xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20news.bbs.nz0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2042.7 MB12.0 KB53.8 MB96.5 MB 44%5.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 13 04:15:00 - 04:59:59 317 2.1% 0.121.6 MB 3.8% 0.61
Oct 13 05:00:00 - 05:59:59 367 2.4% 0.101.1 MB 2.7% 0.32
Oct 13 06:00:00 - 06:59:59 494 3.3% 0.141.3 MB 3.0% 0.36
Oct 13 07:00:00 - 07:59:59 532 3.5% 0.151.4 MB 3.2% 0.39
Oct 13 08:00:00 - 08:59:59 758 5.0% 0.211.9 MB 4.5% 0.54
Oct 13 09:00:00 - 09:59:59 698 4.6% 0.191.8 MB 4.1% 0.50
Oct 13 10:00:00 - 10:59:59 742 4.9% 0.212.1 MB 4.9% 0.59
Oct 13 11:00:00 - 11:59:59 726 4.8% 0.201.7 MB 3.9% 0.47
Oct 13 12:00:00 - 12:59:59 733 4.8% 0.201.8 MB 4.3% 0.52
Oct 13 13:00:00 - 13:59:59 792 5.2% 0.222.0 MB 4.7% 0.57
Oct 13 14:00:00 - 14:59:59 939 6.2% 0.262.4 MB 5.5% 0.67
Oct 13 15:00:00 - 15:59:59 910 6.0% 0.252.3 MB 5.4% 0.65
Oct 13 16:00:00 - 16:59:59 877 5.8% 0.243.1 MB 7.4% 0.90
Oct 13 17:00:00 - 17:59:59 741 4.9% 0.212.0 MB 4.6% 0.56
Oct 13 18:00:00 - 18:59:59 856 5.7% 0.242.4 MB 5.6% 0.68
Oct 13 19:00:00 - 19:59:59 887 5.9% 0.252.3 MB 5.3% 0.65
Oct 13 20:00:00 - 20:59:59 675 4.5% 0.192.0 MB 4.7% 0.57
Oct 13 21:00:00 - 21:59:59 672 4.4% 0.191.8 MB 4.3% 0.52
Oct 13 22:00:00 - 22:59:59 560 3.7% 0.161.7 MB 4.0% 0.49
Oct 13 23:00:00 - 23:59:59 458 3.0% 0.131.4 MB 3.2% 0.39
Oct 14 00:00:00 - 00:59:59 334 2.2% 0.091.1 MB 2.6% 0.31
Oct 14 01:00:00 - 01:59:59 377 2.5% 0.101.2 MB 2.9% 0.35
Oct 14 02:00:00 - 02:59:59 286 1.9% 0.08897.4 KB 2.1% 0.25
Oct 14 03:00:00 - 03:59:59 308 2.0% 0.091.1 MB 2.6% 0.31
Oct 14 04:00:00 - 04:15:00 87 0.6% 0.10373.2 KB 0.9% 0.41
TOTAL: 24:00:00 15126 100.0% 0.1842.7 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1867 76 0 0 0 0 0 0 1791
2newsfeed.fu-berlin.de 430 32 0 0 0 0 0 0 398
3csiph-out.news.weretis.net 375 29 0 1 0 0 0 0 345
4newsfeed.neva.ru 294 95 0 0 0 0 0 0 199
5csiph-out.feed.uzoreto.com 202 7 0 0 0 0 0 0 195
6news-out.aioe.org 192 112 0 0 0 0 0 0 80
7news.freedyn.net 141 0 0 1 0 0 0 0 140
8csiph-out.feeder.erje.net 120 44 0 0 0 0 0 0 76
9news-out.mixmin.net 106 7 0 0 0 0 0 0 99
10feeder.eternal-september.org 105 35 0 3 0 0 0 0 67
11newsfeeds.xmission.com 60 2 0 0 0 0 0 0 58
12news.swapon.de 28 0 0 0 0 0 0 0 28
13csiph-out.news.tnetconsulting.net 28 16 0 2 0 0 0 0 10
14nntp.pasdenom.info 9 0 0 0 0 0 0 0 9
15news-out.neodome.net 7 3 0 1 0 0 0 0 3
16news.fcku.it 4 3 0 1 0 0 0 0 0
TOTAL: 16 3968 461 0 9 0 0 0 0 3498

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 68
alt.bbs.synchronet 59
alt.computer.workshop 53
scinet.stats 25
it-alt.sport.calcio.juventus 23
lada.auto 23
alt.windows7.general 17
spline.eisfair 17
alt.binaries.pictures.purebeauty 12
alt.politics 9
mozilla.support.seamonkey 9
cakewalk.audio 9
free.it.religioni.scientology 8
alt.survival 7
alt.politics.usa 6
oesterreich.tratsch 6
at.jobs 5
alt.binaries.kindle 5
alt.philosophy 4
alt.misanthropy 4
TOTAL: 80 461

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1761
EMP (phn path) 343
EMP (phl) 203
Too many newsgroups 77
EMP (phn nph) 62
HTML Multipart 23
Binary Payload 23
0 20
Binary: misplaced binary 7
Too many newsgroups (meow) 6
Scoring filter 5
HTML post 1
TOTAL: 12 2531

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 70
csiph-out.feed.uzoreto.com 5
csiph-out.news.xs4all.nl 5
TOTAL: 3 80
Huge articles
csiph-out.news.xs4all.nl 178
news.freedyn.net 112
csiph-out.feed.uzoreto.com 93
newsfeeds.xmission.com 53
csiph-out.feeder.erje.net 37
csiph-out.news.weretis.net 17
feeder.eternal-september.org 7
news-out.mixmin.net 2
newsfeed.fu-berlin.de 2
TOTAL: 9 501
Including strange strings
newsfeed.fu-berlin.de 337
news-out.aioe.org 60
news.swapon.de 28
csiph-out.news.xs4all.nl 11
news-out.mixmin.net 10
newsfeeds.xmission.com 5
csiph-out.news.weretis.net 4
feeder.eternal-september.org 2
news-out.neodome.net 1
TOTAL: 9 458
No colon-space in header
csiph-out.news.xs4all.nl 7
TOTAL: 1 7
TOTAL: 4 1046

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 19138 1126 13948 52 0 48 5%23:59:54
2news.bbs.nz 28544 499 14117 24 0 0 1%23:59:54
3fu-berlin.de 14234 451 13783 0 0 1 3%23:59:49
4news.samoylyk.net 15573 435 14680 8 0 0 2%23:59:27
5tnet 16506 129 14528 1 0 0 0%23:59:54
6neva.ru 13530 110 13264 47 0 0 0%23:59:54
7news.freedyn.net 14718 35 14411 0 0 0 0%23:59:54
8newsfeed.xs4all.nl 12896 28 12505 0 0 0 0%23:59:40
9weretis.net 14578 17 14162 1 0 0 0%23:59:49
10usenet.pasdenom.info 15238 13 14589 5 0 15 0%23:59:54
11news.uzoreto.com 14544 12 14258 88 0 0 0%23:59:54
12xmission 12766 11 11091 2 0 0 0%23:59:54
13neodome.net 15260 8 14885 0 0 103 0%23:59:54
14news.mixmin.net 14162 7 13909 0 0 0 0%23:59:54
15aioe 11016 4 10595 1 0 0 0%23:59:50
16erje 14554 2 14258 34 0 0 0%23:59:54
17eternal-september 12624 0 12318 0 0 0 0%23:59:28
18news.fcku.it 2173 0 1309 0 0 0 0%20:44:17
19news.swapon.de 1402 0 1394 0 0 0 0%23:07:19
TOTAL: 19 263456 2887 234004 263 0 167 1%451:48:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs6.1 MB195.7 KB6.2 MB0.1 KB/s5.4 KB23:59:54
2fu-berlin.de4.2 MB0.0 KB4.2 MB0.0 KB/s9.5 KB23:59:49
3news.samoylyk.net4.1 MB49.8 KB4.2 MB0.0 KB/s9.7 KB23:59:27
4news.bbs.nz1.3 MB79.1 KB1.4 MB0.0 KB/s2.7 KB23:59:54
5tnet320.7 KB1.2 KB322.0 KB0.0 KB/s2.5 KB23:59:54
6news.freedyn.net260.3 KB0.0 KB260.3 KB0.0 KB/s7.4 KB23:59:54
7neva.ru220.8 KB88.8 KB309.6 KB0.0 KB/s2.0 KB23:59:54
8newsfeed.xs4all.nl59.2 KB0.0 KB59.2 KB0.0 KB/s2.1 KB23:59:40
9usenet.pasdenom.info23.4 KB20.9 KB44.3 KB0.0 KB/s2.5 KB23:59:54
10weretis.net20.9 KB1.2 KB22.1 KB0.0 KB/s1.2 KB23:59:49
11xmission20.6 KB2.3 KB22.9 KB0.0 KB/s1.8 KB23:59:54
12news.uzoreto.com19.4 KB179.3 KB198.7 KB0.0 KB/s2.0 KB23:59:54
13neodome.net14.1 KB0.0 KB14.1 KB0.0 KB/s1.8 KB23:59:54
14news.mixmin.net9.1 KB0.0 KB9.1 KB0.0 KB/s1.3 KB23:59:54
15aioe9.0 KB1.0 KB10.0 KB0.0 KB/s2.0 KB23:59:50
16erje7.1 KB141.2 KB148.3 KB0.0 KB/s4.1 KB23:59:54
17eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:28
18news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:44:17
19news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:07:19
TOTAL: 1916.7 MB760.6 KB17.4 MB0.0 KB/s5.7 KB451:48:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1a131033.upc-a.chello.nl 48 12.9 KB 1 0 014:08:17
TOTAL: 1 48 12.9 KB 1 0 041:07:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.upc-a.chello.nl 48 12.9 KB 1 0 014:08:17
2unresolved 73 00.0 KB 0 0 023:59:52
3*.res.spectrum.com 4 00.0 KB 0 0 001:28:32
4*.ph.ph.cox.net 3 00.0 KB 0 0 001:30:58
TOTAL: 4 128 12.9 KB 1 0 041:07:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
91.187.33.87 4.517 1.099 0.00023:59:42
a131033.upc-a.chello.nl 3.057 0.689 0.00014:08:17
ip72-222-200-117.ph.ph.cox.net 0.275 0.048 0.00001:30:58
024-178-046-028.res.spectrum.com 0.260 0.047 0.00001:28:32
192.241.239.112 0.059 0.022 0.00000:00:09
TOTAL: 5 8.168 1.905 0.00041:07:41

Curious NNRP server explorers [Top 20]:

SystemConn
91.187.33.87 72
024-178-046-028.res.spectrum.com 4
ip72-222-200-117.ph.ph.cox.net 3
192.241.239.112 1
TOTAL: 4 80

NNRP client timeouts [Top 20]:

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