Daily Usenet report for csiph.com

Aug 22 04:15:00 -- Aug 23 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 32070 52.0%6.8 MB 66.7%
innd 13833 22.4%1.6 MB 16.2%
nnrpd 12417 20.1%1.2 MB 11.8%
innfeed 3201 5.2%542.9 KB 5.2%
nocem 134 0.2%14.6 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 61656 100.0%10.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 335671 54.5%
Negative hits 248680 40.4%
Do not exist 30756 5.0%
Cache misses 427 0.1%
TOTAL: 4 615534 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.858 0.0%1383 0.000 3.513 252.667
article cleanup00:00:00.224 0.0%30458 0.000 0.007 0.040
article logging00:00:04.963 0.0%31003 0.000 0.160 1.490
article parse00:00:04.282 0.0%88239 0.005 0.049 0.691
article write00:03:34.704 0.2%21487 0.200 9.992 60.304
artlog/artcncl00:00:00.103 0.0%681 0.000 0.151 5.750
artlog/artparse00:00:00.051 0.0%413 0.000 0.123 2.833
data move00:00:00.399 0.0%587325 0.000 0.001 0.069
hisgrep/artcncl00:00:01.259 0.0%923 0.000 1.364 110.167
hishave/artcncl00:00:00.489 0.0%1383 0.000 0.354 35.500
hishave/artparse00:00:00.000 0.0%399 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:46.512 0.2%618139 0.003 0.269 1.676
history sync00:00:02.573 0.0%345 0.000 7.458 112.500
history write00:03:30.798 0.2%30005 1.364 7.025 47.584
hiswrite/artcncl00:00:01.365 0.0%460 0.500 2.967 12.000
hiswrite/artparse00:00:03.069 0.0%395 0.000 7.770 167.000
idle23:41:01.777 98.6%569890 40.578 149.611 481.189
nntp read00:00:03.053 0.0%598103 0.002 0.005 0.039
overview write00:06:58.412 0.5%21487 1.400 19.473 339.637
perl filter00:01:07.665 0.1%29990 1.019 2.256 14.244
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.379 0.0%43102 0.000 0.009 0.030
TOTAL: 24:00:50.72023:59:26.935 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.071 0.0%21473 0.000 0.003 0.024
article prepare00:00:00.001 0.0%18788 0.000 0.000 0.014
article read00:00:01.403 0.0%2651 0.000 0.529 21.500
backlog stats00:00:00.192 0.0%368237 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.998 0.0%296668 0.001 0.007 0.011
data write00:00:01.732 0.0%282611 0.000 0.006 0.012
idle23:53:36.537100.0%368237 73.396 233.590 840.015
status file00:00:00.468 0.0%288 0.000 1.625 32.000
TOTAL: 23:53:51.01023:53:42.402100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.399 0.0%183 0.000 2.180 24.000
idle107:50:00.354 99.9%17326 61.000 22405.6541182364.208
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.208 0.0%35085 0.000 0.006 0.167
readart00:01:47.143 0.0%5182 0.000 20.676 161.000
TOTAL: 107:53:43.865107:51:48.104100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 3 42424 5443 36262 719 12%45:42:19
2csiph-out.feeder.erje.net 1152 91744 4284 83760 3700 4%94:58:41
3feeder.eternal-september.org 2 25065 2712 21274 1079 10%24:13:32
4news-out.mixmin.net 2 22137 2452 19013 672 11%24:08:55
5news.redatomik.org 1 19624 1457 18151 16 7%23:09:58
6newsfeeds.xmission.com 3 19343 1327 18008 8 6%20:49:51
7newsfeed.neva.ru 151 27440 1182 23390 2868 4%71:55:18
8newsfeed.fu-berlin.de 51 22698 1121 21316 261 4%35:00:38
9news-out.aioe.org 4 21154 1070 20057 27 5%24:09:39
10news.fcku.it 2 8461 123 8327 11 1%23:59:44
11news.freedyn.net 2 23630 93 23497 40 0%23:59:43
12news.swapon.de 4 2038 56 1982 0 2%26:38:07
13nntp.pasdenom.info 3 20284 24 20256 4 0%24:08:16
14localhost 45 12 12 0 0 100%00:00:08
15news.bbs.geek.nz 1 20876 5 20871 0 0%23:59:46
16xanadu-bbs.net 13 785 4 781 0 0%25:51:17
TOTAL: 16 1439 367715 21365 336945 9405 5%512:45:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.weretis.net16.2 MB1.9 KB10.6 MB26.8 MB 60%4.5 KB
2csiph-out.feeder.erje.net16.1 MB6.2 KB20.2 MB36.4 MB 44%4.7 KB
3news-out.mixmin.net8.4 MB1.4 KB2.0 MB10.4 MB 80%3.4 KB
4feeder.eternal-september.org7.9 MB6.4 KB8.5 MB16.5 MB 48%4.4 KB
5newsfeeds.xmission.com3.6 MB0.0 KB304.3 KB3.9 MB 92%3.0 KB
6news-out.aioe.org3.6 MB4.9 KB46.2 KB3.6 MB 98%3.4 KB
7news.redatomik.org3.3 MB24.7 KB179.6 KB3.5 MB 94%2.5 KB
8newsfeed.neva.ru3.0 MB10.6 MB28.6 MB42.2 MB 7%10.7 KB
9newsfeed.fu-berlin.de2.5 MB0.0 KB593.6 KB3.1 MB 81%2.3 KB
10news.freedyn.net410.2 KB0.0 KB455.8 KB866.0 KB 47%6.5 KB
11news.fcku.it207.4 KB0.0 KB343.3 KB550.7 KB 37%4.1 KB
12news.swapon.de178.8 KB0.0 KB0.0 KB178.8 KB100%3.2 KB
13nntp.pasdenom.info65.6 KB0.0 KB2.9 KB68.4 KB 95%2.4 KB
14localhost25.2 KB0.0 KB0.0 KB25.2 KB100%2.1 KB
15news.bbs.geek.nz10.1 KB0.0 KB0.0 KB10.1 KB100%2.0 KB
16xanadu-bbs.net7.6 KB0.0 KB0.0 KB7.6 KB100%1.9 KB
TOTAL: 1665.5 MB10.6 MB71.9 MB148.0 MB 44%4.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 22 04:15:00 - 04:59:59 364 1.7% 0.131.8 MB 2.8% 0.69
Aug 22 05:00:00 - 05:59:59 512 2.4% 0.142.0 MB 3.1% 0.58
Aug 22 06:00:00 - 06:59:59 572 2.7% 0.162.0 MB 3.1% 0.58
Aug 22 07:00:00 - 07:59:59 802 3.7% 0.222.4 MB 3.7% 0.69
Aug 22 08:00:00 - 08:59:59 1041 4.8% 0.293.4 MB 5.1% 0.96
Aug 22 09:00:00 - 09:59:59 916 4.3% 0.252.2 MB 3.4% 0.64
Aug 22 10:00:00 - 10:59:59 957 4.5% 0.272.8 MB 4.3% 0.80
Aug 22 11:00:00 - 11:59:59 966 4.5% 0.272.6 MB 4.0% 0.75
Aug 22 12:00:00 - 12:59:59 908 4.2% 0.252.8 MB 4.2% 0.79
Aug 22 13:00:00 - 13:59:59 1126 5.2% 0.313.6 MB 5.5% 1.03
Aug 22 14:00:00 - 14:59:59 1093 5.1% 0.303.4 MB 5.2% 0.97
Aug 22 15:00:00 - 15:59:59 1203 5.6% 0.333.3 MB 5.0% 0.94
Aug 22 16:00:00 - 16:59:59 1667 7.8% 0.464.6 MB 7.0% 1.31
Aug 22 17:00:00 - 17:59:59 1222 5.7% 0.343.5 MB 5.3% 0.99
Aug 22 18:00:00 - 18:59:59 1136 5.3% 0.323.9 MB 5.9% 1.11
Aug 22 19:00:00 - 19:59:59 1373 6.4% 0.384.0 MB 6.0% 1.13
Aug 22 20:00:00 - 20:59:59 1130 5.3% 0.313.0 MB 4.6% 0.87
Aug 22 21:00:00 - 21:59:59 922 4.3% 0.262.6 MB 4.0% 0.74
Aug 22 22:00:00 - 22:59:59 846 3.9% 0.232.8 MB 4.3% 0.81
Aug 22 23:00:00 - 23:59:59 678 3.2% 0.192.0 MB 3.1% 0.57
Aug 23 00:00:00 - 00:59:59 554 2.6% 0.151.8 MB 2.7% 0.51
Aug 23 01:00:00 - 01:59:59 493 2.3% 0.141.7 MB 2.5% 0.47
Aug 23 02:00:00 - 02:59:59 434 2.0% 0.121.6 MB 2.4% 0.46
Aug 23 03:00:00 - 03:59:59 438 2.0% 0.121.4 MB 2.2% 0.40
Aug 23 04:00:00 - 04:15:00 123 0.6% 0.14369.2 KB 0.5% 0.41
TOTAL: 24:00:00 21476 100.0% 0.2565.8 MB 100.0% 0.78
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 3745 744 0 3 0 0 0 0 2998
2newsfeed.neva.ru 2852 249 0 442 0 0 0 0 2161
3feeder.eternal-september.org 1081 58 0 4 0 0 0 0 1019
4csiph-out.news.weretis.net 762 255 0 1 0 0 0 0 506
5news-out.mixmin.net 682 2 0 1 0 0 0 0 679
6newsfeed.fu-berlin.de 658 33 0 0 0 0 0 0 625
7news.freedyn.net 40 8 0 0 0 0 0 0 32
8news-out.aioe.org 28 17 0 3 0 0 0 0 8
9news.redatomik.org 25 0 0 11 0 0 0 0 14
10newsfeeds.xmission.com 15 2 0 0 0 0 0 0 13
11news.fcku.it 14 2 0 1 0 0 0 0 11
12news.swapon.de 8 0 0 0 0 0 0 0 8
13nntp.pasdenom.info 4 0 0 1 0 0 0 0 3
TOTAL: 13 9914 1370 0 467 0 0 0 0 8077

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.homeporn 361
ut.test 108
gmane.linux.alsa.devel 99
it.annunci.commerciali 60
it.annunci.immobiliari 58
lada.talk 56
it.annunci.varie 55
alt.survival 41
gmane.comp.gis.openstreetmap 36
it-alt.sport.calcio.juventus 36
mozilla.governance 33
gmane.linux.kernel 29
alt.computer.workshop 27
lada.photo 27
lada.auto 23
spline.eisfair 15
mozilla.support.seamonkey 14
lada.commerce 12
lada.kitchen 11
mpc.lists.nanog 10
TOTAL: 119 1370

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5627
EMP (phn path) 600
Binary Image: misplaced jpg 527
EMP (phn nph) 154
Too many newsgroups 56
Binary Payload 30
HTML Multipart 23
Too many newsgroups (low_xpost) 21
Scoring filter (9) 19
User-issued cancel 16
Scoring filter (10) 8
Scoring filter (8) 8
Scoring filter (14) 5
Scoring filter (11) 5
Scoring filter (13) 4
Scoring filter (16) 3
Cancel for rejected article 3
Scoring filter (12) 3
EMP (phl) 2
Scoring filter (20) 1
TOTAL: 21 7116

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1270708708
TOTAL: 11271708708

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
csiph-out.feeder.erje.net 177
csiph-out.news.weretis.net 152
feeder.eternal-september.org 38
news-out.mixmin.net 14
newsfeeds.xmission.com 6
news.freedyn.net 4
news.fcku.it 3
newsfeed.fu-berlin.de 3
news.redatomik.org 2
TOTAL: 9 399
Including strange strings
newsfeed.fu-berlin.de 417
csiph-out.feeder.erje.net 46
news-out.mixmin.net 28
csiph-out.news.weretis.net 26
news.redatomik.org 8
news.swapon.de 8
newsfeeds.xmission.com 7
feeder.eternal-september.org 3
news.fcku.it 2
newsfeed.neva.ru 1
TOTAL: 11 547
No colon-space in header
csiph-out.feeder.erje.net 14
TOTAL: 1 14
TOTAL: 3 960

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 38132 974 19842 84 0 0 2%23:53:01
2news.freedyn.net 22385 708 20593 6 0 0 3%23:50:05
3xanadu-bbs 23828 683 20772 17 0 35 2%23:59:55
4fu-berlin.de 20161 485 19675 0 0 0 2%23:55:26
5usenet.pasdenom.info 21777 120 19964 1369 0 9 0%23:59:55
6aioe 18576 47 17724 2 0 0 0%23:53:43
7erje 17504 24 16915 5 0 0 0%23:50:05
8neva.ru 19694 16 19445 76 0 0 0%23:59:48
9news.redatomik.org 20017 15 19360 0 0 0 0%23:50:05
10weretis.net 15390 14 14884 1 0 0 0%23:50:05
11eternal-september 18529 13 18041 2 0 0 0%23:59:51
12xmission 20967 13 19490 0 0 0 0%23:59:55
13news.mixmin.net 18441 12 18151 0 0 0 0%23:50:05
14news.swapon.de 1950 11 1922 0 0 0 0%23:52:55
15bwh 0 0 0 0 0 20881 0%23:50:09
16news.fcku.it 2028 0 2000 0 0 0 0%23:10:24
17au2pb 0 0 0 0 0 20890 0%23:50:09
TOTAL: 17 279379 3135 248778 1562 0 41815 1%405:35:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net6.3 MB21.3 KB6.3 MB0.1 KB/s9.0 KB23:50:05
2xanadu-bbs6.1 MB72.2 KB6.2 MB0.1 KB/s9.1 KB23:59:55
3fu-berlin.de5.6 MB0.0 KB5.6 MB0.1 KB/s11.9 KB23:55:26
4news.bbs.geek.nz2.7 MB276.1 KB2.9 MB0.0 KB/s2.8 KB23:53:01
5usenet.pasdenom.info355.5 KB7.2 MB7.6 MB0.1 KB/s5.2 KB23:59:55
6aioe96.5 KB4.1 KB100.7 KB0.0 KB/s2.1 KB23:53:43
7erje47.7 KB9.7 KB57.4 KB0.0 KB/s2.0 KB23:50:05
8weretis.net32.2 KB2.1 KB34.4 KB0.0 KB/s2.3 KB23:50:05
9news.redatomik.org28.9 KB0.0 KB28.9 KB0.0 KB/s1.9 KB23:50:05
10eternal-september27.1 KB4.2 KB31.3 KB0.0 KB/s2.1 KB23:59:51
11xmission26.1 KB0.0 KB26.1 KB0.0 KB/s2.0 KB23:59:55
12news.mixmin.net25.2 KB0.0 KB25.2 KB0.0 KB/s2.1 KB23:50:05
13neva.ru24.9 KB171.5 KB196.4 KB0.0 KB/s2.1 KB23:59:48
14news.swapon.de24.0 KB0.0 KB24.0 KB0.0 KB/s2.2 KB23:52:55
15bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:09
16news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s023:10:24
17au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:09
TOTAL: 1721.4 MB7.8 MB29.1 MB0.0 KB/s6.3 KB405:35:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1144.138.90.254 48 52129.9 KB 37 0 000:37:02
2bas2-montrealak-70-49-69-223.dsl.bell.ca 450 50133.4 KB 33 0 000:38:10
371-90-73-201.dhcp.ftbg.wi.charter.com 35 1225.2 KB 12 12 808:42:32
4194-73-239-109.cust.centrio.cz 10 616.2 KB 6 0 004:28:09
5a131033.upc-a.chello.nl 86 11.7 KB 1 0 028:10:30
TOTAL: 5 629 121306.5 KB 89 12 8107:53:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 91 52129.9 KB 37 0 063:09:40
2*.dsl.bell.ca 450 50133.4 KB 33 0 000:38:10
3*.dhcp.ftbg.wi.charter.com 35 1225.2 KB 12 12 808:42:32
4*.cust.centrio.cz 10 616.2 KB 6 0 004:28:09
5*.upc-a.chello.nl 86 11.7 KB 1 0 028:10:30
6*.bbox.io 4 00.0 KB 0 0 002:00:09
7*.nielsenmedia.com 3 00.0 KB 0 0 000:44:24
8*.208-100-26.static.steadfastdns.net 2 00.0 KB 0 0 000:00:01
TOTAL: 8 681 121306.5 KB 89 12 8107:53:38

NNRP auth users [Top 20]:

UserConn
moussa 48
ctomczyk 10
ohlandl 8
TOTAL: 3 66

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
216.239.174.160 2.779 0.527 0.00062:32:35
a131033.upc-a.chello.nl 6.633 1.212 0.00028:10:30
71-90-73-201.dhcp.ftbg.wi.charter.com 3.111 0.460 0.03408:42:32
194-73-239-109.cust.centrio.cz 1.115 0.199 0.04504:28:09
tempe0.bbox.io 0.446 0.060 0.00002:00:09
challenger.nielsenmedia.com 0.222 0.054 0.00000:44:24
bas2-montrealak-70-49-69-223.dsl.bell.ca 41.324 6.871 0.00000:38:10
144.138.90.254 5.439 1.114 0.25300:37:02
94.161.135.102 0.093 0.008 0.00000:00:01
ip232.208-100-26.static.steadfastdns.net 0.117 0.008 0.00000:00:01
TOTAL: 10 61.279 10.513 0.332107:53:38

Curious NNRP server explorers [Top 20]:

SystemConn
216.239.174.160 42
tempe0.bbox.io 4
challenger.nielsenmedia.com 3
ip232.208-100-26.static.steadfastdns.net 2
94.161.135.102 1
TOTAL: 5 52

NNRP client timeouts [Top 20]:

SystemConnPeer
216.239.174.160 35 0
71-90-73-201.dhcp.ftbg.wi.charter.com 9 0
194-73-239-109.cust.centrio.cz 8 0
tempe0.bbox.io 4 0
challenger.nielsenmedia.com 1 0
TOTAL: 5 57 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 75 62.0%
2uk 17 14.0%
3rec 16 13.2%
4alt 10 8.3%
5talk 2 1.7%
6sci 1 0.8%
TOTAL: 6 121100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 25
2comp.arch 22
3uk.legal 7
4comp.lang.javascript 6
5comp.os.msdos.misc 5
6uk.media.radio.archers 5
7rec.crafts.metalworking 5
8alt.usage.english 4
9comp.sys.ibm.pc.hardware.storage 3
10rec.boats 3
11uk.d-i-y 3
12rec.arts.tv.uk.coronation-st 3
13alt.atheism 2
14rec.sport.tennis 2
15talk.politics.misc 2
16rec.food.cooking 2
17comp.sys.ibm.pc.games.action 2
18comp.os.vms 2
19alt.sports.football.pro.sd-chargers 2
20comp.lang.python 2
21comp.sys.ibm.pc.hardware.chips 1
22rec.arts.sf.written 1
23uk.net.news.moderation 1
24comp.os.os2.misc 1
25comp.lang.c 1
26alt.russian.z1 1
27comp.lang.clipper.visual-objects 1
28comp.os.msdos.programmer 1
29alt.home.repair 1
30sci.military.naval 1
31uk.politics.misc 1
32comp.windows.x.kde 1
33comp.unix.aix 1
34comp.arch.embedded 1
TOTAL: 34 121