Daily Usenet report for csiph.com

Dec 30 04:15:00 -- Jan 1 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 53896 56.4%11.8 MB 70.7%
innd 23637 24.7%3.0 MB 17.9%
nnrpd 11489 12.0%973.5 KB 5.7%
innfeed 6437 6.7%968.0 KB 5.6%
nocem 155 0.2%16.9 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 95615 100.0%16.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 591757 55.6%
Negative hits 419316 39.4%
Do not exist 51988 4.9%
Cache misses 688 0.1%
TOTAL: 4 1063749 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.944 0.0%512 0.000 11.609 259.000
article cleanup00:00:00.343 0.0%50070 0.000 0.007 0.032
article logging00:00:00.950 0.0%51501 0.000 0.018 0.077
article parse00:00:04.358 0.0%159563 0.000 0.027 0.162
article write00:21:21.217 0.7%38926 0.489 32.914 154.926
artlog/artcncl00:00:00.006 0.0%414 0.000 0.014 0.500
artlog/artparse00:00:00.031 0.0%1951 0.000 0.016 1.000
data move00:00:00.403 0.0%1041911 0.000 0.000 0.002
hisgrep/artcncl00:00:00.035 0.0%508 0.000 0.069 1.111
hishave/artcncl00:00:00.005 0.0%512 0.000 0.010 1.000
hishave/artparse00:00:00.006 0.0%1948 0.000 0.003 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.476 0.0%1062210 0.003 0.009 0.043
history sync00:00:03.297 0.0%730 0.000 4.516 13.000
history write00:00:51.659 0.0%50060 0.330 1.032 26.293
hiswrite/artcncl00:00:00.001 0.0%4 0.000 0.250 1.000
hiswrite/artparse00:00:01.927 0.0%1948 0.000 0.989 8.000
idle47:20:53.757 98.9%1031321 86.952 165.277 579.977
nntp read00:00:05.312 0.0%1059316 0.002 0.005 0.009
overview write00:05:11.310 0.2%38926 0.317 7.997 893.702
perl filter00:01:41.010 0.1%49625 1.406 2.035 6.039
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.722 0.0%77996 0.000 0.009 0.027
TOTAL: 47:51:59.61947:50:31.769 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.084 0.0%38974 0.000 0.002 0.019
article prepare00:00:00.007 0.0%44530 0.000 0.000 0.007
article read00:00:25.434 0.0%5752 0.000 4.422 57.455
backlog stats00:00:00.447 0.0%713936 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.907 0.0%550805 0.002 0.007 0.016
data write00:00:03.271 0.0%518571 0.001 0.006 0.014
idle47:56:53.819100.0%713936 128.133 241.778 754.229
status file00:00:03.399 0.0%588 0.000 5.781 209.000
TOTAL: 47:58:00.27547:57:30.368100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle30:26:10.506 99.9%11332 286.000 9669.123600380.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.145 0.0%23544 0.000 0.006 0.167
readart00:00:00.698 0.0%196 0.000 3.561 371.000
TOTAL: 30:27:17.96830:26:11.349 99.9%----

Control commands to INND:

CommandNumber
L 1
flush 6
flushlogs 2
go 2
logmode 2
mode 113
name 1
pause 2
paused 2
reload 4
reserve 2
TOTAL: 11 137

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 11 75759 12475 62601 683 16%95:35:04
2csiph-out.feeder.erje.net 2304 165532 8157 151954 5421 4%189:58:12
3feeder.eternal-september.org 8 44132 4807 37161 2164 10%48:51:07
4news-out.aioe.org 5 36112 3701 32386 25 10%48:18:46
5newsfeed.fu-berlin.de 31 35347 2414 32818 115 6%50:51:54
6newsfeed.neva.ru 293 46793 1865 41379 3549 3%144:11:16
7news-out.mixmin.net 2 39747 1647 37223 877 4%47:59:39
8newsfeeds.xmission.com 3 37961 1390 36567 4 3%52:41:14
9news.fcku.it 2 16436 1156 15059 221 7%49:39:09
10news.redatomik.org 2 29771 1154 28614 3 3%42:12:25
11nntp.pasdenom.info 6 34548 106 34434 8 0%48:06:33
12news.swapon.de 10 3603 74 3527 2 2%47:35:26
13news.freedyn.net 4 52159 57 51997 105 0%58:01:36
14news.bbs.geek.nz 3 34140 14 34126 0 0%45:43:38
15xanadu-bbs.net 31 1245 9 1233 3 0%46:01:00
16localhost 62 0 0 0 0 0%00:00:00
TOTAL: 16 2777 653285 39026 601079 13180 5%1015:46:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.weretis.net39.1 MB4.0 KB22.1 MB61.2 MB 63%4.8 KB
2csiph-out.feeder.erje.net32.5 MB27.6 KB85.3 MB117.8 MB 27%8.9 KB
3feeder.eternal-september.org13.1 MB2.0 KB14.5 MB27.7 MB 47%4.1 KB
4news-out.aioe.org9.3 MB0.0 KB49.1 KB9.3 MB 99%2.6 KB
5news-out.mixmin.net5.8 MB0.0 KB2.7 MB8.5 MB 68%3.4 KB
6newsfeed.fu-berlin.de5.4 MB0.0 KB300.1 KB5.7 MB 94%2.3 KB
7newsfeed.neva.ru5.0 MB43.0 KB29.2 MB34.3 MB 14%6.5 KB
8newsfeeds.xmission.com4.3 MB0.0 KB64.8 KB4.4 MB 98%3.2 KB
9news.fcku.it2.8 MB0.0 KB5.6 MB8.4 MB 33%6.3 KB
10news.redatomik.org2.7 MB0.0 KB10.0 KB2.7 MB 99%2.4 KB
11nntp.pasdenom.info219.0 KB0.0 KB13.4 KB232.4 KB 94%2.0 KB
12news.freedyn.net200.1 KB0.0 KB5.9 MB6.1 MB 3%38.8 KB
13news.swapon.de182.4 KB0.0 KB47.8 KB230.2 KB 79%3.0 KB
14news.bbs.geek.nz21.5 KB0.0 KB0.0 KB21.5 KB100%1.5 KB
15xanadu-bbs.net18.4 KB0.0 KB5.7 KB24.2 KB 76%2.0 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 16120.6 MB76.6 KB165.8 MB286.5 MB 42%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 30 04:15:00 - 04:59:59 305 0.8% 0.11979.6 KB 0.8% 0.36
Dec 30 05:00:00 - 05:59:59 422 1.1% 0.121.3 MB 1.1% 0.37
Dec 30 06:00:00 - 06:59:59 441 1.1% 0.121.4 MB 1.1% 0.39
Dec 30 07:00:00 - 07:59:59 476 1.2% 0.131.7 MB 1.4% 0.49
Dec 30 08:00:00 - 08:59:59 708 1.8% 0.202.6 MB 2.2% 0.75
Dec 30 09:00:00 - 09:59:59 991 2.5% 0.283.8 MB 3.1% 1.08
Dec 30 10:00:00 - 10:59:59 994 2.6% 0.283.5 MB 2.9% 0.99
Dec 30 11:00:00 - 11:59:59 1080 2.8% 0.303.2 MB 2.7% 0.92
Dec 30 12:00:00 - 12:59:59 879 2.3% 0.242.6 MB 2.2% 0.74
Dec 30 13:00:00 - 13:59:59 1001 2.6% 0.282.8 MB 2.4% 0.81
Dec 30 14:00:00 - 14:59:59 1095 2.8% 0.303.0 MB 2.5% 0.86
Dec 30 15:00:00 - 15:59:59 1159 3.0% 0.323.7 MB 3.1% 1.06
Dec 30 16:00:00 - 16:59:59 1165 3.0% 0.323.7 MB 3.1% 1.07
Dec 30 17:00:00 - 17:59:59 1267 3.3% 0.353.5 MB 2.9% 1.01
Dec 30 18:00:00 - 18:59:59 1352 3.5% 0.383.6 MB 3.0% 1.02
Dec 30 19:00:00 - 19:59:59 1286 3.3% 0.364.0 MB 3.3% 1.14
Dec 30 20:00:00 - 20:59:59 1139 2.9% 0.323.1 MB 2.5% 0.87
Dec 30 21:00:00 - 21:59:59 1120 2.9% 0.313.1 MB 2.5% 0.88
Dec 30 22:00:00 - 22:59:59 1081 2.8% 0.303.1 MB 2.5% 0.88
Dec 30 23:00:00 - 23:59:59 881 2.3% 0.242.8 MB 2.3% 0.79
Dec 31 00:00:00 - 00:59:59 688 1.8% 0.192.4 MB 2.0% 0.69
Dec 31 01:00:00 - 01:59:59 550 1.4% 0.151.6 MB 1.3% 0.45
Dec 31 02:00:00 - 02:59:59 487 1.2% 0.141.7 MB 1.4% 0.48
Dec 31 03:00:00 - 03:59:59 475 1.2% 0.131.7 MB 1.4% 0.49
Dec 31 04:00:00 - 04:59:59 359 0.9% 0.101.2 MB 1.0% 0.35
Dec 31 05:00:00 - 05:59:59 504 1.3% 0.141.8 MB 1.5% 0.51
Dec 31 06:00:00 - 06:59:59 386 1.0% 0.111.3 MB 1.0% 0.36
Dec 31 07:00:00 - 07:59:59 438 1.1% 0.121.7 MB 1.4% 0.49
Dec 31 08:00:00 - 08:59:59 554 1.4% 0.151.4 MB 1.2% 0.40
Dec 31 09:00:00 - 09:59:59 758 1.9% 0.212.4 MB 2.0% 0.68
Dec 31 10:00:00 - 10:59:59 798 2.0% 0.223.1 MB 2.6% 0.90
Dec 31 11:00:00 - 11:59:59 1022 2.6% 0.283.1 MB 2.6% 0.88
Dec 31 12:00:00 - 12:59:59 953 2.4% 0.263.0 MB 2.5% 0.85
Dec 31 13:00:00 - 13:59:59 1062 2.7% 0.293.2 MB 2.6% 0.90
Dec 31 14:00:00 - 14:59:59 967 2.5% 0.272.9 MB 2.4% 0.81
Dec 31 15:00:00 - 15:59:59 980 2.5% 0.273.2 MB 2.7% 0.92
Dec 31 16:00:00 - 16:59:59 917 2.4% 0.252.4 MB 2.0% 0.69
Dec 31 17:00:00 - 17:59:59 1072 2.8% 0.303.1 MB 2.5% 0.87
Dec 31 18:00:00 - 18:59:59 992 2.5% 0.282.7 MB 2.2% 0.76
Dec 31 19:00:00 - 19:59:59 963 2.5% 0.273.4 MB 2.8% 0.95
Dec 31 20:00:00 - 20:59:59 900 2.3% 0.252.5 MB 2.0% 0.70
Dec 31 21:00:00 - 21:59:59 893 2.3% 0.252.4 MB 1.9% 0.67
Dec 31 22:00:00 - 22:59:59 828 2.1% 0.232.4 MB 2.0% 0.69
Dec 31 23:00:00 - 23:59:59 689 1.8% 0.192.4 MB 2.0% 0.69
Jan 1 00:00:00 - 00:59:59 531 1.4% 0.151.5 MB 1.3% 0.43
Jan 1 01:00:00 - 01:59:59 521 1.3% 0.142.0 MB 1.7% 0.57
Jan 1 02:00:00 - 02:59:59 383 1.0% 0.111.1 MB 0.9% 0.31
Jan 1 03:00:00 - 03:59:59 381 1.0% 0.111.6 MB 1.3% 0.45
Jan 1 04:00:00 - 04:15:00 67 0.2% 0.07234.9 KB 0.2% 0.26
TOTAL: 48:00:00 38960 100.0% 0.23120.9 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 5486 179 0 8 0 0 0 0 5299
2newsfeed.neva.ru 3449 399 0 2 0 0 0 0 3048
3feeder.eternal-september.org 2097 65 0 1 0 0 0 0 2031
4newsfeed.fu-berlin.de 1180 82 0 0 0 0 0 0 1098
5news-out.mixmin.net 906 3 0 0 0 0 0 0 903
6csiph-out.news.weretis.net 899 283 0 2 0 0 0 0 614
7news.fcku.it 274 0 0 0 0 0 0 0 274
8news.freedyn.net 115 0 0 0 0 0 0 0 115
9news-out.aioe.org 49 24 0 0 0 0 0 0 25
10news.redatomik.org 43 0 0 0 0 0 0 0 43
11news.swapon.de 11 0 0 0 0 0 0 0 11
12nntp.pasdenom.info 8 4 0 0 0 0 0 0 4
13xanadu-bbs.net 3 0 0 0 0 0 0 0 3
14newsfeeds.xmission.com 2 1 0 0 0 0 0 0 1
TOTAL: 14 14522 1040 0 13 0 0 0 013469

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 207
mpc.lists.freebsd.ports.bugs 103
spline.eisfair 64
alt.windows7.general 60
mozilla.general 34
it-alt.sport.calcio.juventus 30
mozilla.support.seamonkey 27
lada.photo 23
lada.commerce 21
gmane.comp.gis.openstreetmap.tagging 19
alt.survival 17
oesterreich.tratsch 15
mpc.lists.nanog 15
mozilla.support.firefox 15
mozilla.support.thunderbird 15
lada.kitchen 13
alt.politics.usa 11
lada.movies 11
cakewalk.audio 10
lada.auto 10
TOTAL: 145 1040

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 8424
Binary: misplaced rar 619
EMP (phn nph) 196
Too many newsgroups 121
EMP (phn path) 85
Binary Payload 42
User-issued cancel 28
HTML Multipart 25
Scoring filter (12) 14
EMP (phl) 14
Scoring filter (11) 10
Scoring filter (15) 9
Scoring filter (13) 7
Scoring filter (10) 7
Too many newsgroups (meow) 5
HTML post 5
Binary: misplaced par2 5
Scoring filter (14) 5
Binary Image: misplaced png 5
Binary Image: misplaced jpg 4
TOTAL: 33 9653

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1440171171
TOTAL: 11440171171

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 352
TOTAL: 1 352
Bad Message-ID's offered
csiph-out.feeder.erje.net 8
TOTAL: 1 8
Huge articles
csiph-out.feeder.erje.net 1382
csiph-out.news.weretis.net 233
news.fcku.it 115
news.freedyn.net 97
feeder.eternal-september.org 91
news-out.mixmin.net 24
newsfeed.fu-berlin.de 4
news.swapon.de 1
newsfeeds.xmission.com 1
TOTAL: 9 1948
Including strange strings
newsfeed.fu-berlin.de 1058
csiph-out.news.weretis.net 188
csiph-out.feeder.erje.net 77
news.redatomik.org 40
news-out.aioe.org 25
news-out.mixmin.net 21
news.swapon.de 9
news.fcku.it 9
newsfeed.neva.ru 5
feeder.eternal-september.org 1
TOTAL: 10 1433
No colon-space in header
csiph-out.feeder.erje.net 3
TOTAL: 1 3
TOTAL: 5 3744

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 68671 2088 35007 228 0 2 3%47:59:44
2news.freedyn.net 41830 1934 36964 9 0 1 4%47:59:48
3xanadu-bbs 43680 1732 37217 0 0 1 3%47:59:36
4fu-berlin.de 35955 1344 34605 0 0 0 3%47:59:19
5usenet.pasdenom.info 40586 213 35423 3219 1 23 0%47:59:56
6aioe 32631 59 31633 11 0 0 0%47:55:47
7erje 31642 39 30377 4 0 0 0%47:59:32
8neva.ru 35710 18 34981 199 0 0 0%47:59:32
9news.redatomik.org 37751 15 36153 8 0 0 0%47:59:49
10weretis.net 25546 4 24142 0 0 0 0%47:55:18
11xmission 39208 3 35995 1 0 1 0%47:59:41
12eternal-september 33125 3 32181 0 0 0 0%47:59:29
13news.mixmin.net 35429 1 34789 0 0 0 0%47:59:28
14au2pb 0 0 0 0 0 37343 0%47:58:43
15news.fcku.it 2444 0 2435 0 0 0 0%44:09:41
16bwh 0 0 0 0 0 37333 0%47:58:43
17news.swapon.de 3844 0 3826 0 0 0 0%47:41:46
TOTAL: 17 508052 7453 445728 3679 1 74704 1%811:35:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net15.6 MB29.5 KB15.6 MB0.1 KB/s8.2 KB47:59:48
2xanadu-bbs14.8 MB0.0 KB14.8 MB0.1 KB/s8.8 KB47:59:36
3fu-berlin.de14.0 MB0.0 KB14.0 MB0.1 KB/s10.7 KB47:59:19
4news.bbs.geek.nz6.0 MB683.5 KB6.6 MB0.0 KB/s2.9 KB47:59:44
5usenet.pasdenom.info644.6 KB17.2 MB17.8 MB0.1 KB/s5.3 KB47:59:56
6aioe152.7 KB38.7 KB191.4 KB0.0 KB/s2.7 KB47:55:47
7erje94.4 KB14.2 KB108.7 KB0.0 KB/s2.5 KB47:59:32
8neva.ru48.2 KB463.5 KB511.7 KB0.0 KB/s2.4 KB47:59:32
9news.redatomik.org41.6 KB23.5 KB65.0 KB0.0 KB/s2.8 KB47:59:49
10xmission12.4 KB2.0 KB14.4 KB0.0 KB/s3.6 KB47:59:41
11eternal-september6.6 KB0.0 KB6.6 KB0.0 KB/s2.2 KB47:59:29
12weretis.net6.4 KB0.0 KB6.4 KB0.0 KB/s1.6 KB47:55:18
13news.mixmin.net3.1 KB0.0 KB3.1 KB0.0 KB/s3.1 KB47:59:28
14au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s047:58:43
15news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s044:09:41
16bwh0.0 KB0.0 KB0.0 KB0.0 KB/s047:58:43
17news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s047:41:46
TOTAL: 1751.4 MB18.4 MB69.8 MB0.0 KB/s6.4 KB811:35:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1141.168.117.108 93 189626.4 KB 111 0 002:28:22
2challenger.nielsenmedia.com 4 413.6 KB 3 0 001:11:28
3tempe0.bbox.io 36 36.6 KB 2 0 013:06:52
TOTAL: 3 133 196646.5 KB 116 0 030:27:16

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 93 189626.4 KB 111 0 002:28:22
2*.nielsenmedia.com 4 413.6 KB 3 0 001:11:28
3*.bbox.io 36 36.6 KB 2 0 013:06:52
4*.upc-a.chello.nl 63 00.0 KB 0 0 010:04:12
5*.hsd1.wa.comcast.net 1 00.0 KB 0 0 000:30:01
6*.dip0.t-ipconnect.de 1 00.0 KB 0 0 000:00:04
7*.dhcp.mdsn.wi.charter.com 4 00.0 KB 0 0 001:53:35
8*.cust.centrio.cz 3 00.0 KB 0 0 001:12:38
TOTAL: 8 205 196646.5 KB 116 0 030:27:16

NNRP auth users [Top 20]:

UserConn
moussa 93
ctomczyk 3
TOTAL: 2 96

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
tempe0.bbox.io 2.724 0.551 0.00013:06:52
a131033.upc-a.chello.nl 4.573 1.158 0.00010:04:12
141.168.117.108 10.680 2.322 0.75202:28:22
96-42-18-226.dhcp.mdsn.wi.charter.com 0.320 0.087 0.00001:53:35
194-73-239-109.cust.centrio.cz 0.228 0.041 0.01001:12:38
challenger.nielsenmedia.com 0.461 0.064 0.00001:11:28
c-67-160-62-214.hsd1.wa.comcast.net 0.078 0.031 0.00000:30:01
p4fc96d60.dip0.t-ipconnect.de 0.143 0.048 0.00000:00:04
TOTAL: 8 19.207 4.302 0.76230:27:16

Curious NNRP server explorers [Top 20]:

SystemConn
a131033.upc-a.chello.nl 63
96-42-18-226.dhcp.mdsn.wi.charter.com 4
194-73-239-109.cust.centrio.cz 3
c-67-160-62-214.hsd1.wa.comcast.net 1
p4fc96d60.dip0.t-ipconnect.de 1
TOTAL: 5 72

NNRP client timeouts [Top 20]:

SystemConnPeer
tempe0.bbox.io 18 0
141.168.117.108 4 0
96-42-18-226.dhcp.mdsn.wi.charter.com 3 0
challenger.nielsenmedia.com 2 0
194-73-239-109.cust.centrio.cz 2 0
c-67-160-62-214.hsd1.wa.comcast.net 1 0
TOTAL: 6 30 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 101 51.5%
2comp 93 47.4%
3news 2 1.0%
TOTAL: 3 196100.0%

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

NewsgroupCount
1alt.comp.freeware 101
2comp.os.vms 55
3comp.arch 12
4comp.os.msdos.djgpp 5
5comp.arch.fpga 5
6comp.lang.awk 4
7comp.sys.ibm.pc.games.action 4
8comp.os.os2.misc 2
9news.software.nntp 2
10comp.os.os2.programmer.misc 2
11comp.ai.philosophy 1
12comp.ai.neural-nets 1
13comp.sys.ibm.pc.hardware.chips 1
14comp.os.os2.announce 1
TOTAL: 14 196