Daily Usenet report for csiph.com

Feb 6 04:15:00 -- Feb 7 04:15:00

Unknown entries from news log file:

First 28 / 28 lines (100.0%)

Feb 6 07:37:00 csiph nnrpd[2839]: 45.32.172.196 noperm ihave without permission
Feb 6 07:37:13 csiph nnrpd[2840]: 45.32.172.196 noperm ihave without permission
Feb 6 07:42:00 csiph nnrpd[3121]: 45.32.172.196 noperm ihave without permission
Feb 6 07:42:00 csiph nnrpd[3122]: 45.32.172.196 noperm ihave without permission
Feb 6 07:42:02 csiph nnrpd[3120]: 45.32.172.196 noperm ihave without permission
Feb 6 07:47:00 csiph nnrpd[3276]: 45.32.172.196 noperm ihave without permission
Feb 6 07:47:00 csiph nnrpd[3275]: 45.32.172.196 noperm ihave without permission
Feb 6 07:47:00 csiph nnrpd[3277]: 45.32.172.196 noperm ihave without permission
Feb 6 07:52:00 csiph nnrpd[3546]: 45.32.172.196 noperm ihave without permission
Feb 6 07:52:00 csiph nnrpd[3547]: 45.32.172.196 noperm ihave without permission
Feb 6 07:52:00 csiph nnrpd[3548]: 45.32.172.196 noperm ihave without permission
Feb 6 07:52:00 csiph nnrpd[3549]: 45.32.172.196 noperm ihave without permission
Feb 6 07:57:00 csiph nnrpd[3701]: 45.32.172.196 noperm ihave without permission
Feb 6 07:57:00 csiph nnrpd[3703]: 45.32.172.196 noperm ihave without permission
Feb 6 07:57:00 csiph nnrpd[3702]: 45.32.172.196 noperm ihave without permission
Feb 6 07:57:00 csiph nnrpd[3700]: 45.32.172.196 noperm ihave without permission
Feb 6 08:02:00 csiph nnrpd[3995]: 45.32.172.196 noperm ihave without permission
Feb 6 08:02:00 csiph nnrpd[3996]: 45.32.172.196 noperm ihave without permission
Feb 6 08:02:00 csiph nnrpd[3997]: 45.32.172.196 noperm ihave without permission
Feb 6 08:02:00 csiph nnrpd[3998]: 45.32.172.196 noperm ihave without permission
Feb 6 08:07:00 csiph nnrpd[4126]: 45.32.172.196 noperm ihave without permission
Feb 6 08:07:00 csiph nnrpd[4128]: 45.32.172.196 noperm ihave without permission
Feb 6 08:07:00 csiph nnrpd[4127]: 45.32.172.196 noperm ihave without permission
Feb 6 08:07:00 csiph nnrpd[4129]: 45.32.172.196 noperm ihave without permission
Feb 6 08:12:00 csiph nnrpd[4440]: 45.32.172.196 noperm ihave without permission
Feb 6 08:12:00 csiph nnrpd[4441]: 45.32.172.196 noperm ihave without permission
Feb 6 08:12:00 csiph nnrpd[4442]: 45.32.172.196 noperm ihave without permission
Feb 6 08:12:00 csiph nnrpd[4443]: 45.32.172.196 noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 20369 47.7%5.3 MB 63.6%
innd 18321 42.9%2.4 MB 28.3%
innfeed 3495 8.2%640.4 KB 7.5%
nnrpd 461 1.1%48.6 KB 0.6%
nocem 29 0.1%3.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 42676 100.0%8.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 339343 57.0%
Negative hits 236049 39.6%
Do not exist 19769 3.3%
Cache misses 325 0.1%
TOTAL: 4 595486 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.477 0.0%32 0.000 14.906 42.600
article cleanup00:00:00.112 0.0%19352 0.000 0.006 0.034
article logging00:00:00.277 0.0%19859 0.000 0.014 0.284
article parse00:00:01.890 0.0%61366 0.000 0.031 0.315
article write00:00:09.594 0.0%16386 0.169 0.585 11.045
artlog/artcncl00:00:00.000 0.0%32 0.000 0.000 0.000
artlog/artparse00:00:00.006 0.0%476 0.000 0.013 1.000
data move00:00:00.152 0.0%550772 0.000 0.000 0.002
hisgrep/artcncl00:00:00.053 0.0%32 0.000 1.656 3.000
hishave/artcncl00:00:00.006 0.0%32 0.000 0.188 0.300
hishave/artparse00:00:00.001 0.0%473 0.000 0.002 0.050
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:42.620 0.0%596742 0.003 0.071 0.699
history sync00:00:00.869 0.0%369 0.000 2.355 16.667
history write00:00:54.274 0.1%19354 0.443 2.804 14.250
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:01.330 0.0%470 0.000 2.830 29.000
idle23:57:21.458 99.7%557609 88.195 154.663 540.786
nntp read00:00:02.152 0.0%562576 0.001 0.004 0.008
overview write00:00:47.566 0.1%16386 0.113 2.903 284.740
perl filter00:00:25.360 0.0%19349 1.030 1.311 2.108
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.278 0.0%32801 0.000 0.008 0.032
TOTAL: 24:01:00.47024:00:28.475100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.040 0.0%17058 0.000 0.002 0.020
article prepare00:00:00.001 0.0%13072 0.000 0.000 0.011
article read00:00:00.284 0.0%1138 0.000 0.250 16.500
backlog stats00:00:00.210 0.0%386306 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.376 0.0%303471 0.001 0.005 0.008
data write00:00:01.717 0.0%290850 0.000 0.006 0.011
idle23:53:49.098100.0%386306 128.548 222.697 642.043
status file00:00:00.193 0.0%281 0.000 0.687 13.000
TOTAL: 23:53:59.88223:53:52.919100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle11:34:46.449100.0%274 0.000152140.325600082.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.651 0.0%95280 0.000 0.007 0.143
readart00:00:00.054 0.0%7 0.000 7.714 42.000
TOTAL: 11:35:03.87911:34:47.154100.0%----

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
1csiph-out.feeder.erje.net 1440 81751 3858 77346 547 4%118:42:39
2news-out.aioe.org 3 16161 3084 13003 74 19%24:09:55
3feeder.eternal-september.org 3 17427 2322 14794 311 13%22:41:18
4newsfeeds.xmission.com 3 15923 1352 14547 24 8%24:04:27
5csiph-out.news.xs4all.nl 861 18132 1115 15979 1038 6%71:25:45
6csiph-out.news.weretis.net 4 35119 1013 33916 190 2%50:57:56
7newsfeed.fu-berlin.de 12 18775 924 17649 202 4%29:50:39
8news-out.mixmin.net 2 17146 841 16013 292 4%24:08:59
9newsfeed.neva.ru 147 17166 827 15895 444 4%71:36:09
10news.freedyn.net 2 19112 344 18681 87 1%23:59:55
11news.fcku.it 8 2092 235 1850 7 11%21:18:04
12csiph-out.feed.uzoreto.com 864 25850 201 25435 214 0%71:12:30
13nntp.pasdenom.info 2 11472 118 11341 13 1%23:59:54
14csiph-out.news.tnetconsulting.net 2 16099 82 16001 16 0%23:59:52
15news-out.neodome.net 2 17118 71 17021 26 0%23:59:41
16news.swapon.de 5 1404 28 1376 0 1%23:49:52
17news.bbs.nz 1 15906 8 15898 0 0%23:59:53
18news.samoylyk.net 2 16410 7 16402 1 0%23:48:36
19localhost 27 1 1 0 0 100%00:00:04
20xanadu-bbs.net 117 564 0 564 0 0%111:09:08
TOTAL: 20 3507 363628 16431 343711 3486 4%808:55:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net13.5 MB0.0 KB11.6 MB25.1 MB 53%5.8 KB
2news-out.aioe.org7.3 MB0.0 KB247.0 KB7.5 MB 96%2.4 KB
3feeder.eternal-september.org5.9 MB0.0 KB3.1 MB9.0 MB 65%3.5 KB
4newsfeeds.xmission.com4.6 MB0.0 KB1.7 MB6.3 MB 73%4.7 KB
5csiph-out.news.xs4all.nl3.8 MB0.0 KB11.6 MB15.3 MB 24%7.3 KB
6csiph-out.news.weretis.net2.9 MB0.0 KB2.5 MB5.4 MB 53%4.6 KB
7newsfeed.fu-berlin.de2.3 MB0.0 KB548.1 KB2.9 MB 81%2.6 KB
8news-out.mixmin.net2.2 MB0.0 KB616.7 KB2.8 MB 78%2.6 KB
9newsfeed.neva.ru1.7 MB0.0 KB1.2 MB2.9 MB 60%2.3 KB
10news.freedyn.net1.2 MB2.7 KB1.3 MB2.6 MB 47%6.1 KB
11csiph-out.feed.uzoreto.com816.3 KB0.0 KB9.3 MB10.1 MB 7%24.9 KB
12news.fcku.it437.7 KB0.0 KB9.8 KB447.5 KB 97%1.8 KB
13csiph-out.news.tnetconsulting.net288.5 KB0.0 KB213.9 KB502.4 KB 57%5.1 KB
14nntp.pasdenom.info246.8 KB0.0 KB20.7 KB267.5 KB 92%2.0 KB
15news-out.neodome.net201.3 KB0.0 KB780.3 KB981.6 KB 20%10.1 KB
16news.swapon.de72.6 KB0.0 KB0.0 KB72.6 KB100%2.6 KB
17news.samoylyk.net21.0 KB0.0 KB950.9 KB971.9 KB 2%121.5 KB
18news.bbs.nz9.1 KB0.0 KB0.0 KB9.1 KB100%1.1 KB
19localhost0.9 KB0.0 KB0.0 KB0.9 KB100%0.9 KB
20xanadu-bbs.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2047.5 MB2.7 KB45.6 MB93.1 MB 50%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 6 04:15:00 - 04:59:59 287 1.8% 0.11980.8 KB 2.0% 0.36
Feb 6 05:00:00 - 05:59:59 372 2.3% 0.101.6 MB 3.4% 0.46
Feb 6 06:00:00 - 06:59:59 423 2.6% 0.121.2 MB 2.5% 0.33
Feb 6 07:00:00 - 07:59:59 495 3.0% 0.141.7 MB 3.5% 0.47
Feb 6 08:00:00 - 08:59:59 581 3.5% 0.161.4 MB 3.0% 0.41
Feb 6 09:00:00 - 09:59:59 703 4.3% 0.201.8 MB 3.8% 0.51
Feb 6 10:00:00 - 10:59:59 709 4.3% 0.201.9 MB 4.1% 0.55
Feb 6 11:00:00 - 11:59:59 740 4.5% 0.212.1 MB 4.5% 0.60
Feb 6 12:00:00 - 12:59:59 858 5.2% 0.242.0 MB 4.3% 0.58
Feb 6 13:00:00 - 13:59:59 855 5.2% 0.242.1 MB 4.4% 0.59
Feb 6 14:00:00 - 14:59:59 898 5.5% 0.252.4 MB 5.0% 0.67
Feb 6 15:00:00 - 15:59:59 1032 6.3% 0.293.5 MB 7.5% 1.01
Feb 6 16:00:00 - 16:59:59 840 5.1% 0.232.3 MB 4.8% 0.65
Feb 6 17:00:00 - 17:59:59 903 5.5% 0.252.2 MB 4.7% 0.64
Feb 6 18:00:00 - 18:59:59 932 5.7% 0.262.2 MB 4.7% 0.63
Feb 6 19:00:00 - 19:59:59 943 5.8% 0.262.9 MB 6.2% 0.84
Feb 6 20:00:00 - 20:59:59 853 5.2% 0.242.7 MB 5.6% 0.76
Feb 6 21:00:00 - 21:59:59 716 4.4% 0.202.2 MB 4.7% 0.63
Feb 6 22:00:00 - 22:59:59 816 5.0% 0.232.1 MB 4.5% 0.60
Feb 6 23:00:00 - 23:59:59 610 3.7% 0.172.0 MB 4.3% 0.58
Feb 7 00:00:00 - 00:59:59 559 3.4% 0.162.0 MB 4.3% 0.58
Feb 7 01:00:00 - 01:59:59 490 3.0% 0.141.4 MB 3.0% 0.40
Feb 7 02:00:00 - 02:59:59 422 2.6% 0.121.2 MB 2.6% 0.35
Feb 7 03:00:00 - 03:59:59 275 1.7% 0.081.1 MB 2.4% 0.33
Feb 7 04:00:00 - 04:15:00 71 0.4% 0.08193.7 KB 0.4% 0.22
TOTAL: 24:00:00 16383 100.0% 0.1947.4 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.news.xs4all.nl 1049 55 0 0 0 0 0 0 994
2csiph-out.feeder.erje.net 553 87 0 0 0 0 0 0 466
3newsfeed.fu-berlin.de 533 88 0 0 0 0 0 0 445
4newsfeed.neva.ru 444 61 0 0 0 0 0 0 383
5feeder.eternal-september.org 317 11 0 0 0 0 0 0 306
6news-out.mixmin.net 312 9 0 0 0 0 0 0 303
7csiph-out.feed.uzoreto.com 216 7 0 0 0 0 0 0 209
8csiph-out.news.weretis.net 203 90 0 0 0 0 0 0 113
9news-out.aioe.org 163 56 0 0 0 0 0 0 107
10news.freedyn.net 87 4 0 1 0 0 0 0 82
11news-out.neodome.net 26 1 0 0 0 0 0 0 25
12newsfeeds.xmission.com 24 0 0 0 0 0 0 0 24
13nntp.pasdenom.info 13 0 0 0 0 0 0 0 13
14news.fcku.it 7 6 0 0 0 0 0 0 1
15news.swapon.de 4 0 0 0 0 0 0 0 4
16csiph-out.news.tnetconsulting.net 2 1 0 0 0 0 0 0 1
17news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 17 3954 476 0 1 0 0 0 0 3477

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.computer.workshop 114
spline.eisfair 79
lada.auto 24
alt.politics.usa 22
it-alt.sport.calcio.juventus 19
isp.tech 17
lada.talk 16
mozilla.support.thunderbird 14
mozilla.dev.platform 12
alt.bbs.synchronet 12
mozilla.dev.l10n 11
alt.music.pink-floyd.publius 10
mozilla.support.seamonkey 8
alt.binaries.ebooks 7
alt.windows7.general 7
oesterreich.tratsch 7
mozilla.dev.security.policy 6
alt.survival 5
mozilla.general 4
alt.christian.bible 4
TOTAL: 75 476

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1830
EMP (phn path) 218
EMP (phl) 169
0 105
EMP (phn nph) 85
HTML Multipart 24
Too many newsgroups 17
Scoring filter 15
Binary Payload 9
Binary: misplaced binary 9
Too many newsgroups (meow) 4
Too many newsgroups (low_xpost) 1
TOTAL: 12 2486

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 205
csiph-out.news.xs4all.nl 121
csiph-out.feed.uzoreto.com 71
newsfeeds.xmission.com 23
csiph-out.news.weretis.net 22
news-out.neodome.net 12
news.freedyn.net 11
feeder.eternal-september.org 7
news-out.mixmin.net 2
csiph-out.news.tnetconsulting.net 1
TOTAL: 11 476
Including strange strings
newsfeed.fu-berlin.de 352
news-out.aioe.org 89
csiph-out.news.weretis.net 28
news-out.mixmin.net 19
csiph-out.news.xs4all.nl 6
csiph-out.feeder.erje.net 5
news.swapon.de 4
news.freedyn.net 3
newsfeed.neva.ru 2
TOTAL: 9 508
No colon-space in header
csiph-out.news.xs4all.nl 2
csiph-out.feeder.erje.net 2
TOTAL: 2 4
TOTAL: 4 1033

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 21104 724 15656 4 0 0 3%23:59:52
2news.freedyn.net 16345 491 15520 18 0 0 3%23:59:55
3news.samoylyk.net 17890 427 15945 3 0 548 2%23:59:55
4fu-berlin.de 15399 411 14988 0 0 0 2%23:59:43
5news.bbs.nz 31092 330 15606 11 0 0 1%23:59:55
6usenet.pasdenom.info 16622 163 15639 31 0 0 0%23:59:45
7tnet 17870 94 15860 0 0 0 0%23:59:49
8neva.ru 15022 83 14668 101 0 0 0%23:59:50
9aioe 12600 67 12129 0 0 0 0%23:59:55
10newsfeed.xs4all.nl 15855 50 15107 12 0 138 0%23:59:55
11erje 12336 18 12113 136 0 0 0%23:59:34
12neodome.net 16832 16 16228 0 0 0 0%23:59:55
13news.uzoreto.com 15969 10 15588 54 0 0 0%23:59:47
14news.mixmin.net 15439 7 14891 0 0 0 0%23:59:39
15xmission 16147 3 14626 0 0 10 0%23:59:51
16weretis.net 15249 2 14766 0 0 0 0%23:59:50
17news.swapon.de 1515 1 1499 0 0 0 0%23:25:19
18eternal-september 13941 1 13380 0 0 0 0%23:59:29
19news.fcku.it 1676 0 1659 0 0 0 0%20:38:35
TOTAL: 19 288903 2898 255868 370 0 696 1%452:00:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs5.4 MB24.0 KB5.4 MB0.1 KB/s7.6 KB23:59:52
2news.freedyn.net4.8 MB25.9 KB4.8 MB0.1 KB/s9.6 KB23:59:55
3news.samoylyk.net4.5 MB3.1 KB4.5 MB0.1 KB/s10.7 KB23:59:55
4fu-berlin.de4.5 MB0.0 KB4.5 MB0.1 KB/s11.2 KB23:59:43
5news.bbs.nz907.8 KB88.5 KB996.4 KB0.0 KB/s2.9 KB23:59:55
6usenet.pasdenom.info538.3 KB124.9 KB663.3 KB0.0 KB/s3.4 KB23:59:45
7tnet272.1 KB0.0 KB272.1 KB0.0 KB/s2.9 KB23:59:49
8neva.ru192.0 KB241.0 KB433.0 KB0.0 KB/s2.4 KB23:59:50
9aioe189.4 KB0.0 KB189.4 KB0.0 KB/s2.8 KB23:59:55
10newsfeed.xs4all.nl156.1 KB58.6 KB214.7 KB0.0 KB/s3.5 KB23:59:55
11neodome.net104.9 KB0.0 KB104.9 KB0.0 KB/s6.6 KB23:59:55
12erje40.9 KB451.5 KB492.4 KB0.0 KB/s3.2 KB23:59:34
13news.uzoreto.com17.7 KB318.0 KB335.7 KB0.0 KB/s5.2 KB23:59:47
14news.mixmin.net16.8 KB0.0 KB16.8 KB0.0 KB/s2.4 KB23:59:39
15xmission11.8 KB0.0 KB11.8 KB0.0 KB/s3.9 KB23:59:51
16weretis.net2.8 KB0.0 KB2.8 KB0.0 KB/s1.4 KB23:59:50
17news.swapon.de0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:25:19
18eternal-september0.9 KB0.0 KB0.9 KB0.0 KB/s0.9 KB23:59:29
19news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s020:38:35
TOTAL: 1921.5 MB1.3 MB22.9 MB0.0 KB/s7.2 KB452:00:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.160.37.57 1 59.5 KB 2 0 000:33:28
266-188-83-159.dhcp.mdsn.wi.charter.com 7 10.9 KB 1 1 102:12:58
3a131033.upc-a.chello.nl 42 14.9 KB 1 0 008:17:40
TOTAL: 3 50 715.3 KB 4 1 111:35:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 30 59.5 KB 2 0 000:34:19
2*.dhcp.mdsn.wi.charter.com 7 10.9 KB 1 1 102:12:58
3*.upc-a.chello.nl 42 14.9 KB 1 0 008:17:40
4*.us-west-2.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
5*.hsd1.wa.comcast.net 1 00.0 KB 0 0 000:30:04
TOTAL: 5 81 715.3 KB 4 1 111:35:03

NNRP auth users [Top 20]:

UserConn
ohlandl 1
kev009 1
TOTAL: 2 2

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
a131033.upc-a.chello.nl 2.640 0.656 0.00008:17:40
66-188-83-159.dhcp.mdsn.wi.charter.com 0.504 0.094 0.00302:12:58
69.160.37.57 0.372 1.132 0.00300:33:28
c-73-140-175-55.hsd1.wa.comcast.net 0.077 0.000 0.00000:30:04
45.32.172.196 1.731 0.342 0.00000:00:49
94.161.242.156 0.068 0.008 0.00000:00:01
ec2-54-187-107-74.us-west-2.compute.amazonaws.com 0.048 0.032 0.00000:00:00
TOTAL: 7 5.440 2.264 0.00611:35:03

Curious NNRP server explorers [Top 20]:

SystemConn
45.32.172.196 28
c-73-140-175-55.hsd1.wa.comcast.net 1
ec2-54-187-107-74.us-west-2.compute.amazonaws.com 1
94.161.242.156 1
TOTAL: 4 31

NNRP client timeouts [Top 20]:

SystemConnPeer
66-188-83-159.dhcp.mdsn.wi.charter.com 4 0
69.160.37.57 1 0
c-73-140-175-55.hsd1.wa.comcast.net 1 0
TOTAL: 3 6 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 7100.0%
TOTAL: 1 7100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 5
2comp.unix.aix 2
TOTAL: 2 7