Daily Usenet report for csiph.com

Apr 30 04:15:03 -- May 1 04:15:00

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 1 00:02:34 csiph pgpverify[12317]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 74468 52.5%7.2 MB 41.5%
inn 38789 27.3%7.0 MB 40.4%
innd 25365 17.9%2.6 MB 15.2%
innfeed 3200 2.3%504.1 KB 2.8%
nocem 80 0.1%8.0 KB 0.0%
controlchan 10 0.0%1.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 141913 100.0%17.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 358544 53.1%
Negative hits 278026 41.2%
Do not exist 37814 5.6%
Cache misses 458 0.1%
TOTAL: 4 674842 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.638 0.0%261 0.000 13.939 138.300
article cleanup00:00:00.242 0.0%36297 0.000 0.007 0.032
article logging00:00:14.627 0.0%36806 0.000 0.397 4.606
article parse00:00:40.151 0.0%162265 0.003 0.247 2.176
article write00:03:38.536 0.3%19229 1.086 11.365 50.873
artlog/artcncl00:00:00.021 0.0%136 0.000 0.154 3.000
artlog/artparse00:00:01.781 0.0%1871 0.000 0.952 10.478
data move00:00:00.527 0.0%664662 0.000 0.001 0.032
hisgrep/artcncl00:00:01.004 0.0%261 0.000 3.847 99.000
hishave/artcncl00:00:00.865 0.0%261 0.000 3.314 47.000
hishave/artparse00:00:00.007 0.0%1869 0.000 0.004 0.028
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:48.137 0.4%676093 0.003 0.515 2.950
history sync00:00:07.215 0.0%361 0.000 19.986 129.667
history write00:08:51.134 0.6%36118 1.396 14.706 100.871
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:36.243 0.0%1869 0.000 19.392 123.333
idle23:23:58.790 97.4%628619 64.522 134.006 402.285
nntp read00:00:03.232 0.0%675245 0.002 0.005 0.018
overview write00:13:57.855 1.0%19229 4.182 43.572 382.316
perl filter00:01:29.830 0.1%36056 1.448 2.491 3.627
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.377 0.0%38536 0.000 0.010 0.030
TOTAL: 24:00:58.13023:59:34.212 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.056 0.0%19236 0.000 0.003 0.020
article prepare00:00:00.001 0.0%22108 0.000 0.000 0.003
article read00:00:03.663 0.0%2919 0.000 1.255 52.400
backlog stats00:00:00.178 0.0%339621 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.779 0.0%267124 0.001 0.007 0.012
data write00:00:01.428 0.0%252108 0.001 0.006 0.011
idle23:54:45.815100.0%339621 129.116 253.476 701.075
status file00:00:01.055 0.0%275 0.000 3.836 48.000
TOTAL: 23:55:01.45723:54:53.975100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle789:06:17.300 94.3%26476058 81.368 107.296600053.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:09:23.769 0.0%77133981 0.000 0.007 0.139
readart46:50:19.899 5.6%26040393 0.000 6.475 254.000
TOTAL: 836:23:52.593836:06:00.968100.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL002112

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.news.weretis.net 3 40037 5380 33482 1175 13%48:02:32
2csiph-out.feeder.erje.net 1440 131668 5318 118796 7554 4%118:43:32
3feeder.eternal-september.org 3 33482 2429 25234 5819 7%24:29:38
4news-out.aioe.org 3 19286 1364 17859 63 7%24:08:57
5newsfeed.fu-berlin.de 11 22174 1077 20855 242 4%30:49:30
6newsfeed.neva.ru 153 28957 1058 24522 3377 3%72:01:06
7news-out.mixmin.net 4 20629 860 19343 426 4%24:13:18
8newsfeeds.xmission.com 2 17914 825 17073 16 4%23:50:46
9news.redatomik.org 1 15371 560 14807 4 3%19:10:53
10news.fcku.it 1 7894 118 7700 76 1%23:59:59
11nntp.pasdenom.info 2 17508 97 17409 2 0%23:58:54
12xanadu-bbs.net 15 772 96 662 14 12%23:18:55
13news.freedyn.net 2 21696 66 21408 222 0%23:59:45
14news.swapon.de 3 1654 41 1613 0 2%22:51:13
15news.bbs.geek.nz 1 18498 3 18495 0 0%23:59:50
16localhost 33 2 2 0 0 100%00:00:01
TOTAL: 16 1677 397542 19294 359258 18990 4%527:38:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net21.8 MB1.9 MB119.6 MB143.3 MB 15%11.4 KB
2csiph-out.news.weretis.net15.4 MB0.0 KB10.2 MB25.6 MB 60%4.0 KB
3feeder.eternal-september.org6.7 MB185.7 KB76.0 MB83.0 MB 8%10.3 KB
4news-out.mixmin.net3.3 MB0.0 KB1.3 MB4.6 MB 71%3.7 KB
5news-out.aioe.org3.3 MB0.0 KB128.5 KB3.4 MB 96%2.5 KB
6newsfeed.fu-berlin.de2.5 MB0.0 KB685.5 KB3.2 MB 79%2.5 KB
7newsfeeds.xmission.com2.5 MB0.0 KB933.9 KB3.4 MB 73%4.1 KB
8newsfeed.neva.ru2.4 MB117.2 KB32.8 MB35.2 MB 6%8.1 KB
9news.redatomik.org1.5 MB0.0 KB190.9 KB1.7 MB 89%3.1 KB
10news.freedyn.net260.1 KB0.0 KB14.5 MB14.8 MB 1%52.6 KB
11xanadu-bbs.net244.7 KB0.0 KB414.2 KB658.9 KB 37%6.0 KB
12news.fcku.it231.2 KB0.0 KB4.3 MB4.5 MB 4%24.0 KB
13nntp.pasdenom.info219.1 KB0.0 KB3.3 KB222.3 KB 98%2.2 KB
14news.swapon.de108.0 KB0.0 KB0.0 KB108.0 KB100%2.6 KB
15news.bbs.geek.nz7.2 KB0.0 KB0.0 KB7.2 KB100%2.4 KB
16localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 1660.5 MB2.2 MB261.0 MB323.8 MB 18%8.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 30 04:15:03 - 04:59:59 333 1.7% 0.121.2 MB 2.0% 0.46
Apr 30 05:00:00 - 05:59:59 463 2.4% 0.131.3 MB 2.2% 0.37
Apr 30 06:00:00 - 06:59:59 482 2.5% 0.131.7 MB 2.7% 0.47
Apr 30 07:00:00 - 07:59:59 793 4.1% 0.223.1 MB 5.1% 0.88
Apr 30 08:00:00 - 08:59:59 813 4.2% 0.233.5 MB 5.8% 1.00
Apr 30 09:00:00 - 09:59:59 1159 6.0% 0.324.6 MB 7.7% 1.32
Apr 30 10:00:00 - 10:59:59 949 4.9% 0.263.7 MB 6.1% 1.05
Apr 30 11:00:00 - 11:59:59 747 3.9% 0.212.2 MB 3.6% 0.62
Apr 30 12:00:00 - 12:59:59 803 4.2% 0.222.2 MB 3.6% 0.62
Apr 30 13:00:00 - 13:59:59 1052 5.5% 0.293.0 MB 4.9% 0.85
Apr 30 14:00:00 - 14:59:59 996 5.2% 0.282.8 MB 4.6% 0.79
Apr 30 15:00:00 - 15:59:59 912 4.7% 0.252.5 MB 4.2% 0.72
Apr 30 16:00:00 - 16:59:59 943 4.9% 0.262.9 MB 4.8% 0.83
Apr 30 17:00:00 - 17:59:59 1138 5.9% 0.323.9 MB 6.4% 1.10
Apr 30 18:00:00 - 18:59:59 1066 5.5% 0.303.1 MB 5.2% 0.89
Apr 30 19:00:00 - 19:59:59 1084 5.6% 0.302.8 MB 4.5% 0.78
Apr 30 20:00:00 - 20:59:59 1162 6.0% 0.323.1 MB 5.2% 0.89
Apr 30 21:00:00 - 21:59:59 943 4.9% 0.262.6 MB 4.2% 0.73
Apr 30 22:00:00 - 22:59:59 882 4.6% 0.242.5 MB 4.1% 0.71
Apr 30 23:00:00 - 23:59:59 588 3.1% 0.161.8 MB 3.0% 0.51
May 1 00:00:00 - 00:59:59 493 2.6% 0.141.5 MB 2.5% 0.43
May 1 01:00:00 - 01:59:59 408 2.1% 0.111.3 MB 2.1% 0.36
May 1 02:00:00 - 02:59:59 471 2.4% 0.131.6 MB 2.6% 0.46
May 1 03:00:00 - 03:59:59 433 2.3% 0.121.3 MB 2.1% 0.36
May 1 04:00:00 - 04:15:00 130 0.7% 0.14589.6 KB 0.9% 0.66
TOTAL: 23:59:57 19243 100.0% 0.2260.6 MB 100.0% 0.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 7592 211 0 155 0 0 0 0 7226
2feeder.eternal-september.org 5794 37 0 15 0 0 0 0 5742
3newsfeed.neva.ru 3385 149 0 10 0 0 0 0 3226
4csiph-out.news.weretis.net 1224 128 0 0 0 0 0 0 1096
5newsfeed.fu-berlin.de 570 21 0 0 0 0 0 0 549
6news-out.mixmin.net 441 1 0 0 0 0 0 0 440
7news.freedyn.net 213 4 0 0 0 0 0 0 209
8news.fcku.it 75 0 0 0 0 0 0 0 75
9news-out.aioe.org 71 42 0 0 0 0 0 0 29
10newsfeeds.xmission.com 20 0 0 0 0 0 0 0 20
11xanadu-bbs.net 14 0 0 0 0 0 0 0 14
12news.redatomik.org 8 0 0 0 0 0 0 0 8
13nntp.pasdenom.info 2 0 0 0 0 0 0 0 2
14news.swapon.de 2 0 0 0 0 0 0 0 2
TOTAL: 14 19411 593 0 180 0 0 0 018638

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 122
it-alt.sport.calcio.juventus 72
lada.talk 56
mpc.lists.freebsd.ports.bugs 37
alt.windows7.general 36
alt.survival 19
spline.eisfair 17
mozilla.support.firefox 13
mozilla.support.thunderbird 11
alt.pl.nieruchomosci.gielda 11
gmane.linux.alsa.devel 9
lada.auto 8
mpc.lists.freebsd.gnome 8
gmane.comp.gis.openstreetmap.tagging 8
alt.tv.star-trek 7
mpc.lists.freebsd.gecko 7
oesterreich.tratsch 5
mozilla.support.seamonkey 5
alt.politics 5
lada.kitchen 5
TOTAL: 111 593

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14282
EMP (phn path) 1561
EMP (phn nph) 97
EMP (phl) 61
Binary Payload 41
Too many newsgroups 40
User-issued cancel 38
HTML Multipart 14
Scoring filter (8) 13
Scoring filter (10) 11
Scoring filter (11) 10
Scoring filter (9) 8
HTML post 5
Too many newsgroups (meow) 3
Scoring filter (12) 2
Binary Image: misplaced jpg 2
Scoring filter (13) 1
Binary: misplaced PAR2 1
Binary: misplaced sfv 1
User-issued spam cancel 1
TOTAL: 24 16196

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com7508080
TOTAL: 17508080

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 37
TOTAL: 1 37
Bad Message-ID's offered
csiph-out.feeder.erje.net 25
TOTAL: 1 25
Huge articles
csiph-out.feeder.erje.net 1516
feeder.eternal-september.org 116
news.freedyn.net 108
news.fcku.it 55
csiph-out.news.weretis.net 35
newsfeeds.xmission.com 17
news-out.mixmin.net 9
xanadu-bbs.net 6
newsfeed.fu-berlin.de 4
news.redatomik.org 3
TOTAL: 10 1869
Including strange strings
newsfeed.fu-berlin.de 360
csiph-out.news.weretis.net 63
csiph-out.feeder.erje.net 36
news-out.mixmin.net 17
newsfeed.neva.ru 14
news-out.aioe.org 8
feeder.eternal-september.org 3
newsfeeds.xmission.com 3
news.redatomik.org 3
news.swapon.de 2
TOTAL: 11 511
TOTAL: 4 2442

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.freedyn.net 19676 992 18181 2 0 0 5%23:59:47
2xanadu-bbs 19908 905 18240 1 0 6 4%23:59:44
3fu-berlin.de 18071 777 17294 0 0 0 4%23:59:52
4news.bbs.geek.nz 33140 687 17660 59 0 1 2%23:59:45
5usenet.pasdenom.info 20256 59 17115 1973 0 14 0%23:59:52
6aioe 17282 21 16478 5 0 0 0%23:59:49
7news.redatomik.org 18285 10 17799 0 0 0 0%23:59:44
8xmission 18432 7 17579 1 0 0 0%23:59:52
9eternal-september 16464 6 15750 0 0 0 0%23:59:52
10weretis.net 12805 5 12673 0 0 0 0%23:59:52
11news.mixmin.net 17868 5 17379 0 0 17 0%23:59:52
12neva.ru 17458 2 17180 7 0 0 0%23:59:52
13news.swapon.de 1873 2 1833 0 0 0 0%23:54:28
14erje 13934 1 13820 17 0 0 0%23:59:51
15au2pb 0 0 0 0 0 18408 0%23:58:39
16news.fcku.it 1585 0 1571 0 0 0 0%21:40:30
17bwh 0 0 0 0 0 18388 0%23:58:39
TOTAL: 17 247037 3479 220552 2065 0 36834 1%405:30:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net10.4 MB2.7 KB10.4 MB0.1 KB/s10.7 KB23:59:47
2xanadu-bbs10.1 MB1.5 KB10.1 MB0.1 KB/s11.4 KB23:59:44
3fu-berlin.de9.8 MB0.0 KB9.8 MB0.1 KB/s12.9 KB23:59:52
4news.bbs.geek.nz1.9 MB207.5 KB2.1 MB0.0 KB/s2.9 KB23:59:45
5usenet.pasdenom.info215.2 KB11.9 MB12.1 MB0.1 KB/s6.1 KB23:59:52
6aioe60.5 KB11.6 KB72.2 KB0.0 KB/s2.8 KB23:59:49
7news.redatomik.org38.2 KB0.0 KB38.2 KB0.0 KB/s3.8 KB23:59:44
8news.mixmin.net29.6 KB0.0 KB29.6 KB0.0 KB/s5.9 KB23:59:52
9xmission15.6 KB2.9 KB18.5 KB0.0 KB/s2.3 KB23:59:52
10eternal-september14.1 KB0.0 KB14.1 KB0.0 KB/s2.4 KB23:59:52
11weretis.net9.2 KB0.0 KB9.2 KB0.0 KB/s1.8 KB23:59:52
12neva.ru3.0 KB22.1 KB25.1 KB0.0 KB/s2.8 KB23:59:52
13news.swapon.de3.0 KB0.0 KB3.0 KB0.0 KB/s1.5 KB23:54:28
14erje1.5 KB54.6 KB56.1 KB0.0 KB/s3.1 KB23:59:51
15au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:39
16news.fcku.it0.0 KB0.0 KB0.0 KB0.0 KB/s021:40:30
17bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:39
TOTAL: 1732.5 MB12.1 MB44.7 MB0.0 KB/s8.3 KB405:30:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp130-04-70-54-156-183.dsl.bell.ca 8431209041634.7 GB 15689 0 0819:04:42
2144.138.90.254 287 75240.0 KB 66 0 003:33:22
3cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 1 1113.7 KB 1 0 000:02:30
468-185-181-64.dhcp.mdsn.wi.charter.com 27 34.2 KB 2 2 206:47:01
5dhcp-089-099-203-254.chello.nl 15 11.2 KB 1 0 004:02:11
TOTAL: 511731209050634.7 GB 15759 2 2836:23:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 8431209041634.7 GB 15689 0 0819:04:42
2unresolved 287 75240.0 KB 66 0 003:33:22
3*.19-1.cable.virginm.net 1 1113.7 KB 1 0 000:02:30
4*.dhcp.mdsn.wi.charter.com 27 34.2 KB 2 2 206:47:01
5*.chello.nl 15 11.2 KB 1 0 004:02:11
6*.bbox.io 6 00.0 KB 0 0 002:53:53
TOTAL: 611791209050634.7 GB 15759 2 2836:23:41

NNRP auth users [Top 20]:

UserConn
moussa 287
ohlandl 2
TOTAL: 2 289

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp130-04-70-54-156-183.dsl.bell.ca 1514.670 2675.987 0.000819:04:42
68-185-181-64.dhcp.mdsn.wi.charter.com 1.886 0.344 0.00606:47:01
dhcp-089-099-203-254.chello.nl 1.130 0.188 0.00004:02:11
144.138.90.254 23.003 5.686 0.98003:33:22
tempe0.bbox.io 0.368 0.101 0.00002:53:53
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 0.148 0.016 0.00000:02:30
TOTAL: 6 1541.205 2682.322 0.986836:23:41

Curious NNRP server explorers [Top 20]:

SystemConn
tempe0.bbox.io 6
TOTAL: 1 6

NNRP client timeouts [Top 20]:

SystemConnPeer
mtrlpq2314w-lp130-04-70-54-156-183.dsl.bell.ca 21 21
68-185-181-64.dhcp.mdsn.wi.charter.com 6 0
tempe0.bbox.io 5 0
TOTAL: 3 32 21

Newsgroup request counts (by category):

CategoryCountPct
1alt3749934 26.7%
2linux3327694 23.7%
3rec2494802 17.8%
4uk1393406 9.9%
5comp1071931 7.6%
6fr 858713 6.1%
7sci 537672 3.8%
8soc 255587 1.8%
9can 122399 0.9%
10talk 94120 0.7%
11aus 73240 0.5%
12misc 52752 0.4%
13relcom 12917 0.1%
TOTAL: 1314045167100.0%

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

NewsgroupCount
1linux.kernel3327694
2alt.atheism2251035
3rec.arts.tv1480798
4fr.soc.politique 854670
5uk.politics.misc 641453
6alt.home.repair 336529
7rec.food.cooking 333461
8uk.d-i-y 285658
9sci.physics 251968
10comp.lang.python 209951
11alt.usage.english 200253
12alt.arts.poetry.comments 198806
13sci.electronics.design 176855
14comp.soft-sys.matlab 174292
15soc.retirement 160253
16rec.sport.pro-wrestling 158451
17comp.sys.mac.advocacy 135896
18can.politics 122399
19comp.sys.mac.system 114692
20rec.sport.tennis 111256
21alt.california 92611
22uk.legal 81431
23alt.global-warming 71924
24rec.arts.drwho 71026
25rec.sport.football.college 69064
26sci.physics.relativity 63336
27uk.railway 57912
28alt.politics.economics 56871
29soc.culture.polish 56318
30alt.christnet.christianlife 54389
31comp.lang.java.programmer 54167
32uk.rec.sheds 52885
33misc.survivalism 52348
34comp.os.vms 50010
35alt.baldspot 49996
36alt.russian.z1 47962
37talk.origins 47136
38talk.politics.misc 46984
39comp.mobile.ipad 46415
40rec.arts.sf.written 46137
41uk.radio.amateur 43776
42alt.comp.freeware 42649
43comp.lang.forth 41125
44uk.legal.moderated 38608
45aus.politics 37544
46uk.rec.cycling 37509
47aus.cars 35696
48rec.crafts.metalworking 32465
49uk.media.radio.archers 32015
50rec.gambling.poker 31043
51comp.lang.c++ 30917
52comp.lang.fortran 30756
53alt.slack 30603
54soc.culture.usa 30427
55alt.humor.puns 28002
56rec.boats 27459
57uk.people.silversurfers 25689
58alt.society.liberalism 25108
59alt.prophecies.nostradamus 24663
60rec.outdoors.rv-travel 24149
61alt.support.depression 23081
62comp.sys.mac.apps 22794
63comp.arch 22395
64alt.comp.os.windows-10 20305
65rec.photo.digital 20212
66alt.war.vietnam 20153
67alt.conspiracy 20111
68comp.lang.tcl 20078
69uk.rec.drugs.cannabis 19347
70uk.tech.digital-tv 19247
71alt.folklore.computers 19170
72rec.music.classical.recordings 18782
73rec.bicycles.tech 18532
74uk.sci.weather 18012
75uk.rec.motorcycles 17499
76comp.lang.ada 16874
77comp.dsp 16803
78rec.music.dylan 15523
79comp.sys.apple2 15295
80comp.lang.javascript 14287
81alt.assassination.jfk 14000
82alt.bible.prophecy 13838
83sci.math 13468
84sci.military.naval 13125
85relcom.wheels 12917
86alt.support.diabetes 12763
87alt.messianic 12682
88alt.free.newsservers 12639
89alt.philosophy.taoism 12470
90comp.lang.lisp 12308
91uk.sport.cricket 11788
92sci.logic 10923
93comp.arch.embedded 10337
94alt.happy.valley 10080
95alt.abortion 9775
96rec.games.pinball 8842
97soc.culture.singapore 8589
98alt.astronomy 8016
99sci.astro.amateur 7997
100uk.religion.christian 7458
TOTAL: 14314045167