Daily Usenet report for csiph.com

Sep 22 04:15:02 -- Sep 23 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 22 06:30:02 csiph pgpverify[68102]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 101625 68.9%10.5 MB 55.6%
inn 29138 19.7%6.4 MB 33.6%
innd 13445 9.1%1.5 MB 8.1%
innfeed 3260 2.2%513.0 KB 2.6%
nocem 64 0.0%6.9 KB 0.0%
controlchan 4 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 147537 100.0%18.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 326004 55.4%
Negative hits 233222 39.7%
Do not exist 28396 4.8%
Cache misses 330 0.1%
TOTAL: 4 587952 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.827 0.0%211 0.000 27.616 133.400
article cleanup00:00:00.211 0.0%27188 0.000 0.008 0.030
article logging00:00:14.184 0.0%27671 0.000 0.513 4.289
article parse00:00:22.359 0.0%90702 0.004 0.247 2.452
article write00:07:06.185 0.5%20664 1.201 20.625 105.356
artlog/artcncl00:00:00.190 0.0%200 0.000 0.950 9.000
artlog/artparse00:00:00.402 0.0%1344 0.000 0.299 51.000
data move00:00:00.389 0.0%566346 0.000 0.001 0.024
hisgrep/artcncl00:00:00.568 0.0%210 0.000 2.705 42.000
hishave/artcncl00:00:00.640 0.0%211 0.000 3.033 42.900
hishave/artparse00:00:00.002 0.0%1344 0.000 0.001 0.042
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:30.957 0.2%589014 0.002 0.358 1.592
history sync00:00:12.484 0.0%366 0.000 34.109 315.000
history write00:11:35.421 0.8%27187 5.079 25.579 92.048
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
hiswrite/artparse00:00:20.550 0.0%1344 0.000 15.290 149.000
idle23:11:03.971 96.5%510484 94.170 163.500 480.440
nntp read00:00:02.596 0.0%576463 0.002 0.005 0.011
overview write00:22:48.598 1.6%20664 8.518 66.231 308.893
perl filter00:00:57.483 0.1%27187 1.567 2.114 3.236
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.375 0.0%41385 0.000 0.009 0.034
TOTAL: 24:00:59.34323:58:23.393 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.049 0.0%20787 0.000 0.002 0.020
article prepare00:00:00.001 0.0%15036 0.000 0.000 0.017
article read00:00:04.463 0.0%1984 0.000 2.249 51.200
backlog stats00:00:00.223 0.0%347347 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.911 0.0%279785 0.003 0.007 0.013
data write00:00:01.449 0.0%265324 0.001 0.005 0.011
idle23:54:38.767100.0%347347 132.434 247.818 684.353
status file00:00:00.443 0.0%305 0.000 1.452 39.000
TOTAL: 23:54:55.67423:54:47.306100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:07.183 0.0%741 0.143 9.694 23.667
idle334:48:17.150 96.2%6598644 80.667 182.658600068.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:46.176 0.0%18157734 0.000 0.006 4.700
readart13:11:59.841 3.8%6343987 0.000 7.491 222.000
TOTAL: 348:08:33.458348:02:10.350100.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
ba-mod@panix.com000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 9 43005 6605 35566 834 15%48:46:50
2csiph-out.feeder.erje.net 1152 87797 3730 81026 3041 4%95:00:06
3feeder.eternal-september.org 8 24512 2534 21186 792 10%25:03:06
4news-out.aioe.org 2 19587 1994 17576 17 10%24:09:55
5newsfeed.neva.ru 143 26166 1514 22188 2464 5%72:33:18
6news-out.mixmin.net 3 21619 1116 20113 390 5%24:08:53
7newsfeeds.xmission.com 3 18296 1112 17179 5 6%20:52:31
8newsfeed.fu-berlin.de 33 18647 1112 17339 196 5%27:16:04
9news.redatomik.org 1 19058 693 18352 13 3%22:00:25
10news.fcku.it 2 8518 91 8332 95 1%23:59:50
11news.swapon.de 4 1671 47 1623 1 2%25:15:39
12nntp.pasdenom.info 5 19813 30 19781 2 0%23:58:34
13news.freedyn.net 2 22674 26 22629 19 0%23:59:44
14news.bbs.geek.nz 2 21218 10 21208 0 0%23:59:40
15xanadu-bbs.net 12 669 2 667 0 0%23:54:58
16localhost 34 0 0 0 0 0%00:00:02
TOTAL: 16 1415 353250 20616 324765 7869 5%504:59:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.news.weretis.net20.0 MB0.0 KB13.7 MB33.7 MB 59%4.6 KB
2csiph-out.feeder.erje.net15.3 MB0.0 KB69.5 MB84.8 MB 18%12.8 KB
3feeder.eternal-september.org6.8 MB3.7 KB6.4 MB13.2 MB 51%4.1 KB
4news-out.aioe.org4.8 MB0.0 KB46.4 KB4.9 MB 99%2.5 KB
5newsfeed.neva.ru4.5 MB0.0 KB10.6 MB15.2 MB 29%3.9 KB
6news-out.mixmin.net4.2 MB0.0 KB1.1 MB5.3 MB 79%3.6 KB
7newsfeeds.xmission.com3.4 MB0.0 KB393.4 KB3.8 MB 89%3.5 KB
8newsfeed.fu-berlin.de2.4 MB0.0 KB590.4 KB2.9 MB 80%2.3 KB
9news.redatomik.org2.0 MB0.0 KB73.7 KB2.1 MB 96%3.0 KB
10news.fcku.it181.8 KB0.0 KB661.4 KB843.2 KB 21%4.5 KB
11news.freedyn.net118.3 KB0.0 KB748.8 KB867.1 KB 13%19.3 KB
12news.swapon.de116.8 KB0.0 KB249.0 KB365.8 KB 31%7.6 KB
13nntp.pasdenom.info81.5 KB0.0 KB4.2 KB85.7 KB 95%2.7 KB
14news.bbs.geek.nz25.6 KB0.0 KB0.0 KB25.6 KB100%2.6 KB
15xanadu-bbs.net4.3 KB0.0 KB0.0 KB4.3 KB100%2.1 KB
16localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1663.9 MB3.7 KB104.1 MB168.0 MB 38%6.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 22 04:15:02 - 04:59:59 406 2.0% 0.152.5 MB 4.0% 0.97
Sep 22 05:00:00 - 05:59:59 508 2.5% 0.142.0 MB 3.1% 0.56
Sep 22 06:00:00 - 06:59:59 654 3.2% 0.182.0 MB 3.1% 0.57
Sep 22 07:00:00 - 07:59:59 810 3.9% 0.232.1 MB 3.3% 0.61
Sep 22 08:00:00 - 08:59:59 950 4.6% 0.262.5 MB 3.9% 0.70
Sep 22 09:00:00 - 09:59:59 1050 5.1% 0.293.0 MB 4.7% 0.85
Sep 22 10:00:00 - 10:59:59 1054 5.1% 0.293.2 MB 5.0% 0.91
Sep 22 11:00:00 - 11:59:59 1001 4.8% 0.282.6 MB 4.0% 0.73
Sep 22 12:00:00 - 12:59:59 1037 5.0% 0.292.7 MB 4.2% 0.76
Sep 22 13:00:00 - 13:59:59 1198 5.8% 0.333.5 MB 5.4% 0.98
Sep 22 14:00:00 - 14:59:59 1211 5.9% 0.343.9 MB 6.1% 1.10
Sep 22 15:00:00 - 15:59:59 1276 6.2% 0.354.4 MB 6.8% 1.24
Sep 22 16:00:00 - 16:59:59 1206 5.8% 0.344.1 MB 6.4% 1.17
Sep 22 17:00:00 - 17:59:59 1091 5.3% 0.303.0 MB 4.7% 0.85
Sep 22 18:00:00 - 18:59:59 1140 5.5% 0.323.3 MB 5.2% 0.95
Sep 22 19:00:00 - 19:59:59 1030 5.0% 0.293.1 MB 4.8% 0.88
Sep 22 20:00:00 - 20:59:59 1039 5.0% 0.293.4 MB 5.3% 0.96
Sep 22 21:00:00 - 21:59:59 759 3.7% 0.212.5 MB 3.9% 0.70
Sep 22 22:00:00 - 22:59:59 769 3.7% 0.212.6 MB 4.1% 0.74
Sep 22 23:00:00 - 23:59:59 583 2.8% 0.161.8 MB 2.8% 0.52
Sep 23 00:00:00 - 00:59:59 505 2.4% 0.141.4 MB 2.2% 0.41
Sep 23 01:00:00 - 01:59:59 403 2.0% 0.111.2 MB 1.9% 0.34
Sep 23 02:00:00 - 02:59:59 432 2.1% 0.121.6 MB 2.5% 0.46
Sep 23 03:00:00 - 03:59:59 410 2.0% 0.111.3 MB 2.0% 0.36
Sep 23 04:00:00 - 04:15:01 120 0.6% 0.13401.5 KB 0.6% 0.45
TOTAL: 23:59:59 20642 100.0% 0.2463.9 MB 100.0% 0.76
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 3082 151 0 0 1 0 0 0 2930
2newsfeed.neva.ru 2423 212 0 0 0 0 0 0 2211
3csiph-out.news.weretis.net 865 185 0 0 0 0 0 0 680
4feeder.eternal-september.org 754 33 0 1 0 0 0 0 720
5newsfeed.fu-berlin.de 586 8 0 0 0 0 0 0 578
6news-out.mixmin.net 403 0 0 0 0 0 0 0 403
7news.fcku.it 101 0 0 0 0 0 0 0 101
8news.freedyn.net 23 0 0 0 0 0 0 0 23
9news.redatomik.org 22 0 0 0 0 0 0 0 22
10news-out.aioe.org 20 15 0 0 0 0 0 0 5
11newsfeeds.xmission.com 8 1 0 0 0 0 0 0 7
12news.swapon.de 7 0 0 0 0 0 0 0 7
13nntp.pasdenom.info 3 0 0 0 0 0 0 0 3
TOTAL: 13 8297 605 0 1 1 0 0 0 7690

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 116
lada.auto 65
ut.test 32
alt.survival 29
it-alt.sport.calcio.juventus 28
mozilla.dev.platform 21
free.it.religioni.scientology 16
mpc.lists.nanog 15
gmane.linux.kernel 13
alt.windows7.general 12
gmane.linux.alsa.devel 12
gmane.comp.gis.openstreetmap 12
alt.politics.usa 10
mozilla.general 9
oesterreich.tratsch 9
lada.commerce 8
mozilla.dev.media 7
ab.test 7
mozilla.support.firefox 7
mozilla.dev.security.policy 7
TOTAL: 107 605

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

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4870
EMP (phn path) 503
EMP (phn nph) 240
Too many newsgroups 71
Binary Payload 46
Scoring filter (10) 26
Scoring filter (8) 25
HTML Multipart 20
Scoring filter (12) 15
User-issued cancel 11
Scoring filter (13) 9
Scoring filter (11) 4
Too many newsgroups (low_xpost) 4
Scoring filter (9) 4
Scoring filter (14) 4
HTML Image Tags 4
Poison newsgroup 3
HTML post 2
Scoring filter (15) 2
Binary: non-binary distribution 1
TOTAL: 22 5866

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com5606969
TOTAL: 15606969

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 1120
csiph-out.news.weretis.net 122
feeder.eternal-september.org 44
news.fcku.it 19
news.freedyn.net 12
news-out.mixmin.net 10
newsfeeds.xmission.com 6
newsfeed.fu-berlin.de 5
news.redatomik.org 1
news.swapon.de 1
TOTAL: 10 1340
Including strange strings
newsfeed.fu-berlin.de 362
csiph-out.feeder.erje.net 41
csiph-out.news.weretis.net 38
news-out.mixmin.net 13
newsfeed.neva.ru 8
news.redatomik.org 7
news.swapon.de 6
news-out.aioe.org 4
feeder.eternal-september.org 3
newsfeeds.xmission.com 1
TOTAL: 11 484
TOTAL: 3 1828

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1xanadu-bbs 21861 689 19928 22 0 73 3%23:59:54
2news.freedyn.net 21468 655 19960 0 0 2 3%23:59:54
3fu-berlin.de 19294 513 18778 0 0 1 2%23:59:53
4news.bbs.geek.nz 33705 384 19636 38 0 2 1%23:59:51
5usenet.pasdenom.info 20854 41 19210 1360 0 108 0%23:59:53
6weretis.net 12883 8 12738 4 0 4 0%23:59:54
7news.redatomik.org 19701 5 19332 1 0 1 0%23:59:48
8aioe 17754 4 17182 0 0 1 0%23:59:49
9eternal-september 17853 3 17306 1 0 1 0%23:59:53
10xmission 19602 2 18805 0 0 1 0%23:59:44
11erje 17051 2 16803 4 0 5 0%23:59:53
12bwh 0 0 0 0 0 20057 0%23:58:40
13news.swapon.de 1591 0 1569 0 0 0 0%23:48:38
14neva.ru 18405 0 18244 23 0 0 0%23:59:53
15news.mixmin.net 18579 0 18415 0 0 1 0%23:59:45
16news.fcku.it 2359 0 2329 0 0 0 0%22:30:25
17au2pb 0 0 0 0 0 20068 0%23:58:40
TOTAL: 17 262960 2306 240235 1453 0 40325 0%406:14:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1xanadu-bbs7.1 MB49.3 KB7.2 MB0.1 KB/s10.4 KB23:59:54
2news.freedyn.net7.0 MB0.0 KB7.0 MB0.1 KB/s10.9 KB23:59:54
3fu-berlin.de6.7 MB0.0 KB6.7 MB0.1 KB/s13.3 KB23:59:53
4news.bbs.geek.nz1.0 MB110.1 KB1.2 MB0.0 KB/s2.8 KB23:59:51
5usenet.pasdenom.info190.2 KB8.0 MB8.2 MB0.1 KB/s6.0 KB23:59:53
6erje36.5 KB106.5 KB143.0 KB0.0 KB/s23.8 KB23:59:53
7weretis.net18.4 KB12.9 KB31.3 KB0.0 KB/s2.6 KB23:59:54
8news.redatomik.org14.1 KB3.4 KB17.5 KB0.0 KB/s2.9 KB23:59:48
9aioe14.0 KB0.0 KB14.0 KB0.0 KB/s3.5 KB23:59:49
10xmission6.7 KB0.0 KB6.7 KB0.0 KB/s3.3 KB23:59:44
11eternal-september5.7 KB1.5 KB7.2 KB0.0 KB/s1.8 KB23:59:53
12bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:40
13news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:48:38
14neva.ru0.0 KB51.6 KB51.6 KB0.0 KB/s2.2 KB23:59:53
15news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
16news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s022:30:25
17au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:40
TOTAL: 1722.1 MB8.4 MB30.5 MB0.0 KB/s8.3 KB406:14:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-05-70-55-59-147.dsl.bell.ca106824799846.4 GB 78340 0 0332:41:03
2213.55.176.165 1 69107.2 KB 3 0 001:02:03
3144.138.90.254 47 60123.6 KB 41 0 000:37:24
4194-73-239-109.cust.centrio.cz 3 45.8 KB 2 0 001:00:15
TOTAL: 4111924801176.4 GB 78386 0 0348:08:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca106824799846.4 GB 78340 0 0332:41:03
2unresolved 48 129230.8 KB 44 0 001:39:28
3*.cust.centrio.cz 3 45.8 KB 2 0 001:00:15
4*.dhcp.mdsn.wi.charter.com 1 00.0 KB 0 0 000:31:30
5*.dhcp.chtrptr.net 18 00.0 KB 0 0 001:48:16
6*.upc-a.chello.nl 26 00.0 KB 0 0 004:11:36
7*.bbox.io 15 00.0 KB 0 0 005:22:36
8*.drr02.clwr.fl.frontiernet.net 2 00.0 KB 0 0 000:53:35
TOTAL: 8118124801176.4 GB 78386 0 0348:08:23

NNRP auth users [Top 20]:

UserConn
moussa 47
ctomczyk 3
TOTAL: 2 50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-05-70-55-59-147.dsl.bell.ca 437.463 780.003 0.000332:41:03
tempe0.bbox.io 1.202 0.287 0.00005:22:36
a131033.upc-a.chello.nl 1.775 0.322 0.00004:11:36
172-221-045-126.dhcp.chtrptr.net 1.111 0.319 0.00001:48:16
213.55.176.165 0.111 0.079 0.00001:02:03
194-73-239-109.cust.centrio.cz 0.224 0.053 0.05501:00:15
47-192-184-201.drr02.clwr.fl.frontiernet.net 0.177 0.023 0.00000:53:35
144.138.90.254 4.783 1.016 0.22900:37:24
71-82-167-215.dhcp.mdsn.wi.charter.com 0.076 0.025 0.00000:31:30
TOTAL: 9 446.922 782.127 0.284348:08:23

Curious NNRP server explorers [Top 20]:

SystemConn
a131033.upc-a.chello.nl 26
172-221-045-126.dhcp.chtrptr.net 18
tempe0.bbox.io 15
47-192-184-201.drr02.clwr.fl.frontiernet.net 2
71-82-167-215.dhcp.mdsn.wi.charter.com 1
TOTAL: 5 62

NNRP client timeouts [Top 20]:

SystemConnPeer
mtrlpq2314w-lp140-05-70-55-59-147.dsl.bell.ca 7 7
tempe0.bbox.io 6 0
194-73-239-109.cust.centrio.cz 2 0
47-192-184-201.drr02.clwr.fl.frontiernet.net 1 0
172-221-045-126.dhcp.chtrptr.net 1 0
71-82-167-215.dhcp.mdsn.wi.charter.com 1 0
213.55.176.165 1 0
TOTAL: 7 19 7

Newsgroup request counts (by category):

CategoryCountPct
1alt 662697 24.3%
2uk 617541 22.7%
3soc 410942 15.1%
4rec 387087 14.2%
5fr 206252 7.6%
6sci 151069 5.5%
7comp 132562 4.9%
8talk 95417 3.5%
9misc 49293 1.8%
10linux 11756 0.4%
11news 72 0.0%
12aus 4 0.0%
TOTAL: 122724692100.0%

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

NewsgroupCount
1alt.atheism 223161
2fr.soc.politique 206251
3uk.d-i-y 205209
4rec.food.cooking 177650
5soc.culture.israel 144536
6soc.retirement 142724
7sci.electronics.design 114348
8comp.os.linux.advocacy 103254
9rec.sport.tennis 101548
10uk.legal 97065
11alt.home.repair 92468
12talk.politics.misc 76924
13soc.culture.polish 74332
14alt.politics.economics 60919
15rec.arts.sf.written 60389
16uk.railway 59862
17uk.rec.sheds 59848
18alt.slack 59745
19uk.radio.amateur 57107
20alt.california 53506
21alt.suicide.methods 51938
22uk.legal.moderated 50706
23soc.culture.usa 49350
24misc.survivalism 49293
25rec.crafts.metalworking 47473
26alt.support.depression 47304
27uk.rec.cycling 40924
28alt.baldspot 31768
29comp.lang.fortran 29215
30uk.rec.motorcycles 28611
31alt.astronomy 23558
32talk.origins 18493
33sci.astro.amateur 18477
34sci.physics.relativity 18231
35uk.rec.driving 18187
36alt.obituaries 16366
37linux.kernel 11756
38alt.fan.art-bell 1934
39news.admin.peering 65
40comp.os.vms 36
41comp.lang.python 24
42alt.free.newsservers 11
43uk.media.radio.archers 11
44sci.physics 10
45rec.boats 10
46rec.sport.pro-wrestling 8
47news.lists.filters 7
48alt.sports.football.pro.sd-chargers 6
49comp.sys.ibm.pc.games.action 6
50comp.arch.embedded 5
51comp.lang.c 4
52comp.lang.javascript 4
53comp.arch 4
54alt.usenet.peering 4
55uk.tech.digital-tv 4
56alt.os.linux 3
57comp.os.msdos.programmer 3
58rec.arts.tv 3
59rec.autos.tech 3
60uk.games.video.misc 3
61alt.russian.z1 2
62sci.military.naval 2
63aus.politics 2
64comp.arch.fpga 2
65alt.os.linux.debian 1
66comp.mobile.android 1
67alt.society.liberalism 1
68rec.aviation.soaring 1
69comp.ai.philosophy 1
70aus.cars 1
71fr.rec.photo 1
72alt.folklore.computers 1
73rec.woodworking 1
74uk.media.radio.bbc-r4 1
75comp.windows.misc 1
76alt.comp.os.windows-10 1
77comp.os.os2.advocacy 1
78sci.math 1
79uk.rec.drugs.cannabis 1
80comp.sys.ibm.pc.hardware.chips 1
81aus.computers 1
82uk.media.tv.misc 1
83rec.photo.digital 1
84uk.rec.gardening 1
TOTAL: 842724692