Daily Usenet report for csiph.com

Nov 3 04:15:01 -- Nov 4 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 36780 44.9%4.0 MB 32.3%
inn 28861 35.2%6.3 MB 50.7%
innd 12974 15.8%1.6 MB 12.7%
innfeed 3203 3.9%529.0 KB 4.2%
nocem 85 0.1%9.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 81904 100.0%12.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 321528 55.4%
Negative hits 230490 39.7%
Do not exist 27964 4.8%
Cache misses 333 0.1%
TOTAL: 4 580315 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.319 0.0%207 0.000 6.372 144.000
article cleanup00:00:00.205 0.0%27236 0.000 0.008 0.049
article logging00:00:08.393 0.0%27794 0.000 0.302 3.192
article parse00:00:14.340 0.0%80830 0.000 0.177 2.681
article write00:05:04.861 0.4%20226 0.456 15.073 82.143
artlog/artcncl00:00:00.086 0.0%175 0.000 0.491 50.000
artlog/artparse00:00:00.388 0.0%897 0.000 0.433 32.000
data move00:00:00.325 0.0%562834 0.000 0.001 0.024
hisgrep/artcncl00:00:00.098 0.0%206 0.000 0.476 15.000
hishave/artcncl00:00:00.015 0.0%207 0.000 0.072 1.000
hishave/artparse00:00:00.002 0.0%896 0.000 0.002 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:34.212 0.3%582913 0.001 0.470 1.994
history sync00:00:11.142 0.0%341 0.000 32.674 253.000
history write00:08:26.930 0.6%27225 1.952 18.620 113.642
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:12.877 0.0%895 0.000 14.388 128.000
idle23:23:24.565 97.4%532712 73.758 158.068 654.861
nntp read00:00:02.878 0.0%575392 0.001 0.005 0.040
overview write00:15:27.658 1.1%20226 1.343 45.865 306.405
perl filter00:00:51.152 0.1%27054 1.356 1.891 4.188
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.392 0.0%40528 0.000 0.010 0.040
TOTAL: 24:00:45.26723:58:41.838 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.051 0.0%20730 0.000 0.002 0.030
article prepare00:00:00.004 0.0%22724 0.000 0.000 0.013
article read00:00:02.963 0.0%2958 0.000 1.002 52.000
backlog stats00:00:00.240 0.0%383810 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.905 0.0%291526 0.001 0.007 0.012
data write00:00:01.720 0.0%275090 0.000 0.006 0.012
idle23:53:55.942100.0%383810 117.285 224.163 751.928
status file00:00:01.287 0.0%319 0.000 4.034 120.000
TOTAL: 23:54:14.83323:54:04.112100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle37:50:47.195 94.8%720222 71.308 189.174600146.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:10.442 0.0%1864271 0.000 0.006 0.167
readart02:01:01.202 5.1%611957 0.000 11.866 735.000
TOTAL: 39:56:01.98639:51:58.839 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 90072 7170 79436 3466 7%94:58:47
2feeder.eternal-september.org 5 22555 2660 19270 625 11%23:03:49
3csiph-out.news.weretis.net 5 41285 1940 38967 378 4%48:15:53
4news-out.aioe.org 4 20251 1901 18294 56 9%24:09:38
5news-out.mixmin.net 3 21335 1306 19430 599 6%24:11:58
6newsfeed.neva.ru 152 25098 1262 21513 2323 5%71:43:57
7newsfeeds.xmission.com 3 18273 1168 17095 10 6%22:43:50
8newsfeed.fu-berlin.de 14 19135 1099 17870 166 5%24:29:54
9news.fcku.it 2 10724 725 9785 214 6%24:26:38
10news.redatomik.org 3 17318 634 16674 10 3%21:43:41
11news.swapon.de 4 1625 72 1551 2 4%24:31:29
12nntp.pasdenom.info 2 18866 55 18800 11 0%23:59:19
13news.freedyn.net 2 21982 28 21929 25 0%23:59:45
14xanadu-bbs.net 20 593 4 586 3 0%22:09:07
15news.bbs.geek.nz 1 19606 2 19604 0 0%23:59:45
16localhost 38 2 2 0 0 100%00:00:08
TOTAL: 16 1410 348720 20028 320804 7888 5%498:27:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net27.1 MB6.3 KB45.1 MB72.2 MB 37%7.0 KB
2feeder.eternal-september.org6.8 MB2.3 KB3.7 MB10.4 MB 64%3.2 KB
3csiph-out.news.weretis.net6.2 MB2.4 KB13.0 MB19.2 MB 32%8.5 KB
4news-out.mixmin.net4.4 MB0.0 KB1.4 MB5.8 MB 76%3.1 KB
5news-out.aioe.org4.2 MB2.3 KB101.7 KB4.3 MB 97%2.3 KB
6newsfeed.neva.ru3.3 MB4.0 KB6.1 MB9.4 MB 34%2.7 KB
7newsfeeds.xmission.com3.1 MB0.0 KB614.1 KB3.7 MB 83%3.3 KB
8newsfeed.fu-berlin.de2.5 MB0.0 KB259.7 KB2.7 MB 90%2.2 KB
9news.fcku.it1.6 MB0.0 KB1.9 MB3.5 MB 46%3.8 KB
10news.redatomik.org1.6 MB2.4 KB78.8 KB1.7 MB 95%2.6 KB
11news.swapon.de177.9 KB0.0 KB51.7 KB229.6 KB 77%3.1 KB
12nntp.pasdenom.info134.2 KB0.0 KB11.8 KB146.1 KB 91%2.2 KB
13news.freedyn.net74.9 KB0.0 KB1.5 MB1.6 MB 4%30.1 KB
14xanadu-bbs.net8.2 KB0.0 KB21.2 KB29.4 KB 27%4.2 KB
15news.bbs.geek.nz3.4 KB0.0 KB0.0 KB3.4 KB100%1.7 KB
16localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 1661.1 MB19.7 KB73.8 MB134.9 MB 45%4.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 3 04:15:01 - 04:59:59 290 1.4% 0.11854.5 KB 1.3% 0.32
Nov 3 05:00:00 - 05:59:59 416 2.1% 0.121.9 MB 3.1% 0.54
Nov 3 06:00:00 - 06:59:59 492 2.4% 0.142.6 MB 4.1% 0.73
Nov 3 07:00:00 - 07:59:59 634 3.1% 0.182.3 MB 3.7% 0.65
Nov 3 08:00:00 - 08:59:59 897 4.4% 0.252.2 MB 3.6% 0.63
Nov 3 09:00:00 - 09:59:59 1003 5.0% 0.282.5 MB 4.1% 0.72
Nov 3 10:00:00 - 10:59:59 947 4.7% 0.262.3 MB 3.7% 0.65
Nov 3 11:00:00 - 11:59:59 826 4.1% 0.232.4 MB 3.9% 0.69
Nov 3 12:00:00 - 12:59:59 830 4.1% 0.232.0 MB 3.2% 0.57
Nov 3 13:00:00 - 13:59:59 965 4.8% 0.272.5 MB 4.0% 0.71
Nov 3 14:00:00 - 14:59:59 1194 5.9% 0.333.8 MB 6.1% 1.08
Nov 3 15:00:00 - 15:59:59 1097 5.4% 0.303.6 MB 5.8% 1.02
Nov 3 16:00:00 - 16:59:59 1153 5.7% 0.323.2 MB 5.2% 0.91
Nov 3 17:00:00 - 17:59:59 1238 6.1% 0.343.6 MB 5.8% 1.03
Nov 3 18:00:00 - 18:59:59 1212 6.0% 0.344.6 MB 7.4% 1.31
Nov 3 19:00:00 - 19:59:59 1241 6.1% 0.344.3 MB 7.0% 1.23
Nov 3 20:00:00 - 20:59:59 1154 5.7% 0.323.2 MB 5.2% 0.92
Nov 3 21:00:00 - 21:59:59 1169 5.8% 0.323.2 MB 5.1% 0.90
Nov 3 22:00:00 - 22:59:59 867 4.3% 0.242.8 MB 4.6% 0.80
Nov 3 23:00:00 - 23:59:59 708 3.5% 0.202.1 MB 3.4% 0.61
Nov 4 00:00:00 - 00:59:59 503 2.5% 0.141.4 MB 2.3% 0.40
Nov 4 01:00:00 - 01:59:59 449 2.2% 0.121.2 MB 2.0% 0.35
Nov 4 02:00:00 - 02:59:59 404 2.0% 0.111.2 MB 1.9% 0.33
Nov 4 03:00:00 - 03:59:59 444 2.2% 0.121.8 MB 2.9% 0.51
Nov 4 04:00:00 - 04:15:00 93 0.5% 0.10429.4 KB 0.7% 0.48
TOTAL: 23:59:59 20226 100.0% 0.2362.1 MB 100.0% 0.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 3512 240 0 2 0 0 0 0 3270
2newsfeed.neva.ru 2327 459 0 2 0 0 0 0 1866
3feeder.eternal-september.org 628 51 0 1 0 0 0 0 576
4news-out.mixmin.net 622 3 0 0 0 0 0 0 619
5newsfeed.fu-berlin.de 585 33 0 0 0 0 0 0 552
6csiph-out.news.weretis.net 387 117 0 1 0 0 0 0 269
7news.fcku.it 213 8 0 0 0 0 0 0 205
8news-out.aioe.org 66 25 0 1 0 0 0 0 40
9news.redatomik.org 38 0 0 1 0 0 0 0 37
10news.swapon.de 36 0 0 0 0 0 0 0 36
11news.freedyn.net 23 2 0 0 0 0 0 0 21
12nntp.pasdenom.info 11 0 0 0 0 0 0 0 11
13newsfeeds.xmission.com 9 3 0 0 0 0 0 0 6
14xanadu-bbs.net 3 0 0 0 0 0 0 0 3
TOTAL: 14 8460 941 0 8 0 0 0 0 7511

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 343
lada.auto 50
alt.survival 50
gmane.linux.alsa.devel 33
lada.photo 32
mpc.lists.freebsd.ports.bugs 30
it-alt.sport.calcio.juventus 26
alt.politics 26
ut.test 25
spline.eisfair.dev 19
free.it.religioni.scientology 19
lada.commerce 15
mozilla.support.seamonkey 13
mozilla.dev.platform 13
alt.windows7.general 12
mozilla.test 10
mozilla.support.firefox 10
mozilla.general 10
oesterreich.tratsch 10
alt.politics.usa 7
TOTAL: 116 941

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4923
EMP (phn path) 362
EMP (phn nph) 251
EMP (phl) 68
Too many newsgroups 33
HTML Multipart 31
Scoring filter (8) 24
Scoring filter (12) 24
Scoring filter (10) 22
Binary Payload 22
User-issued cancel 20
HTML post 16
Scoring filter (13) 15
Scoring filter (9) 13
Poison newsgroup 7
Scoring filter (11) 7
Too many newsgroups (low_xpost) 6
Scoring filter (24) 5
Scoring filter (22) 5
Scoring filter (23) 5
TOTAL: 35 5883

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com7608484
TOTAL: 17608484

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 170
TOTAL: 1 170
Bad Message-ID's offered
csiph-out.feeder.erje.net 4
TOTAL: 1 4
Huge articles
csiph-out.feeder.erje.net 702
csiph-out.news.weretis.net 124
feeder.eternal-september.org 24
news.fcku.it 20
news.freedyn.net 12
newsfeeds.xmission.com 6
news-out.mixmin.net 6
news.swapon.de 1
news.redatomik.org 1
TOTAL: 9 896
Including strange strings
newsfeed.fu-berlin.de 411
csiph-out.feeder.erje.net 50
news.swapon.de 34
news-out.mixmin.net 22
news.redatomik.org 20
news-out.aioe.org 10
csiph-out.news.weretis.net 6
newsfeed.neva.ru 3
news.fcku.it 1
TOTAL: 9 557
TOTAL: 4 1627

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.freedyn.net 21750 1253 18875 11 0 0 5%23:50:13
2news.bbs.geek.nz 34134 797 18698 56 0 0 2%23:57:46
3xanadu-bbs 22885 768 19453 0 0 0 3%23:59:52
4fu-berlin.de 18765 658 18107 0 0 0 3%23:50:13
5aioe 19846 133 16881 3 0 0 0%23:52:15
6usenet.pasdenom.info 21086 122 18430 1619 0 3 0%23:59:52
7erje 13289 49 12836 11 0 1 0%23:54:25
8news.redatomik.org 21411 36 18853 0 0 171 0%23:53:56
9eternal-september 18786 14 16606 0 0 1 0%23:59:48
10neva.ru 18261 5 17864 137 0 0 0%23:59:49
11news.swapon.de 1674 4 1597 0 0 0 0%23:21:36
12news.mixmin.net 18741 4 17757 0 0 0 0%23:55:45
13weretis.net 17913 2 16775 0 0 0 0%23:50:46
14xmission 19161 2 18203 0 0 65 0%23:59:52
15bwh 0 0 0 0 0 19491 0%23:50:10
16news.fcku.it 2144 0 2068 0 0 0 0%21:03:17
17au2pb 0 0 0 0 0 19509 0%23:50:10
TOTAL: 17 269846 3847 233003 1837 0 39241 1%403:09:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net10.4 MB55.6 KB10.4 MB0.1 KB/s8.5 KB23:50:13
2xanadu-bbs9.2 MB0.0 KB9.2 MB0.1 KB/s12.3 KB23:59:52
3fu-berlin.de8.9 MB0.0 KB8.9 MB0.1 KB/s13.9 KB23:50:13
4news.bbs.geek.nz2.0 MB196.6 KB2.2 MB0.0 KB/s2.7 KB23:57:46
5usenet.pasdenom.info331.6 KB10.8 MB11.1 MB0.1 KB/s6.5 KB23:59:52
6aioe304.3 KB3.9 KB308.2 KB0.0 KB/s2.3 KB23:52:15
7erje116.8 KB43.1 KB159.9 KB0.0 KB/s2.7 KB23:54:25
8news.redatomik.org86.5 KB0.0 KB86.5 KB0.0 KB/s2.4 KB23:53:56
9eternal-september30.8 KB0.0 KB30.8 KB0.0 KB/s2.2 KB23:59:48
10news.swapon.de15.9 KB0.0 KB15.9 KB0.0 KB/s4.0 KB23:21:36
11neva.ru8.9 KB349.7 KB358.6 KB0.0 KB/s2.5 KB23:59:49
12news.mixmin.net8.4 KB0.0 KB8.4 KB0.0 KB/s2.1 KB23:55:45
13weretis.net3.0 KB0.0 KB3.0 KB0.0 KB/s1.5 KB23:50:46
14xmission3.0 KB0.0 KB3.0 KB0.0 KB/s1.5 KB23:59:52
15bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:10
16news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:03:17
17au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:10
TOTAL: 1731.4 MB11.4 MB42.8 MB0.0 KB/s7.7 KB403:09:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-03-70-24-217-190.dsl.bell.ca2318211787595.8 MB 922 0 019:49:50
2141.168.117.108 48 2042.8 KB 17 0 000:38:08
3challenger.nielsenmedia.com 2 819.0 KB 2 0 000:35:01
4a131033.upc-a.chello.nl 43 57.5 KB 5 0 012:43:38
524.178.46.210 18 35.3 KB 3 2 205:08:59
TOTAL: 52429211823595.8 MB 949 2 239:55:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca2318211787595.8 MB 922 0 019:49:50
2unresolved 66 2348.1 KB 20 2 205:47:07
3*.nielsenmedia.com 2 819.0 KB 2 0 000:35:01
4*.upc-a.chello.nl 43 57.5 KB 5 0 012:43:38
5*.bbox.io 2 00.0 KB 0 0 001:00:05
TOTAL: 52431211823595.8 MB 949 2 239:55:43

NNRP auth users [Top 20]:

UserConn
moussa 48
ohlandl 2
TOTAL: 2 50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-03-70-24-217-190.dsl.bell.ca 224.141 98.545 0.00019:49:50
a131033.upc-a.chello.nl 3.392 0.606 0.00012:43:38
24.178.46.210 1.440 0.326 0.00705:08:59
tempe0.bbox.io 0.261 0.046 0.00001:00:05
141.168.117.108 4.280 1.066 0.17500:38:08
challenger.nielsenmedia.com 0.206 0.046 0.00000:35:01
TOTAL: 6 233.720 100.635 0.18239:55:43

Curious NNRP server explorers [Top 20]:

SystemConn
tempe0.bbox.io 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
24.178.46.210 6 0
tempe0.bbox.io 2 0
challenger.nielsenmedia.com 1 0
TOTAL: 3 9 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 209913 99.7%
2talk 415 0.2%
3uk 68 0.0%
4comp 66 0.0%
5rec 36 0.0%
6sci 5 0.0%
7fr 4 0.0%
8soc 3 0.0%
9misc 2 0.0%
10can 2 0.0%
11news 1 0.0%
TOTAL: 11 210515100.0%

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

NewsgroupCount
1alt.arts.poetry.comments 209837
2talk.politics.guns 408
3uk.legal 29
4comp.lang.python 27
5alt.home.repair 23
6rec.boats 16
7rec.arts.tv.uk.coronation-st 12
8alt.society.liberalism 12
9uk.media.radio.archers 11
10comp.sys.ibm.ps2.hardware 11
11comp.os.vms 11
12alt.usage.english 11
13uk.d-i-y 9
14comp.lang.awk 8
15talk.politics.misc 7
16alt.atheism 7
17alt.politics.trump 6
18rec.arts.tv 5
19uk.politics.misc 5
20uk.tech.digital-tv 4
21sci.physics.relativity 4
22comp.sys.ibm.pc.games.action 3
23alt.russian.z1 3
24fr.soc.politique 3
25alt.global-warming 3
26can.politics 2
27uk.tech.broadcast 2
28uk.media.tv.misc 2
29comp.lang.c 2
30comp.os.linux.advocacy 2
31uk.radio.amateur 2
32alt.sports.basketball.nba.gs-warriors 2
33alt.california 2
34alt.support.depression 1
35soc.culture.israel 1
36comp.os.os2.programmer.misc 1
37uk.people.silversurfers 1
38rec.games.trivia 1
39uk.comp.homebuilt 1
40misc.invest.stocks 1
41sci.physics 1
42alt.buddha.short.fat.guy 1
43soc.genealogy.britain 1
44misc.survivalism 1
45news.admin.peering 1
46alt.suicide.methods 1
47alt.stupidity 1
48rec.photo.digital 1
49rec.sport.pro-wrestling 1
50uk.rec.motorcycles 1
51alt.christnet.theology 1
52soc.culture.usa 1
53alt.sports.football.pro.ny-giants 1
54fr.rec.photo 1
55uk.rec.cycling 1
56alt.forsale 1
57comp.os.os2.misc 1
TOTAL: 57 210515