Daily Usenet report for csiph.com

Jun 4 04:15:01 -- Jun 5 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 28944 54.1%6.1 MB 68.2%
innd 15174 28.4%1.8 MB 20.4%
nnrpd 6156 11.5%528.3 KB 5.8%
innfeed 3165 5.9%517.6 KB 5.6%
nocem 53 0.1%5.2 KB 0.1%
TOTAL: 5 53492 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 341281 56.2%
Negative hits 237496 39.1%
Do not exist 28179 4.6%
Cache misses 348 0.1%
TOTAL: 4 607304 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.769 0.0%183 0.000 9.667 126.167
article cleanup00:00:00.204 0.0%27580 0.000 0.007 0.028
article logging00:00:04.642 0.0%28175 0.000 0.165 3.252
article parse00:00:04.836 0.0%96157 0.000 0.050 0.530
article write00:03:52.806 0.3%19567 0.122 11.898 107.378
artlog/artcncl00:00:00.041 0.0%146 0.000 0.281 4.000
artlog/artparse00:00:00.094 0.0%629 0.000 0.149 18.000
data move00:00:00.224 0.0%593267 0.000 0.000 0.002
hisgrep/artcncl00:00:00.603 0.0%183 0.000 3.295 33.833
hishave/artcncl00:00:00.251 0.0%183 0.000 1.372 28.500
hishave/artparse00:00:00.001 0.0%624 0.000 0.002 0.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:57.528 0.2%607345 0.002 0.292 2.422
history sync00:00:03.825 0.0%360 0.000 10.625 167.667
history write00:03:18.349 0.2%27584 0.085 7.191 53.985
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:03.473 0.0%624 0.000 5.566 98.000
idle23:42:27.324 98.7%575508 55.646 148.299 404.197
nntp read00:00:02.819 0.0%604088 0.002 0.005 0.022
overview write00:05:42.130 0.4%19567 1.477 17.485 182.554
perl filter00:01:01.074 0.1%27417 1.429 2.228 5.311
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.392 0.0%39180 0.000 0.010 0.028
TOTAL: 24:00:57.84123:59:42.385 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.079 0.0%19657 0.000 0.004 0.025
article prepare00:00:00.003 0.0%21484 0.000 0.000 0.016
article read00:00:01.390 0.0%2855 0.000 0.487 153.000
backlog stats00:00:00.195 0.0%341784 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.956 0.0%269073 0.003 0.007 0.013
data write00:00:01.547 0.0%253463 0.001 0.006 0.014
idle23:53:20.602100.0%341784 144.528 251.623 618.177
status file00:00:00.488 0.0%293 0.000 1.666 117.000
TOTAL: 23:53:35.08523:53:26.260100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.009 0.0%1 9.000 9.000 9.000
idle20:53:39.770 99.9%5996 47.500 12544.992900033.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.060 0.0%12379 0.000 0.005 0.250
readart00:00:00.722 0.0%85 0.000 8.494 60.000
TOTAL: 20:54:26.12720:53:40.561 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1440 114093 7526 101602 4965 6%118:44:21
2feeder.eternal-september.org 3 25390 2894 21203 1293 11%24:26:31
3news-out.mixmin.net 4 20715 1832 18177 706 8%24:13:19
4csiph-out.news.weretis.net 3 37651 1569 35766 316 4%45:50:17
5news-out.aioe.org 2 18878 1271 17564 43 6%24:09:01
6newsfeeds.xmission.com 3 18035 1247 16769 19 6%22:47:50
7newsfeed.fu-berlin.de 22 20174 1172 18884 118 5%29:22:26
8newsfeed.neva.ru 148 26167 928 24417 822 3%72:02:42
9news.redatomik.org 1 21052 566 20482 4 2%29:29:57
10news.freedyn.net 2 21573 253 21133 187 1%23:59:44
11news.fcku.it 1 8065 110 7871 84 1%23:59:58
12nntp.pasdenom.info 2 17954 104 17799 51 0%23:59:10
13xanadu-bbs.net 22 543 64 459 20 11%23:21:47
14news.swapon.de 5 1639 42 1597 0 2%23:57:08
15news.bbs.geek.nz 1 19018 15 19003 0 0%23:59:50
16localhost 35 1 1 0 0 100%00:00:13
TOTAL: 16 1694 370948 19594 342726 8628 5%534:24:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net28.5 MB3.2 KB26.6 MB55.1 MB 51%4.5 KB
2feeder.eternal-september.org7.8 MB0.0 KB45.6 MB53.4 MB 14%13.1 KB
3news-out.mixmin.net6.3 MB0.0 KB1.7 MB7.9 MB 78%3.2 KB
4csiph-out.news.weretis.net5.4 MB0.0 KB11.2 MB16.6 MB 32%9.0 KB
5newsfeeds.xmission.com3.6 MB0.0 KB1.2 MB4.7 MB 75%3.8 KB
6news-out.aioe.org3.1 MB0.0 KB63.5 KB3.2 MB 98%2.5 KB
7newsfeed.fu-berlin.de2.5 MB0.0 KB335.1 KB2.8 MB 88%2.2 KB
8newsfeed.neva.ru2.3 MB0.0 KB2.8 MB5.1 MB 44%3.0 KB
9news.redatomik.org1.5 MB0.0 KB5.6 KB1.5 MB 99%2.7 KB
10news.freedyn.net988.4 KB0.0 KB5.9 MB6.8 MB 14%15.9 KB
11news.fcku.it269.1 KB0.0 KB1.5 MB1.8 MB 14%9.4 KB
12nntp.pasdenom.info228.8 KB0.0 KB101.8 KB330.6 KB 69%2.1 KB
13xanadu-bbs.net180.4 KB0.0 KB51.6 KB232.0 KB 77%2.8 KB
14news.swapon.de95.5 KB0.0 KB0.0 KB95.5 KB100%2.3 KB
15news.bbs.geek.nz35.9 KB0.0 KB0.0 KB35.9 KB100%2.4 KB
16localhost1.0 KB0.0 KB0.0 KB1.0 KB100%1.0 KB
TOTAL: 1662.7 MB3.2 KB97.0 MB159.7 MB 39%5.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 4 04:15:01 - 04:59:59 308 1.6% 0.11908.5 KB 1.4% 0.34
Jun 4 05:00:00 - 05:59:59 448 2.3% 0.122.2 MB 3.5% 0.62
Jun 4 06:00:00 - 06:59:59 645 3.3% 0.182.6 MB 4.2% 0.74
Jun 4 07:00:00 - 07:59:59 797 4.1% 0.223.4 MB 5.4% 0.97
Jun 4 08:00:00 - 08:59:59 914 4.7% 0.253.8 MB 6.0% 1.07
Jun 4 09:00:00 - 09:59:59 934 4.8% 0.262.6 MB 4.2% 0.75
Jun 4 10:00:00 - 10:59:59 875 4.5% 0.242.8 MB 4.5% 0.80
Jun 4 11:00:00 - 11:59:59 818 4.2% 0.232.4 MB 3.8% 0.68
Jun 4 12:00:00 - 12:59:59 1037 5.3% 0.292.9 MB 4.6% 0.82
Jun 4 13:00:00 - 13:59:59 1008 5.2% 0.282.7 MB 4.4% 0.78
Jun 4 14:00:00 - 14:59:59 1058 5.4% 0.293.1 MB 4.9% 0.88
Jun 4 15:00:00 - 15:59:59 971 5.0% 0.273.0 MB 4.7% 0.84
Jun 4 16:00:00 - 16:59:59 1131 5.8% 0.313.5 MB 5.6% 1.00
Jun 4 17:00:00 - 17:59:59 1088 5.6% 0.303.3 MB 5.2% 0.93
Jun 4 18:00:00 - 18:59:59 1177 6.0% 0.334.1 MB 6.5% 1.17
Jun 4 19:00:00 - 19:59:59 1044 5.3% 0.293.1 MB 5.0% 0.89
Jun 4 20:00:00 - 20:59:59 969 5.0% 0.272.7 MB 4.3% 0.76
Jun 4 21:00:00 - 21:59:59 957 4.9% 0.273.0 MB 4.8% 0.86
Jun 4 22:00:00 - 22:59:59 757 3.9% 0.212.3 MB 3.7% 0.66
Jun 4 23:00:00 - 23:59:59 674 3.4% 0.192.0 MB 3.2% 0.57
Jun 5 00:00:00 - 00:59:59 563 2.9% 0.161.9 MB 3.0% 0.53
Jun 5 01:00:00 - 01:59:59 454 2.3% 0.131.5 MB 2.4% 0.42
Jun 5 02:00:00 - 02:59:59 396 2.0% 0.111.3 MB 2.0% 0.36
Jun 5 03:00:00 - 03:59:59 422 2.2% 0.121.3 MB 2.2% 0.38
Jun 5 04:00:00 - 04:15:00 113 0.6% 0.13424.9 KB 0.7% 0.47
TOTAL: 23:59:59 19558 100.0% 0.2362.8 MB 100.0% 0.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 5004 234 0 1 0 0 0 0 4769
2feeder.eternal-september.org 1303 37 0 0 0 0 0 0 1266
3newsfeed.neva.ru 840 183 0 0 0 0 0 0 657
4news-out.mixmin.net 727 0 0 0 0 0 0 0 727
5newsfeed.fu-berlin.de 562 20 0 0 0 0 0 0 542
6csiph-out.news.weretis.net 373 92 0 0 0 0 0 0 281
7news.freedyn.net 187 6 0 0 0 0 0 0 181
8news.fcku.it 85 16 0 0 0 0 0 0 69
9news-out.aioe.org 55 42 0 0 0 0 0 0 13
10nntp.pasdenom.info 51 1 0 0 0 0 0 0 50
11newsfeeds.xmission.com 22 0 0 0 0 0 0 0 22
12xanadu-bbs.net 19 0 0 0 0 0 0 0 19
13news.redatomik.org 6 0 0 0 0 0 0 0 6
14news.swapon.de 6 0 0 0 0 0 0 0 6
TOTAL: 14 9240 631 0 1 0 0 0 0 8608

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 129
lada.talk 110
ut.test 59
mpc.lists.freebsd.ports.bugs 23
mozilla.support.seamonkey 19
lada.auto 16
mpc.lists.freebsd.gnome 14
mozilla.dev.ports.os2 13
mpc.lists.nanog 12
lada.photo 11
alt.pl.nieruchomosci.gielda 11
alt.religion 9
alt.windows7.general 9
alt.binaries.kindle 8
mozilla.support.thunderbird 8
oesterreich.tratsch 7
alt.politics 7
cakewalk.audio 7
spline.eisfair 6
gmane.comp.gis.openstreetmap 5
TOTAL: 106 631

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6000
EMP (phn path) 546
EMP (phl) 233
EMP (phn nph) 218
Too many newsgroups 85
Scoring filter (8) 25
User-issued cancel 25
Scoring filter (9) 20
Binary Payload 15
Scoring filter (12) 11
HTML Multipart 9
Scoring filter (13) 6
HTML post 6
Scoring filter (10) 5
Scoring filter (14) 5
Scoring filter (20) 5
Too many newsgroups (meow) 2
Scoring filter (11) 2
Scoring filter (16) 1
User-issued spam cancel 1
TOTAL: 22 7222

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com4604646
TOTAL: 14604646

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 162
TOTAL: 1 162
Huge articles
csiph-out.feeder.erje.net 238
feeder.eternal-september.org 218
csiph-out.news.weretis.net 109
news.freedyn.net 32
newsfeeds.xmission.com 15
news-out.mixmin.net 9
news.fcku.it 4
TOTAL: 7 625
Including strange strings
newsfeed.fu-berlin.de 451
csiph-out.news.weretis.net 39
csiph-out.feeder.erje.net 38
news-out.mixmin.net 22
newsfeed.neva.ru 14
news-out.aioe.org 11
feeder.eternal-september.org 9
news.swapon.de 6
newsfeeds.xmission.com 3
news.redatomik.org 2
TOTAL: 10 595
TOTAL: 3 1382

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.freedyn.net 19846 890 18341 3 0 0 4%23:50:04
2news.bbs.geek.nz 34890 819 17857 64 0 0 2%23:50:04
3xanadu-bbs 20194 758 18660 2 0 0 3%23:50:04
4fu-berlin.de 18225 719 17506 0 0 0 3%23:58:46
5usenet.pasdenom.info 19891 155 17501 1739 0 2 0%23:51:13
6erje 12626 113 11810 42 0 0 0%23:54:43
7weretis.net 13149 22 13038 3 0 0 0%23:51:17
8xmission 18578 21 17436 0 0 0 0%23:53:11
9news.redatomik.org 18795 8 18348 0 0 22 0%23:54:16
10aioe 17193 3 16591 0 0 0 0%23:50:06
11news.mixmin.net 17142 3 16627 0 0 117 0%23:53:26
12eternal-september 16284 3 15669 0 0 0 0%23:59:08
13news.swapon.de 1669 1 1651 0 0 0 0%23:42:57
14neva.ru 18005 0 17671 2 0 0 0%23:50:51
15au2pb 0 0 0 0 0 18777 0%23:50:03
16news.fcku.it 1659 0 1637 0 0 0 0%21:50:19
17bwh 0 0 0 0 0 18767 0%23:50:03
TOTAL: 17 248146 3515 220343 1855 0 37685 1%403:40:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net9.9 MB16.7 KB10.0 MB0.1 KB/s11.4 KB23:50:04
2xanadu-bbs9.6 MB7.2 KB9.6 MB0.1 KB/s12.9 KB23:50:04
3fu-berlin.de9.5 MB0.0 KB9.5 MB0.1 KB/s13.5 KB23:58:46
4news.bbs.geek.nz1.9 MB212.2 KB2.1 MB0.0 KB/s2.5 KB23:50:04
5usenet.pasdenom.info574.6 KB11.3 MB11.9 MB0.1 KB/s6.4 KB23:51:13
6erje264.7 KB352.3 KB617.0 KB0.0 KB/s4.0 KB23:54:43
7xmission64.9 KB0.0 KB64.9 KB0.0 KB/s3.1 KB23:53:11
8weretis.net50.0 KB65.8 KB115.8 KB0.0 KB/s4.6 KB23:51:17
9news.redatomik.org17.7 KB0.0 KB17.7 KB0.0 KB/s2.2 KB23:54:16
10news.mixmin.net11.3 KB0.0 KB11.3 KB0.0 KB/s3.8 KB23:53:26
11eternal-september11.3 KB0.0 KB11.3 KB0.0 KB/s3.8 KB23:59:08
12aioe4.4 KB0.0 KB4.4 KB0.0 KB/s1.5 KB23:50:06
13news.swapon.de1.0 KB0.0 KB1.0 KB0.0 KB/s1.0 KB23:42:57
14neva.ru0.0 KB2.3 KB2.3 KB0.0 KB/s1.1 KB23:50:51
15au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
16news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:50:19
17bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
TOTAL: 1731.9 MB12.0 MB43.9 MB0.0 KB/s8.4 KB403:40:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147-192-187-101.drr02.clwr.fl.frontiernet.net 36 3994.1 KB 11 0 003:11:43
2144.138.90.254 48 3064.3 KB 27 0 000:40:48
3204-73-239-109.cust.centrio.cz 2 817.2 KB 2 0 000:59:35
4challenger.nielsenmedia.com 2 510.5 KB 1 0 001:02:21
5dhcp-089-099-203-254.chello.nl 33 11.0 KB 1 0 006:44:11
696-42-16-100.dhcp.mdsn.wi.charter.com 14 11.0 KB 1 1 102:46:24
7tempe0.bbox.io 13 11.0 KB 1 0 003:59:15
TOTAL: 7 148 85189.2 KB 44 1 120:54:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.drr02.clwr.fl.frontiernet.net 36 3994.1 KB 11 0 003:11:43
2unresolved 49 3064.3 KB 27 0 001:10:48
3*.cust.centrio.cz 2 817.2 KB 2 0 000:59:35
4*.nielsenmedia.com 2 510.5 KB 1 0 001:02:21
5*.dhcp.mdsn.wi.charter.com 14 11.0 KB 1 1 102:46:24
6*.chello.nl 33 11.0 KB 1 0 006:44:11
7*.bbox.io 13 11.0 KB 1 0 003:59:15
8*.hsd1.wa.comcast.net 2 00.0 KB 0 0 001:00:03
TOTAL: 8 151 85189.2 KB 44 1 120:54:24

NNRP auth users [Top 20]:

UserConn
moussa 48
ctomczyk 2
ohlandl 1
TOTAL: 3 51

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dhcp-089-099-203-254.chello.nl 2.555 0.454 0.00006:44:11
tempe0.bbox.io 1.324 0.177 0.00003:59:15
47-192-187-101.drr02.clwr.fl.frontiernet.net 2.485 0.349 0.00003:11:43
96-42-16-100.dhcp.mdsn.wi.charter.com 1.098 0.216 0.00302:46:24
challenger.nielsenmedia.com 0.253 0.046 0.00001:02:21
c-174-61-130-222.hsd1.wa.comcast.net 0.100 0.023 0.00001:00:03
204-73-239-109.cust.centrio.cz 0.252 0.024 0.00800:59:35
144.138.90.254 4.901 0.986 0.18100:40:48
216.239.174.218 0.073 0.024 0.00000:30:00
TOTAL: 9 13.041 2.299 0.19220:54:24

Curious NNRP server explorers [Top 20]:

SystemConn
c-174-61-130-222.hsd1.wa.comcast.net 2
216.239.174.218 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
tempe0.bbox.io 6 0
47-192-187-101.drr02.clwr.fl.frontiernet.net 6 0
96-42-16-100.dhcp.mdsn.wi.charter.com 3 0
challenger.nielsenmedia.com 2 0
c-174-61-130-222.hsd1.wa.comcast.net 2 0
204-73-239-109.cust.centrio.cz 1 0
216.239.174.218 1 0
TOTAL: 7 21 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 85100.0%
TOTAL: 1 85100.0%

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

NewsgroupCount
1comp.lang.awk 44
2comp.os.msdos.misc 10
3comp.lang.javascript 8
4comp.os.os2.apps 6
5comp.os.vms 5
6comp.sys.ibm.ps2.hardware 4
7comp.sys.ibm.as400.misc 3
8comp.os.os2.advocacy 2
9comp.sys.ibm.pc.games.action 1
10comp.answers 1
11comp.arch 1
TOTAL: 11 85