Daily Usenet report for csiph.com

Aug 17 04:15:00 -- Aug 18 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 17 11:10:03 csiph pgpverify[3614]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 32457 44.2%7.0 MB 60.2%
nnrpd 22893 31.2%2.3 MB 20.1%
innd 14708 20.0%1.7 MB 15.0%
innfeed 3179 4.3%532.4 KB 4.5%
nocem 122 0.2%13.0 KB 0.1%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 73364 100.0%11.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 345191 53.6%
Negative hits 266531 41.4%
Do not exist 31641 4.9%
Cache misses 805 0.1%
TOTAL: 4 644168 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.980 0.0%365 0.000 8.164 59.182
article cleanup00:00:00.226 0.0%30450 0.000 0.007 0.028
article logging00:00:06.887 0.0%30966 0.000 0.222 3.407
article parse00:00:14.602 0.0%94788 0.004 0.154 1.320
article write00:03:47.723 0.3%22325 0.268 10.200 50.323
artlog/artcncl00:00:00.064 0.0%244 0.000 0.262 3.909
artlog/artparse00:00:00.221 0.0%1256 0.000 0.176 12.500
data move00:00:00.513 0.0%614900 0.000 0.001 0.020
hisgrep/artcncl00:00:01.339 0.0%361 0.000 3.709 34.333
hishave/artcncl00:00:00.424 0.0%365 0.000 1.162 23.667
hishave/artparse00:00:00.007 0.0%1253 0.000 0.006 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:21.432 0.2%644549 0.002 0.313 1.600
history sync00:00:04.210 0.0%358 0.000 11.760 195.000
history write00:04:29.895 0.3%30439 2.240 8.867 54.233
hiswrite/artcncl00:00:00.021 0.0%4 1.000 5.250 13.000
hiswrite/artparse00:00:12.857 0.0%1253 0.000 10.261 124.286
idle23:36:43.171 98.3%595839 75.998 142.661 440.188
nntp read00:00:02.969 0.0%625618 0.001 0.005 0.020
overview write00:09:04.110 0.6%22325 1.447 24.372 903.231
perl filter00:01:08.820 0.1%30409 1.434 2.263 19.107
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.411 0.0%44766 0.000 0.009 0.037
TOTAL: 24:00:52.65623:59:22.882 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.088 0.0%22316 0.000 0.004 0.030
article prepare00:00:00.004 0.0%31520 0.000 0.000 0.004
article read00:00:02.498 0.0%5260 0.000 0.475 39.500
backlog stats00:00:00.246 0.0%394887 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.164 0.0%309708 0.003 0.007 0.012
data write00:00:01.863 0.0%295511 0.002 0.006 0.013
idle23:54:02.860100.0%394887 123.786 217.892 585.237
status file00:00:00.512 0.0%289 0.000 1.772 25.000
TOTAL: 23:54:20.72223:54:10.235100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.080 0.0%36 0.000 2.222 15.000
idle29:40:28.204 99.7%34956 81.429 3056.076900326.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.361 0.0%70705 0.000 0.005 0.250
readart00:02:23.041 0.1%12156 0.000 11.767 543.000
TOTAL: 29:45:16.20729:42:51.686 99.9%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 4 45462 6785 38105 572 14%46:18:42
2csiph-out.feeder.erje.net 1152 94529 5337 83826 5366 5%94:57:41
3feeder.eternal-september.org 5 26283 3242 22173 868 12%24:38:23
4news-out.aioe.org 3 22150 1622 20485 43 7%24:09:38
5news-out.mixmin.net 3 23833 1364 22133 336 5%24:08:31
6newsfeed.neva.ru 148 23771 1294 20678 1799 5%71:38:51
7news.redatomik.org 1 21374 1170 20199 5 5%23:58:25
8newsfeed.fu-berlin.de 62 22979 974 21733 272 4%35:20:11
9newsfeeds.xmission.com 3 24055 395 23657 3 1%26:13:04
10news.fcku.it 1 9018 182 8798 38 2%23:59:57
11news.swapon.de 2 1887 83 1803 1 4%22:19:33
12news.freedyn.net 2 24877 79 24740 58 0%23:59:44
13nntp.pasdenom.info 2 21311 14 21296 1 0%23:59:02
14news.bbs.geek.nz 1 18872 6 18863 3 0%23:59:47
15xanadu-bbs.net 9 790 5 785 0 0%23:40:47
16localhost 33 0 0 0 0 0%00:00:12
TOTAL: 16 1431 381191 22552 349274 9365 5%513:22:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net21.8 MB11.3 KB68.4 MB90.1 MB 24%8.6 KB
2csiph-out.news.weretis.net19.4 MB0.0 KB10.6 MB30.0 MB 64%4.2 KB
3feeder.eternal-september.org9.5 MB3.3 KB6.4 MB15.9 MB 59%4.0 KB
4news-out.mixmin.net6.7 MB0.0 KB1.1 MB7.9 MB 85%4.7 KB
5news-out.aioe.org4.9 MB0.0 KB68.3 KB5.0 MB 98%3.1 KB
6newsfeed.neva.ru3.7 MB10.8 KB6.7 MB10.4 MB 35%3.4 KB
7news.redatomik.org3.5 MB0.0 KB14.5 KB3.5 MB 99%3.0 KB
8newsfeed.fu-berlin.de2.3 MB0.0 KB480.9 KB2.7 MB 82%2.3 KB
9newsfeeds.xmission.com1019.0 KB2.6 KB6.0 KB1.0 MB 99%2.6 KB
10news.freedyn.net334.8 KB0.0 KB906.4 KB1.2 MB 26%9.1 KB
11news.fcku.it306.4 KB0.0 KB1.1 MB1.4 MB 22%6.3 KB
12news.swapon.de200.6 KB0.0 KB1.1 KB201.7 KB 99%2.4 KB
13news.bbs.geek.nz124.5 KB0.0 KB127.8 KB252.2 KB 49%28.0 KB
14nntp.pasdenom.info39.4 KB0.0 KB3.0 KB42.4 KB 92%2.8 KB
15xanadu-bbs.net10.8 KB0.0 KB0.0 KB10.8 KB100%2.2 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1673.7 MB28.0 KB95.8 MB169.6 MB 43%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 17 04:15:00 - 04:59:59 398 1.8% 0.151.6 MB 2.2% 0.62
Aug 17 05:00:00 - 05:59:59 493 2.2% 0.141.9 MB 2.6% 0.53
Aug 17 06:00:00 - 06:59:59 686 3.1% 0.192.2 MB 3.1% 0.63
Aug 17 07:00:00 - 07:59:59 917 4.1% 0.252.5 MB 3.5% 0.72
Aug 17 08:00:00 - 08:59:59 1056 4.7% 0.293.6 MB 5.0% 1.03
Aug 17 09:00:00 - 09:59:59 1000 4.5% 0.283.6 MB 5.0% 1.03
Aug 17 10:00:00 - 10:59:59 961 4.3% 0.274.0 MB 5.4% 1.13
Aug 17 11:00:00 - 11:59:59 945 4.2% 0.262.6 MB 3.6% 0.74
Aug 17 12:00:00 - 12:59:59 1102 4.9% 0.314.1 MB 5.6% 1.15
Aug 17 13:00:00 - 13:59:59 1200 5.4% 0.333.4 MB 4.7% 0.97
Aug 17 14:00:00 - 14:59:59 1217 5.5% 0.343.9 MB 5.4% 1.12
Aug 17 15:00:00 - 15:59:59 1385 6.2% 0.385.8 MB 8.0% 1.65
Aug 17 16:00:00 - 16:59:59 1243 5.6% 0.353.3 MB 4.5% 0.94
Aug 17 17:00:00 - 17:59:59 1283 5.7% 0.363.5 MB 4.8% 0.99
Aug 17 18:00:00 - 18:59:59 1465 6.6% 0.414.8 MB 6.5% 1.35
Aug 17 19:00:00 - 19:59:59 1201 5.4% 0.334.0 MB 5.4% 1.13
Aug 17 20:00:00 - 20:59:59 984 4.4% 0.272.7 MB 3.8% 0.78
Aug 17 21:00:00 - 21:59:59 1162 5.2% 0.323.5 MB 4.8% 0.99
Aug 17 22:00:00 - 22:59:59 904 4.1% 0.253.0 MB 4.1% 0.86
Aug 17 23:00:00 - 23:59:59 562 2.5% 0.161.8 MB 2.5% 0.51
Aug 18 00:00:00 - 00:59:59 537 2.4% 0.151.7 MB 2.4% 0.49
Aug 18 01:00:00 - 01:59:59 555 2.5% 0.151.9 MB 2.6% 0.54
Aug 18 02:00:00 - 02:59:59 458 2.1% 0.131.6 MB 2.1% 0.44
Aug 18 03:00:00 - 03:59:59 493 2.2% 0.141.5 MB 2.0% 0.42
Aug 18 04:00:00 - 04:15:00 112 0.5% 0.12328.2 KB 0.4% 0.36
TOTAL: 24:00:00 22319 100.0% 0.2672.8 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 5422 348 0 3 0 0 0 0 5071
2newsfeed.neva.ru 1814 220 0 4 0 0 0 0 1590
3feeder.eternal-september.org 882 47 0 1 0 0 0 0 834
4newsfeed.fu-berlin.de 656 18 0 0 0 0 0 0 638
5csiph-out.news.weretis.net 594 240 0 1 0 0 0 0 353
6news-out.mixmin.net 339 5 0 1 0 0 0 0 333
7news.freedyn.net 56 3 0 0 0 0 0 0 53
8news-out.aioe.org 48 35 0 1 0 0 0 0 12
9news.fcku.it 38 3 0 0 0 0 0 0 35
10news.swapon.de 19 0 0 0 0 0 0 0 19
11news.redatomik.org 15 0 0 1 0 0 0 0 14
12news.bbs.geek.nz 5 0 0 0 0 0 0 0 5
13newsfeeds.xmission.com 3 1 0 1 0 0 0 0 1
14nntp.pasdenom.info 2 1 0 1 0 0 0 0 0
TOTAL: 14 9893 921 0 14 0 0 0 0 8958

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 110
ut.test 104
gmane.linux.kernel 63
gmane.linux.alsa.devel 53
it-alt.sport.calcio.juventus 47
it.annunci.commerciali 39
it.annunci.varie 38
alt.computer.workshop 37
it.annunci.immobiliari 36
gmane.comp.gis.openstreetmap.tagging 24
lada.auto 23
mozilla.dev.security.policy 22
alt.survival 18
mozilla.support.firefox 17
alt.philosophy 15
mozilla.support.thunderbird 13
gmane.linux.bios.flashrom 12
spline.eisfair 11
mpc.lists.nanog 11
eagle.support.eng 10
TOTAL: 114 921

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6004
EMP (phn path) 640
EMP (phn nph) 249
Too many newsgroups 77
Binary Payload 36
Scoring filter (10) 32
User-issued cancel 22
HTML Multipart 21
Scoring filter (11) 18
Scoring filter (8) 14
Scoring filter (9) 7
Scoring filter (12) 6
EMP (phl) 6
HTML post 6
Scoring filter (14) 4
Scoring filter (15) 3
Too many newsgroups (low_xpost) 3
Too many newsgroups (meow) 2
Binary: misplaced 021 2
Scoring filter (17) 2
TOTAL: 25 7159

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1160130130
TOTAL: 11160130130

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
csiph-out.feeder.erje.net 4
TOTAL: 1 4
Huge articles
csiph-out.feeder.erje.net 1030
csiph-out.news.weretis.net 139
feeder.eternal-september.org 48
news.fcku.it 13
news.freedyn.net 10
news-out.mixmin.net 8
news.bbs.geek.nz 5
TOTAL: 7 1253
Including strange strings
newsfeed.fu-berlin.de 399
csiph-out.feeder.erje.net 53
csiph-out.news.weretis.net 24
news.swapon.de 18
news.redatomik.org 9
news-out.aioe.org 5
news-out.mixmin.net 4
feeder.eternal-september.org 3
newsfeed.neva.ru 1
TOTAL: 9 516
No colon-space in header
csiph-out.feeder.erje.net 1
TOTAL: 1 1
TOTAL: 4 1774

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 37837 3409 18194 76 0 0 9%23:56:38
2xanadu-bbs 24135 826 21467 20 0 32 3%23:59:47
3news.freedyn.net 23226 756 21407 4 0 0 3%23:50:02
4fu-berlin.de 21114 579 20534 0 0 0 2%23:50:02
5erje 20707 349 16353 41 0 0 1%23:50:02
6usenet.pasdenom.info 22622 96 20697 1510 0 9 0%23:59:54
7aioe 18891 80 18338 2 0 0 0%23:55:43
8news.redatomik.org 20823 19 20486 0 0 0 0%23:56:47
9neva.ru 20307 5 20051 95 0 0 0%23:59:54
10weretis.net 14536 4 14342 0 0 0 0%23:50:02
11news.swapon.de 1908 2 1898 0 0 0 0%23:48:51
12xmission 22834 2 21200 0 0 0 0%23:59:40
13bwh 0 0 0 0 0 21645 0%23:50:05
14news.fcku.it 1791 0 1772 0 0 0 0%22:28:14
15au2pb 0 0 0 0 0 21656 0%23:50:05
16news.mixmin.net 20124 0 19912 0 0 0 0%23:50:02
17eternal-september 18680 0 18251 6 0 0 0%23:59:50
TOTAL: 17 289535 6127 254902 1754 0 43342 2%404:55:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs9.4 MB40.2 KB9.5 MB0.1 KB/s11.5 KB23:59:47
2news.freedyn.net9.2 MB36.8 KB9.3 MB0.1 KB/s12.5 KB23:50:02
3news.bbs.geek.nz9.2 MB345.7 KB9.5 MB0.1 KB/s2.8 KB23:56:38
4fu-berlin.de8.7 MB0.0 KB8.7 MB0.1 KB/s15.4 KB23:50:02
5erje989.2 KB183.3 KB1.1 MB0.0 KB/s3.0 KB23:50:02
6usenet.pasdenom.info251.8 KB10.3 MB10.5 MB0.1 KB/s6.7 KB23:59:54
7aioe221.8 KB6.6 KB228.3 KB0.0 KB/s2.8 KB23:55:43
8news.redatomik.org45.3 KB0.0 KB45.3 KB0.0 KB/s2.4 KB23:56:47
9neva.ru11.7 KB214.9 KB226.6 KB0.0 KB/s2.3 KB23:59:54
10weretis.net7.8 KB0.0 KB7.8 KB0.0 KB/s1.9 KB23:50:02
11news.swapon.de4.9 KB0.0 KB4.9 KB0.0 KB/s2.4 KB23:48:51
12xmission4.0 KB0.0 KB4.0 KB0.0 KB/s2.0 KB23:59:40
13bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:05
14news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:28:14
15au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:05
16news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
17eternal-september0.0 KB9.2 KB9.2 KB0.0 KB/s1.5 KB23:59:50
TOTAL: 1738.1 MB11.1 MB49.2 MB0.0 KB/s6.4 KB404:55:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1bas2-montrealak-70-49-69-223.dsl.bell.ca1200 166466.6 KB 109 0 001:36:44
2144.138.90.254 48 67251.4 KB 50 0 000:35:01
3194-73-239-109.cust.centrio.cz 7 926.9 KB 3 0 002:12:05
4tempe0.bbox.io 16 947.2 KB 3 0 005:29:18
5challenger.nielsenmedia.com 7 813.2 KB 4 0 003:06:51
6mtrlpq2314w-lp130-01-70-49-69-223.dsl.bell.ca 100 510.5 KB 4 0 000:06:56
TOTAL: 61378 264815.7 KB 173 0 029:45:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca1300 171477.0 KB 113 0 001:43:41
2unresolved 87 67251.4 KB 50 0 014:42:37
3*.bbox.io 16 947.2 KB 3 0 005:29:18
4*.cust.centrio.cz 7 926.9 KB 3 0 002:12:05
5*.nielsenmedia.com 7 813.2 KB 4 0 003:06:51
6*.upc-a.chello.nl 17 00.0 KB 0 0 002:30:31
TOTAL: 61434 264815.7 KB 173 0 029:45:05

NNRP auth users [Top 20]:

UserConn
moussa 48
ctomczyk 7
TOTAL: 2 55

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
216.239.174.160 1.836 0.389 0.00010:31:08
tempe0.bbox.io 1.463 0.218 0.00005:29:18
challenger.nielsenmedia.com 0.586 0.118 0.00003:06:51
24.178.44.90 0.688 0.137 0.00002:43:15
a131033.upc-a.chello.nl 1.113 0.337 0.00002:30:31
194-73-239-109.cust.centrio.cz 0.645 0.165 0.02602:12:05
bas2-montrealak-70-49-69-223.dsl.bell.ca 108.752 19.894 0.00001:36:44
144.138.90.254 5.277 1.150 0.18500:35:01
216.239.174.135 0.094 0.008 0.00000:30:00
216.239.174.218 0.219 0.093 0.00000:23:11
mtrlpq2314w-lp130-01-70-49-69-223.dsl.bell.ca 8.911 1.108 0.00000:06:56
TOTAL: 11 129.584 23.617 0.21129:45:05

Curious NNRP server explorers [Top 20]:

SystemConn
216.239.174.160 24
a131033.upc-a.chello.nl 17
24.178.44.90 10
216.239.174.218 4
216.239.174.135 1
TOTAL: 5 56

NNRP client timeouts [Top 20]:

SystemConnPeer
216.239.174.160 20 3
tempe0.bbox.io 9 0
challenger.nielsenmedia.com 5 0
24.178.44.90 5 0
216.239.174.218 4 4
194-73-239-109.cust.centrio.cz 3 0
216.239.174.135 1 0
TOTAL: 7 47 7

Newsgroup request counts (by category):

CategoryCountPct
1comp 121 45.8%
2uk 71 26.9%
3alt 34 12.9%
4rec 18 6.8%
5muc 9 3.4%
6soc 4 1.5%
7aus 3 1.1%
8misc 3 1.1%
9sci 1 0.4%
TOTAL: 9 264100.0%

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

NewsgroupCount
1uk.legal 25
2uk.d-i-y 21
3comp.lang.python 21
4comp.arch 21
5uk.rec.cycling 11
6comp.ai.philosophy 11
7rec.boats 11
8alt.home.repair 11
9comp.lang.javascript 9
10comp.arch.fpga 8
11comp.lang.awk 8
12comp.os.vms 8
13muc.lists.freebsd.hardware 7
14comp.os.linux.advocacy 6
15alt.os.linux.ubuntu 5
16comp.lang.c++ 4
17alt.sports.football.pro.sd-chargers 4
18alt.sports.basketball.nba.gs-warriors 4
19comp.os.msdos.djgpp 4
20comp.os.os2.advocacy 4
21comp.arch.embedded 4
22uk.radio.amateur 3
23comp.mobile.android 3
24uk.tech.broadcast 3
25comp.os.msdos.misc 3
26comp.os.os2.apps 3
27uk.rec.sheds 3
28misc.survivalism 3
29alt.atheism 3
30soc.genealogy.medieval 2
31comp.lang.c 2
32uk.media.radio.archers 2
33alt.os.linux 2
34rec.photo.digital 1
35alt.stupidity 1
36rec.sport.cricket 1
37rec.arts.tv.uk.coronation-st 1
38aus.legal 1
39soc.retirement 1
40rec.sport.tennis 1
41uk.railway 1
42comp.sys.ibm.pc.games.action 1
43alt.conspiracy 1
44muc.lists.freebsd.fs 1
45alt.comp.freeware 1
46rec.outdoors.rv-travel 1
47aus.politics 1
48uk.rec.motorcycles 1
49muc.lists.freebsd.current 1
50sci.lang 1
51comp.sys.mac.system 1
52aus.cars 1
53rec.crafts.metalworking 1
54alt.tv.general-hospital 1
55soc.genealogy.britain 1
56uk.media.tv.misc 1
57alt.os.linux.mint 1
58rec.arts.tv 1
TOTAL: 58 264