Daily Usenet report for csiph.com

Dec 2 04:15:00 -- Dec 3 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 2 07:45:03 csiph pgpverify[86740]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 28703 51.3%6.1 MB 66.0%
innd 13350 23.8%1.6 MB 17.3%
nnrpd 10624 19.0%1.0 MB 11.0%
innfeed 3209 5.7%526.4 KB 5.6%
nocem 90 0.2%9.5 KB 0.1%
controlchan 4 0.0%0.6 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 55981 100.0%9.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 303504 53.6%
Negative hits 234567 41.4%
Do not exist 27372 4.8%
Cache misses 724 0.1%
TOTAL: 4 566167 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.853 0.0%559 0.000 5.104 62.000
article cleanup00:00:00.214 0.0%26946 0.000 0.008 0.037
article logging00:00:09.511 0.0%27648 0.000 0.344 4.761
article parse00:00:10.766 0.0%73703 0.000 0.146 2.317
article write00:15:58.484 1.1%19470 0.263 49.229 163.576
artlog/artcncl00:00:00.005 0.0%487 0.000 0.010 0.500
artlog/artparse00:00:00.583 0.0%575 0.000 1.014 30.000
data move00:00:00.184 0.0%535743 0.000 0.000 0.002
hisgrep/artcncl00:00:00.101 0.0%554 0.000 0.182 2.000
hishave/artcncl00:00:00.038 0.0%559 0.000 0.068 2.000
hishave/artparse00:00:00.003 0.0%572 0.000 0.005 0.125
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:45.278 0.4%568451 0.005 0.607 1.867
history sync00:00:07.170 0.0%370 0.000 19.378 281.000
history write00:07:19.399 0.5%26929 0.227 16.317 44.917
hiswrite/artcncl00:00:00.126 0.0%5 0.000 25.200 124.000
hiswrite/artparse00:00:09.134 0.0%572 0.000 15.969 205.000
idle23:12:57.887 96.7%493638 102.662 169.310 466.060
nntp read00:00:02.474 0.0%544989 0.002 0.005 0.008
overview write00:15:17.188 1.1%19470 1.048 47.108 213.047
perl filter00:00:53.643 0.1%26828 1.204 2.000 4.804
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.380 0.0%39024 0.000 0.010 0.030
TOTAL: 24:00:59.68123:58:55.421 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.038 0.0%19873 0.000 0.002 0.021
article prepare00:00:00.002 0.0%20800 0.000 0.000 0.009
article read00:00:10.263 0.0%2339 0.000 4.388 68.780
backlog stats00:00:00.222 0.0%340303 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.799 0.0%266102 0.001 0.007 0.017
data write00:00:01.559 0.0%252495 0.001 0.006 0.019
idle23:54:35.613100.0%340303 147.104 252.938 645.722
status file00:00:01.565 0.0%314 0.000 4.984 144.000
TOTAL: 23:55:06.03023:54:51.061100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle18:30:49.799 99.5%21126 73.583 3154.871600147.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.251 0.0%43280 0.000 0.006 0.167
readart00:03:47.495 0.3%8339 0.000 27.281 231.000
TOTAL: 18:35:54.25418:34:37.545 99.9%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 86642 6329 77204 3109 7%94:57:20
2csiph-out.news.weretis.net 6 40003 3715 35704 584 9%49:19:26
3feeder.eternal-september.org 4 23312 2103 20229 980 9%25:09:51
4news-out.aioe.org 3 18841 1666 17136 39 8%24:09:02
5newsfeeds.xmission.com 2 18360 1408 16944 8 7%24:22:54
6newsfeed.fu-berlin.de 12 17617 1176 16199 242 6%24:23:57
7newsfeed.neva.ru 141 21585 993 18403 2189 4%72:07:35
8news-out.mixmin.net 2 20640 877 19178 585 4%23:59:35
9news.fcku.it 2 9412 604 8578 230 6%29:22:20
10news.redatomik.org 1 21058 602 20445 11 2%26:34:15
11nntp.pasdenom.info 3 17841 68 17726 47 0%23:58:16
12news.swapon.de 4 1969 59 1910 0 2%24:06:32
13news.freedyn.net 2 10428 16 10407 5 0%13:25:10
14xanadu-bbs.net 25 517 8 509 0 1%22:52:53
15localhost 38 4 4 0 0 100%00:00:05
16news.bbs.geek.nz 1 19263 2 19261 0 0%23:59:50
TOTAL: 16 1398 327492 19630 299833 8029 5%502:49:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net24.9 MB154.0 KB15.7 MB40.7 MB 61%4.4 KB
2csiph-out.news.weretis.net12.2 MB10.2 KB19.7 MB31.9 MB 38%7.6 KB
3feeder.eternal-september.org5.5 MB0.0 KB9.7 MB15.2 MB 36%5.1 KB
4newsfeeds.xmission.com4.1 MB0.0 KB269.8 KB4.4 MB 93%3.2 KB
5news-out.aioe.org3.9 MB10.1 KB87.2 KB4.0 MB 97%2.4 KB
6news-out.mixmin.net3.6 MB11.4 KB2.1 MB5.7 MB 62%4.0 KB
7newsfeed.neva.ru3.0 MB0.0 KB6.0 MB9.0 MB 32%2.9 KB
8newsfeed.fu-berlin.de2.7 MB0.0 KB989.1 KB3.7 MB 73%2.7 KB
9news.fcku.it1.8 MB0.0 KB4.3 MB6.0 MB 29%7.4 KB
10news.redatomik.org1.6 MB0.0 KB297.7 KB1.9 MB 84%3.2 KB
11nntp.pasdenom.info174.6 KB0.0 KB68.9 KB243.6 KB 71%2.1 KB
12news.swapon.de118.6 KB0.0 KB0.0 KB118.6 KB100%2.0 KB
13news.freedyn.net43.6 KB0.0 KB67.6 KB111.1 KB 39%5.3 KB
14xanadu-bbs.net16.5 KB0.0 KB0.0 KB16.5 KB100%2.1 KB
15localhost5.8 KB0.0 KB0.0 KB5.8 KB100%1.4 KB
16news.bbs.geek.nz2.6 KB0.0 KB0.0 KB2.6 KB100%1.3 KB
TOTAL: 1663.8 MB185.7 KB59.2 MB123.1 MB 51%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 2 04:15:00 - 04:59:59 299 1.5% 0.111002.5 KB 1.6% 0.37
Dec 2 05:00:00 - 05:59:59 722 3.7% 0.203.3 MB 5.3% 0.95
Dec 2 06:00:00 - 06:59:59 405 2.1% 0.111.3 MB 2.1% 0.37
Dec 2 07:00:00 - 07:59:59 490 2.5% 0.141.9 MB 3.1% 0.55
Dec 2 08:00:00 - 08:59:59 666 3.4% 0.181.9 MB 3.1% 0.55
Dec 2 09:00:00 - 09:59:59 936 4.8% 0.263.3 MB 5.2% 0.93
Dec 2 10:00:00 - 10:59:59 934 4.8% 0.263.7 MB 5.9% 1.06
Dec 2 11:00:00 - 11:59:59 992 5.1% 0.284.6 MB 7.2% 1.30
Dec 2 12:00:00 - 12:59:59 843 4.3% 0.232.4 MB 3.7% 0.67
Dec 2 13:00:00 - 13:59:59 889 4.6% 0.253.2 MB 5.1% 0.92
Dec 2 14:00:00 - 14:59:59 992 5.1% 0.282.8 MB 4.5% 0.80
Dec 2 15:00:00 - 15:59:59 1071 5.5% 0.303.1 MB 4.9% 0.87
Dec 2 16:00:00 - 16:59:59 1074 5.5% 0.303.3 MB 5.2% 0.94
Dec 2 17:00:00 - 17:59:59 1194 6.1% 0.333.8 MB 6.0% 1.08
Dec 2 18:00:00 - 18:59:59 985 5.1% 0.272.8 MB 4.4% 0.79
Dec 2 19:00:00 - 19:59:59 1160 6.0% 0.323.3 MB 5.3% 0.95
Dec 2 20:00:00 - 20:59:59 996 5.1% 0.282.8 MB 4.5% 0.81
Dec 2 21:00:00 - 21:59:59 883 4.5% 0.252.7 MB 4.3% 0.77
Dec 2 22:00:00 - 22:59:59 773 4.0% 0.212.2 MB 3.5% 0.63
Dec 2 23:00:00 - 23:59:59 774 4.0% 0.212.3 MB 3.7% 0.66
Dec 3 00:00:00 - 00:59:59 695 3.6% 0.192.2 MB 3.5% 0.62
Dec 3 01:00:00 - 01:59:59 511 2.6% 0.141.5 MB 2.4% 0.43
Dec 3 02:00:00 - 02:59:59 623 3.2% 0.171.7 MB 2.6% 0.47
Dec 3 03:00:00 - 03:59:59 467 2.4% 0.131.7 MB 2.7% 0.48
Dec 3 04:00:00 - 04:15:00 80 0.4% 0.09201.9 KB 0.3% 0.22
TOTAL: 24:00:00 19454 100.0% 0.2363.1 MB 100.0% 0.75
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 3156 206 0 15 0 0 0 0 2935
2newsfeed.neva.ru 2213 141 0 0 0 0 0 0 2072
3feeder.eternal-september.org 976 82 0 0 0 0 0 0 894
4newsfeed.fu-berlin.de 782 40 0 0 0 0 0 0 742
5csiph-out.news.weretis.net 646 194 0 1 0 0 0 0 451
6news-out.mixmin.net 602 8 0 3 0 0 0 0 591
7news.fcku.it 211 2 0 0 0 0 0 0 209
8news-out.aioe.org 54 35 0 1 0 0 0 0 18
9nntp.pasdenom.info 47 21 0 0 0 0 0 0 26
10news.redatomik.org 34 0 0 0 0 0 0 0 34
11news.freedyn.net 18 3 0 0 0 0 0 0 15
12news.swapon.de 13 0 0 0 0 0 0 0 13
13newsfeeds.xmission.com 10 4 0 0 0 0 0 0 6
TOTAL: 13 8762 736 0 20 0 0 0 0 8006

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.survival 112
lada.talk 87
mozilla.general 62
alt.windows7.general 45
mpc.lists.freebsd.ports.bugs 34
spline.eisfair 30
alt.politics.usa 26
lada.auto 24
it-alt.sport.calcio.juventus 23
gmane.comp.gis.openstreetmap.tagging 21
mozilla.support.firefox 21
alt.computer.workshop 19
nemo.bavardages 18
mozilla.support.seamonkey 16
alt.politics 15
mpc.lists.nanog 11
alt.binaries.ebooks 9
ut.test 8
alt.att 7
gmane.linux.drivers.devicetree 7
TOTAL: 92 736

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5880
EMP (phn path) 463
EMP (phn nph) 75
Too many newsgroups 51
User-issued spam cancel 24
User-issued cancel 21
Binary Payload 18
Scoring filter (11) 15
Scoring filter (10) 14
HTML Multipart 13
Too many newsgroups (low_xpost) 12
Scoring filter (8) 12
Scoring filter (12) 9
Scoring filter (9) 7
HTML post 5
Scoring filter (13) 4
Scoring filter (14) 3
Poison newsgroup 2
Scoring filter (18) 2
Cancel for rejected article 2
TOTAL: 22 6635

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com8309696
TOTAL: 18309696

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 80
TOTAL: 1 80
Huge articles
csiph-out.news.weretis.net 206
csiph-out.feeder.erje.net 183
news.fcku.it 68
feeder.eternal-september.org 67
news-out.mixmin.net 18
news.redatomik.org 8
newsfeed.fu-berlin.de 8
news.freedyn.net 6
newsfeeds.xmission.com 4
TOTAL: 9 568
Including strange strings
newsfeed.fu-berlin.de 531
csiph-out.news.weretis.net 68
csiph-out.feeder.erje.net 37
news.redatomik.org 20
news-out.mixmin.net 13
news.swapon.de 13
news-out.aioe.org 7
news.fcku.it 6
newsfeed.neva.ru 3
feeder.eternal-september.org 2
TOTAL: 11 701
No colon-space in header
csiph-out.feeder.erje.net 3
TOTAL: 1 3
TOTAL: 4 1352

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.freedyn.net 20237 1034 18285 36 0 64 5%23:50:04
2xanadu-bbs 22107 986 18414 29 0 40 4%23:57:32
3fu-berlin.de 17920 759 17160 0 0 0 4%23:52:45
4news.bbs.geek.nz 31306 570 17891 42 0 0 1%23:50:11
5usenet.pasdenom.info 20174 96 17801 1467 0 338 0%23:56:08
6erje 13083 26 12813 13 0 0 0%23:50:03
7aioe 16509 25 15920 6 0 0 0%23:56:39
8news.redatomik.org 18416 22 17885 7 0 0 0%23:50:03
9news.mixmin.net 17313 8 17106 5 0 0 0%23:50:04
10news.swapon.de 1971 5 1957 0 0 0 0%23:47:32
11xmission 18559 4 17240 0 0 0 0%23:58:47
12weretis.net 15589 4 14379 0 0 0 0%23:53:02
13eternal-september 16808 3 16273 0 0 0 0%23:50:04
14neva.ru 17520 3 17330 43 0 0 0%23:58:11
15bwh 0 0 0 0 0 18511 0%23:50:01
16au2pb 0 0 0 0 0 18527 0%23:50:01
17news.fcku.it 1236 0 1236 0 0 0 0%22:00:25
TOTAL: 17 248748 3545 221690 1648 0 37480 1%404:01:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net9.9 MB162.9 KB10.0 MB0.1 KB/s9.6 KB23:50:04
2xanadu-bbs9.7 MB79.1 KB9.8 MB0.1 KB/s9.8 KB23:57:32
3fu-berlin.de9.1 MB0.0 KB9.1 MB0.1 KB/s12.2 KB23:52:45
4news.bbs.geek.nz1.6 MB172.2 KB1.8 MB0.0 KB/s2.9 KB23:50:11
5usenet.pasdenom.info396.3 KB10.3 MB10.7 MB0.1 KB/s7.0 KB23:56:08
6erje75.7 KB41.5 KB117.2 KB0.0 KB/s3.0 KB23:50:03
7news.redatomik.org56.8 KB21.0 KB77.8 KB0.0 KB/s2.7 KB23:50:03
8aioe56.0 KB16.0 KB71.9 KB0.0 KB/s2.3 KB23:56:39
9news.mixmin.net14.5 KB16.5 KB31.0 KB0.0 KB/s2.4 KB23:50:04
10news.swapon.de7.4 KB0.0 KB7.4 KB0.0 KB/s1.5 KB23:47:32
11xmission5.8 KB0.0 KB5.8 KB0.0 KB/s1.5 KB23:58:47
12weretis.net5.8 KB0.0 KB5.8 KB0.0 KB/s1.5 KB23:53:02
13neva.ru5.6 KB87.6 KB93.1 KB0.0 KB/s2.0 KB23:58:11
14eternal-september4.0 KB0.0 KB4.0 KB0.0 KB/s1.3 KB23:50:04
15bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
16au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
17news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:00:25
TOTAL: 1730.8 MB10.9 MB41.7 MB0.0 KB/s8.2 KB404:01:32
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-06-70-55-74-86.dsl.bell.ca 350 264775.4 KB 54 0 000:38:27
2141.168.117.108 48 93281.1 KB 67 0 000:47:06
371-82-225-155.dhcp.stpt.wi.charter.com 26 58.4 KB 5 4 407:38:32
4a131033.upc-a.chello.nl 22 45.8 KB 3 0 005:00:41
5tempe0.bbox.io 9 45.8 KB 2 0 003:50:45
6194-73-239-109.cust.centrio.cz 2 28.0 KB 2 0 000:09:34
TOTAL: 6 457 3721.1 MB 133 4 418:35:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 350 264775.4 KB 54 0 000:38:27
2unresolved 48 93281.1 KB 67 0 000:47:06
3*.dhcp.stpt.wi.charter.com 26 58.4 KB 5 4 407:38:32
4*.upc-a.chello.nl 22 45.8 KB 3 0 005:00:41
5*.bbox.io 9 45.8 KB 2 0 003:50:45
6*.cust.centrio.cz 2 28.0 KB 2 0 000:09:34
7*.static.chello.nl 2 00.0 KB 0 0 000:00:30
8*.nielsenmedia.com 1 00.0 KB 0 0 000:30:10
TOTAL: 8 460 3721.1 MB 133 4 418:35:49

NNRP auth users [Top 20]:

UserConn
moussa 48
ohlandl 4
ctomczyk 2
TOTAL: 3 54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
71-82-225-155.dhcp.stpt.wi.charter.com 2.360 0.452 0.01907:38:32
a131033.upc-a.chello.nl 1.908 0.328 0.00005:00:41
tempe0.bbox.io 0.804 0.174 0.00003:50:45
141.168.117.108 5.464 1.066 0.19800:47:06
mtrlpq2314w-lp140-06-70-55-74-86.dsl.bell.ca 27.937 6.583 0.00000:38:27
challenger.nielsenmedia.com 0.077 0.026 0.00000:30:10
194-73-239-109.cust.centrio.cz 0.260 0.041 0.01000:09:34
095-096-102-220.static.chello.nl 0.211 0.024 0.00000:00:30
TOTAL: 8 39.021 8.694 0.22718:35:49

Curious NNRP server explorers [Top 20]:

SystemConn
095-096-102-220.static.chello.nl 2
challenger.nielsenmedia.com 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
71-82-225-155.dhcp.stpt.wi.charter.com 9 0
tempe0.bbox.io 7 0
challenger.nielsenmedia.com 1 0
TOTAL: 3 17 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 206 55.4%
2comp 81 21.8%
3uk 23 6.2%
4fr 21 5.6%
5aus 18 4.8%
6rec 12 3.2%
7soc 6 1.6%
8pl 2 0.5%
9misc 1 0.3%
10sci 1 0.3%
11talk 1 0.3%
TOTAL: 11 372100.0%

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

NewsgroupCount
1alt.atheism 91
2alt.comp.freeware 56
3comp.os.vms 40
4fr.soc.politique 21
5alt.society.liberalism 18
6comp.sys.ibm.ps2.hardware 18
7alt.usage.english 16
8aus.cars 13
9uk.d-i-y 11
10comp.sys.ibm.pc.games.action 10
11alt.home.repair 9
12uk.legal 6
13rec.arts.tv 6
14aus.legal 4
15alt.bible.prophecy 4
16alt.slack 3
17uk.sport.cricket 2
18comp.arch 2
19comp.arch.embedded 2
20pl.comp.www 2
21alt.sports.football.pro.sd-chargers 2
22rec.woodworking 2
23alt.politics.trump 2
24comp.os.cpm 2
25rec.sport.tennis 2
26comp.lang.c 2
27soc.culture.usa 2
28soc.culture.polish 1
29alt.usenet.offline-reader.forte-agent 1
30rec.boats 1
31uk.sci.weather 1
32comp.os.msdos.misc 1
33soc.culture.israel 1
34uk.media.radio.archers 1
35uk.rec.gardening 1
36soc.culture.lebanon 1
37misc.news.internet.discuss 1
38talk.politics.misc 1
39sci.physics.relativity 1
40alt.tv.general-hospital 1
41alt.war.vietnam 1
42alt.arts.poetry.comments 1
43soc.retirement 1
44alt.rush-limbaugh 1
45comp.lang.perl.misc 1
46uk.radio.amateur 1
47comp.mobile.android 1
48rec.arts.tv.uk.coronation-st 1
49comp.lang.c++ 1
50comp.lang.python 1
51aus.politics 1
TOTAL: 51 372