Daily Usenet report for csiph.com

Feb 9 04:15:00 -- Feb 10 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 45283 51.5%8.5 MB 64.2%
innd 24595 28.0%2.6 MB 19.8%
nnrpd 14691 16.7%1.6 MB 11.9%
innfeed 3210 3.7%537.0 KB 4.0%
nocem 92 0.1%9.7 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 87872 100.0%13.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 449175 56.3%
Negative hits 304056 38.1%
Do not exist 44111 5.5%
Cache misses 697 0.1%
TOTAL: 4 798039 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.313 0.0%276 0.000 4.757 23.611
article cleanup00:00:00.270 0.0%44326 0.000 0.006 0.019
article logging00:00:04.680 0.0%44903 0.000 0.104 0.795
article parse00:00:02.417 0.0%144484 0.002 0.017 0.194
article write00:02:16.661 0.2%24733 0.207 5.525 25.551
artlog/artcncl00:00:00.030 0.0%251 0.000 0.120 1.200
artlog/artparse00:00:00.004 0.0%176 0.000 0.023 0.500
data move00:00:00.301 0.0%730669 0.000 0.000 0.003
hisgrep/artcncl00:00:00.496 0.0%271 0.000 1.830 14.833
hishave/artcncl00:00:00.084 0.0%276 0.000 0.304 3.278
hishave/artparse00:00:00.000 0.0%175 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:56.905 0.1%801708 0.003 0.146 0.538
history sync00:00:04.948 0.0%350 0.000 14.137 126.667
history write00:03:43.740 0.3%44141 0.087 5.069 27.125
hiswrite/artcncl00:00:00.005 0.0%5 0.000 1.000 5.000
hiswrite/artparse00:00:00.744 0.0%174 0.000 4.276 37.000
idle23:44:30.361 98.9%714116 73.942 119.687 294.185
nntp read00:00:03.305 0.0%745436 0.002 0.004 0.007
overview write00:04:48.752 0.3%24733 1.226 11.675 85.945
perl filter00:01:48.799 0.1%44044 1.451 2.470 4.269
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.459 0.0%49551 0.000 0.009 0.028
TOTAL: 24:00:47.13323:59:24.274 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.082 0.0%24992 0.000 0.003 0.021
article prepare00:00:00.004 0.0%44968 0.000 0.000 0.006
article read00:00:01.464 0.0%8860 0.027 0.165 1.600
backlog stats00:00:00.288 0.0%460315 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.402 0.0%353428 0.001 0.007 0.013
data write00:00:02.074 0.0%335333 0.002 0.006 0.013
idle23:54:47.342100.0%460315 123.892 187.018 524.110
status file00:00:00.242 0.0%283 0.000 0.855 19.000
TOTAL: 23:55:04.38023:54:53.898100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:03.725 0.0%2215 0.000 1.682 13.000
idle46:09:23.436 99.8%30785 78.929 5397.545900139.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.312 0.0%61868 0.000 0.005 0.167
readart00:00:43.893 0.0%11871 0.000 3.697 61.000
TOTAL: 46:15:23.24746:10:11.366 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 142599 6748 123574 12277 4%94:33:55
2csiph-out.news.weretis.net 4 48129 5727 41625 777 11%44:48:20
3feeder.eternal-september.org 2 39970 3609 32021 4340 9%24:29:17
4news-out.aioe.org 3 23926 2636 21254 36 11%24:09:52
5newsfeed.fu-berlin.de 50 27088 1371 25258 459 5%35:14:06
6newsfeed.neva.ru 140 57406 1338 52718 3350 2%71:39:39
7newsfeeds.xmission.com 2 24475 954 23520 1 3%25:30:36
8news-out.mixmin.net 4 26707 761 25704 242 2%24:09:05
9news.redatomik.org 1 21499 685 20808 6 3%22:02:44
10news.fcku.it 1 10844 543 10240 61 5%23:59:57
11xanadu-bbs.net 11 1586 193 1357 36 12%36:27:49
12news.freedyn.net 3 27757 119 27535 103 0%24:09:48
13news.swapon.de 2 2360 90 2260 10 3%24:47:21
14nntp.pasdenom.info 4 23894 53 23823 18 0%23:54:46
15news.bbs.geek.nz 2 19449 24 19423 2 0%23:59:38
16localhost 40 4 4 0 0 100%00:00:01
TOTAL: 16 1421 497693 24855 451120 21718 4%523:56:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net21.2 MB1.9 MB63.8 MB86.9 MB 24%4.7 KB
2csiph-out.news.weretis.net17.0 MB20.6 KB9.9 MB27.0 MB 63%4.2 KB
3feeder.eternal-september.org9.7 MB59.3 KB57.9 MB67.7 MB 14%8.7 KB
4news-out.aioe.org7.1 MB23.4 KB86.6 KB7.2 MB 98%2.8 KB
5news-out.mixmin.net4.1 MB20.1 KB874.9 KB5.0 MB 82%5.1 KB
6newsfeed.neva.ru3.4 MB158.0 KB28.9 MB32.5 MB 10%7.1 KB
7newsfeed.fu-berlin.de3.1 MB4.8 KB1.2 MB4.2 MB 72%2.4 KB
8newsfeeds.xmission.com3.0 MB0.0 KB1.5 KB3.0 MB 99%3.2 KB
9news.redatomik.org1.9 MB0.0 KB1.6 MB3.5 MB 55%5.1 KB
10news.fcku.it1.1 MB4.8 KB830.6 KB2.0 MB 58%3.3 KB
11xanadu-bbs.net554.0 KB0.0 KB331.6 KB885.6 KB 62%3.9 KB
12news.freedyn.net410.2 KB12.1 KB812.3 KB1.2 MB 33%5.6 KB
13news.swapon.de231.6 KB0.0 KB591.2 KB822.8 KB 28%8.2 KB
14nntp.pasdenom.info159.9 KB15.1 KB49.1 KB224.1 KB 71%3.2 KB
15news.bbs.geek.nz51.0 KB6.5 KB8.3 KB65.8 KB 77%2.5 KB
16localhost5.0 KB0.0 KB0.0 KB5.0 KB100%1.2 KB
TOTAL: 1673.1 MB2.2 MB166.8 MB242.0 MB 30%5.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 9 04:15:00 - 04:59:59 417 1.7% 0.151.6 MB 2.1% 0.59
Feb 9 05:00:00 - 05:59:59 622 2.5% 0.172.3 MB 3.2% 0.65
Feb 9 06:00:00 - 06:59:59 612 2.5% 0.172.9 MB 4.0% 0.82
Feb 9 07:00:00 - 07:59:59 666 2.7% 0.181.9 MB 2.6% 0.55
Feb 9 08:00:00 - 08:59:59 1016 4.1% 0.282.8 MB 3.8% 0.79
Feb 9 09:00:00 - 09:59:59 1186 4.8% 0.333.2 MB 4.4% 0.91
Feb 9 10:00:00 - 10:59:59 1210 4.9% 0.343.4 MB 4.7% 0.98
Feb 9 11:00:00 - 11:59:59 1080 4.4% 0.303.1 MB 4.2% 0.88
Feb 9 12:00:00 - 12:59:59 1143 4.6% 0.323.0 MB 4.1% 0.85
Feb 9 13:00:00 - 13:59:59 1263 5.1% 0.353.3 MB 4.6% 0.95
Feb 9 14:00:00 - 14:59:59 1332 5.4% 0.373.6 MB 4.9% 1.02
Feb 9 15:00:00 - 15:59:59 1415 5.7% 0.394.2 MB 5.7% 1.19
Feb 9 16:00:00 - 16:59:59 1373 5.6% 0.383.7 MB 5.1% 1.05
Feb 9 17:00:00 - 17:59:59 1362 5.5% 0.383.7 MB 5.1% 1.07
Feb 9 18:00:00 - 18:59:59 1409 5.7% 0.393.7 MB 5.1% 1.06
Feb 9 19:00:00 - 19:59:59 1328 5.4% 0.374.0 MB 5.4% 1.13
Feb 9 20:00:00 - 20:59:59 1230 5.0% 0.343.6 MB 4.9% 1.02
Feb 9 21:00:00 - 21:59:59 1160 4.7% 0.323.5 MB 4.9% 1.01
Feb 9 22:00:00 - 22:59:59 1211 4.9% 0.343.3 MB 4.6% 0.95
Feb 9 23:00:00 - 23:59:59 990 4.0% 0.283.2 MB 4.4% 0.90
Feb 10 00:00:00 - 00:59:59 762 3.1% 0.212.5 MB 3.4% 0.70
Feb 10 01:00:00 - 01:59:59 696 2.8% 0.192.6 MB 3.5% 0.73
Feb 10 02:00:00 - 02:59:59 623 2.5% 0.171.9 MB 2.7% 0.55
Feb 10 03:00:00 - 03:59:59 509 2.1% 0.141.5 MB 2.1% 0.44
Feb 10 04:00:00 - 04:15:00 103 0.4% 0.11262.8 KB 0.4% 0.29
TOTAL: 24:00:00 24718 100.0% 0.2972.8 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 10323 454 0 150 1 0 0 0 9718
2feeder.eternal-september.org 4379 61 0 6 0 0 0 0 4312
3newsfeed.neva.ru 3350 314 0 11 0 0 0 0 3025
4csiph-out.news.weretis.net 859 217 0 4 0 0 0 0 638
5newsfeed.fu-berlin.de 850 59 0 2 0 0 0 0 789
6news-out.mixmin.net 253 0 0 3 0 0 0 0 250
7news.freedyn.net 101 19 0 2 0 0 0 0 80
8news.fcku.it 63 1 0 1 0 0 0 0 61
9news-out.aioe.org 48 30 0 4 0 0 0 0 14
10xanadu-bbs.net 31 0 0 0 0 0 0 0 31
11news.swapon.de 24 0 0 0 0 0 0 0 24
12nntp.pasdenom.info 18 9 0 2 0 0 0 0 7
13news.redatomik.org 11 0 0 0 0 0 0 0 11
14newsfeeds.xmission.com 6 0 0 0 0 0 0 0 6
15news.bbs.geek.nz 2 0 0 1 0 0 0 0 1
TOTAL: 15 20318 1164 0 186 1 0 0 018967

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 166
ut.test 134
mozilla.general 83
it-alt.sport.calcio.juventus 75
spline.eisfair 48
it.annunci.varie 45
it.annunci.immobiliari 39
lada.auto 39
it.annunci.commerciali 38
alt.windows7.general 35
alt.survival 30
gmane.linux.alsa.devel 25
mozilla.dev.platform 24
lada.photo 20
mozilla.support.seamonkey 20
lada.commerce 19
mpc.lists.nanog 17
mozilla.dev.security.policy 15
cakewalk.audio 14
mpc.lists.freebsd.gecko 12
TOTAL: 132 1164

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
nz.politics.announce 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 15760
EMP (phn path) 1428
EMP (phl) 495
EMP (phn nph) 248
Too many newsgroups 71
Binary Payload 38
HTML Multipart 16
User-issued cancel 16
Scoring filter (8) 7
Scoring filter (14) 6
Scoring filter (11) 5
Scoring filter (13) 5
Scoring filter (19) 5
Scoring filter (12) 5
Scoring filter (9) 4
Too many newsgroups (low_xpost) 3
Scoring filter (17) 2
Scoring filter (20) 1
Scoring filter (21) 1
HTML Image Tags 1
TOTAL: 22 18119

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com8309090
TOTAL: 18309090

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 96
TOTAL: 1 96
Bad Message-ID's offered
csiph-out.feeder.erje.net 4
TOTAL: 1 4
Huge articles
feeder.eternal-september.org 96
csiph-out.news.weretis.net 56
news-out.mixmin.net 6
news.fcku.it 5
news.redatomik.org 5
newsfeed.fu-berlin.de 2
news.swapon.de 2
news.freedyn.net 1
xanadu-bbs.net 1
TOTAL: 9 174
Including strange strings
newsfeed.fu-berlin.de 439
csiph-out.feeder.erje.net 39
feeder.eternal-september.org 26
csiph-out.news.weretis.net 15
news.swapon.de 14
news-out.aioe.org 12
newsfeed.neva.ru 10
news-out.mixmin.net 8
news.redatomik.org 5
newsfeeds.xmission.com 5
TOTAL: 13 577
No colon-space in header
csiph-out.feeder.erje.net 1
TOTAL: 1 1
TOTAL: 5 852

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 40097 7376 16569 103 0 181 18%23:55:23
2news.freedyn.net 25637 787 23793 21 0 1 3%23:59:54
3xanadu-bbs 27649 716 23860 2 0 0 2%23:59:55
4fu-berlin.de 23122 606 22516 0 0 0 2%23:59:54
5usenet.pasdenom.info 27394 146 23247 1270 0 120 0%23:59:54
6xmission 28589 111 22924 6 0 2 0%23:59:55
7news.redatomik.org 24104 21 23272 7 0 0 0%23:50:10
8aioe 21426 19 20137 1 0 0 0%23:50:09
9weretis.net 17441 11 16660 2 0 0 0%23:49:06
10eternal-september 21819 10 20080 0 0 1 0%23:59:38
11erje 17911 8 17841 11 0 0 0%23:59:55
12news.mixmin.net 22950 5 22101 0 0 0 0%23:59:54
13neva.ru 23510 4 22356 12 0 1 0%23:59:48
14news.swapon.de 2346 3 2265 3 0 0 0%23:56:32
15news.fcku.it 2786 1 2771 0 0 0 0%22:33:29
16au2pb 0 0 0 0 0 24087 0%23:58:42
17bwh 0 0 0 0 0 24066 0%23:58:42
TOTAL: 17 326781 9824 280392 1438 0 48459 3%405:51:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.bbs.geek.nz19.9 MB343.9 KB20.2 MB0.2 KB/s2.8 KB23:55:23
2news.freedyn.net5.8 MB93.8 KB5.9 MB0.1 KB/s7.5 KB23:59:54
3xanadu-bbs5.6 MB6.2 KB5.6 MB0.1 KB/s8.0 KB23:59:55
4fu-berlin.de5.3 MB0.0 KB5.3 MB0.1 KB/s9.0 KB23:59:54
5usenet.pasdenom.info440.5 KB6.5 MB6.9 MB0.1 KB/s5.0 KB23:59:54
6xmission277.8 KB9.4 KB287.2 KB0.0 KB/s2.5 KB23:59:55
7aioe81.2 KB10.2 KB91.4 KB0.0 KB/s4.6 KB23:50:09
8news.redatomik.org53.3 KB86.0 KB139.3 KB0.0 KB/s5.0 KB23:50:10
9weretis.net20.1 KB26.7 KB46.8 KB0.0 KB/s3.6 KB23:49:06
10eternal-september15.9 KB0.0 KB15.9 KB0.0 KB/s1.6 KB23:59:38
11erje11.4 KB71.7 KB83.2 KB0.0 KB/s4.4 KB23:59:55
12news.mixmin.net11.4 KB0.0 KB11.4 KB0.0 KB/s2.3 KB23:59:54
13neva.ru10.2 KB39.4 KB49.6 KB0.0 KB/s3.1 KB23:59:48
14news.swapon.de4.0 KB12.8 KB16.8 KB0.0 KB/s2.8 KB23:56:32
15news.fcku.it2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB22:33:29
16au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:42
17bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:42
TOTAL: 1737.5 MB7.1 MB44.6 MB0.0 KB/s4.1 KB405:51:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca 300 109436.3 KB 71 0 000:49:23
2194-73-239-109.cust.centrio.cz 20 1335.8 KB 7 0 002:49:21
368-185-181-64.dhcp.mdsn.wi.charter.com 28 45.0 KB 4 4 407:36:05
TOTAL: 3 348 126477.0 KB 82 4 446:15:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 300 109436.3 KB 71 0 000:49:23
2*.cust.centrio.cz 20 1335.8 KB 7 0 002:49:21
3*.dhcp.mdsn.wi.charter.com 28 45.0 KB 4 4 407:36:05
4*.chello.nl 50 00.0 KB 0 0 008:20:19
5unresolved 49 00.0 KB 0 0 024:52:43
6*.bbox.io 8 00.0 KB 0 0 001:47:25
TOTAL: 6 455 126477.0 KB 82 4 446:15:19

NNRP auth users [Top 20]:

UserConn
ctomczyk 9
ohlandl 4
TOTAL: 2 13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
216.239.174.218 3.454 0.743 0.00022:29:30
dhcp-089-099-203-254.chello.nl 3.739 0.806 0.00008:20:19
68-185-181-64.dhcp.mdsn.wi.charter.com 2.352 0.635 0.01507:36:05
194-73-239-109.cust.centrio.cz 1.626 0.367 0.03302:49:21
50.96.153.220 0.191 0.188 0.00002:23:12
tempe0.bbox.io 0.687 0.135 0.00001:47:25
mtrlpq2314w-lp130-01-70-49-68-214.dsl.bell.ca 28.523 6.825 0.00000:49:23
TOTAL: 7 40.572 9.699 0.04846:15:19

Curious NNRP server explorers [Top 20]:

SystemConn
dhcp-089-099-203-254.chello.nl 50
216.239.174.218 47
tempe0.bbox.io 8
50.96.153.220 2
TOTAL: 4 107

NNRP client timeouts [Top 20]:

SystemConnPeer
216.239.174.218 43 0
68-185-181-64.dhcp.mdsn.wi.charter.com 7 0
194-73-239-109.cust.centrio.cz 5 0
tempe0.bbox.io 3 0
TOTAL: 4 58 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 67 53.2%
2comp 17 13.5%
3fr 15 11.9%
4uk 9 7.1%
5can 5 4.0%
6talk 3 2.4%
7soc 3 2.4%
8aus 2 1.6%
9rec 1 0.8%
10linux 1 0.8%
11sci 1 0.8%
12misc 1 0.8%
13dictator 1 0.8%
TOTAL: 13 126100.0%

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

NewsgroupCount
1alt.usenet.kooks 17
2comp.lang.javascript 13
3fr.soc.politique 12
4alt.fan.rush-limbaugh 10
5alt.home.repair 9
6alt.california 9
7alt.society.liberalism 6
8alt.atheism 6
9uk.rec.drugs.cannabis 5
10alt.christnet.christianlife 5
11can.politics 5
12comp.sys.ibm.ps2.hardware 4
13fr.rec.photo 3
14soc.culture.usa 3
15talk.politics.misc 3
16uk.legal 2
17uk.politics.misc 2
18alt.slack 2
19aus.religion.christian 2
20rec.bicycles.tech 1
21sci.math 1
22dictator.europe 1
23linux.kernel 1
24alt.life.sucks 1
25misc.survivalism 1
26alt.conspiracy 1
27alt.russian.z1 1
TOTAL: 27 126