Daily Usenet report for csiph.com

Jul 13 04:15:00 -- Jul 14 04:15:00

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 14 02:39:02 csiph pgpverify[62979]: pgpverify: verification failed
Jul 14 02:39:02 csiph controlchan[9379]: skipping newgroup y nl-admin@nic.surfnet.nl (pgpverify failed) in <1499997841.18373@news.a3.xs4all.nl>

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 40465 46.1%4.4 MB 33.3%
inn 30521 34.8%6.7 MB 50.3%
innd 13521 15.4%1.6 MB 12.3%
innfeed 3238 3.7%549.4 KB 4.1%
nocem 40 0.0%4.3 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 87787 100.0%13.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 348946 55.0%
Negative hits 255334 40.2%
Do not exist 29786 4.7%
Cache misses 358 0.1%
TOTAL: 4 634424 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.092 0.0%205 0.000 5.327 52.400
article cleanup00:00:00.186 0.0%29395 0.000 0.006 0.025
article logging00:00:05.293 0.0%29874 0.000 0.177 1.648
article parse00:00:05.060 0.0%84924 0.000 0.060 0.500
article write00:03:48.134 0.3%21626 0.279 10.549 61.806
artlog/artcncl00:00:00.001 0.0%156 0.000 0.006 1.000
artlog/artparse00:00:00.256 0.0%534 0.000 0.479 5.000
data move00:00:00.224 0.0%596438 0.000 0.000 0.014
hisgrep/artcncl00:00:00.279 0.0%174 0.000 1.603 17.000
hishave/artcncl00:00:00.104 0.0%205 0.000 0.507 8.200
hishave/artparse00:00:00.002 0.0%530 0.000 0.004 0.083
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:58.242 0.2%636780 0.003 0.280 1.541
history sync00:00:04.969 0.0%335 0.000 14.833 186.000
history write00:04:38.594 0.3%29360 0.074 9.489 62.852
hiswrite/artcncl00:00:00.126 0.0%31 0.000 4.065 9.000
hiswrite/artparse00:00:03.721 0.0%528 0.000 7.047 89.500
idle23:36:57.995 98.4%580069 80.044 146.565 601.727
nntp read00:00:02.993 0.0%609347 0.002 0.005 0.021
overview write00:09:06.709 0.6%21626 1.596 25.280 187.324
perl filter00:01:02.444 0.1%29356 1.663 2.127 3.583
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.402 0.0%43286 0.000 0.009 0.030
TOTAL: 24:00:43.97623:58:56.826 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.052 0.0%21665 0.000 0.002 0.016
article prepare00:00:00.005 0.0%17972 0.000 0.000 0.014
article read00:00:02.195 0.0%2590 0.000 0.847 36.250
backlog stats00:00:00.218 0.0%376339 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.043 0.0%297649 0.002 0.007 0.013
data write00:00:01.626 0.0%283031 0.001 0.006 0.013
idle23:54:08.799100.0%376339 129.392 228.647 706.943
status file00:00:00.653 0.0%308 0.000 2.120 33.500
TOTAL: 23:54:24.66823:54:15.591100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:02.389 0.0%4924 0.296 0.485 2.000
idle28:35:04.239 97.5%567401 81.875 181.361600092.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.592 0.0%1586452 0.000 0.006 0.083
readart00:39:22.806 2.2%518798 0.000 4.554 309.000
TOTAL: 29:18:28.59029:14:39.026 99.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 92895 8283 80498 4114 8%94:58:04
2feeder.eternal-september.org 4 26953 3112 22990 851 11%24:40:31
3csiph-out.news.weretis.net 4 45392 2348 42419 625 5%47:38:33
4news-out.aioe.org 3 21386 1842 19452 92 8%24:09:47
5news-out.mixmin.net 2 22926 1765 20399 762 7%24:08:49
6newsfeed.neva.ru 147 29413 1130 26768 1515 3%71:31:25
7newsfeeds.xmission.com 3 19901 1084 18810 7 5%22:05:00
8news.redatomik.org 1 26298 980 25310 8 3%32:35:36
9newsfeed.fu-berlin.de 52 23251 924 22084 243 3%33:42:57
10xanadu-bbs.net 9 944 153 772 19 16%23:06:34
11news.fcku.it 1 9888 82 9753 53 0%23:59:56
12news.swapon.de 3 1919 50 1869 0 2%22:28:11
13nntp.pasdenom.info 2 20597 29 20565 3 0%23:59:02
14news.freedyn.net 2 23722 23 23678 21 0%23:59:47
15news.bbs.geek.nz 2 20496 7 20488 1 0%23:59:43
16localhost 37 3 3 0 0 100%00:00:09
TOTAL: 16 1424 385984 21815 355855 8314 5%517:04:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net28.2 MB16.2 KB24.7 MB52.9 MB 53%4.4 KB
2feeder.eternal-september.org8.2 MB7.2 KB13.9 MB22.1 MB 37%5.7 KB
3csiph-out.news.weretis.net7.3 MB15.2 KB15.8 MB23.2 MB 31%8.0 KB
4news-out.mixmin.net5.9 MB7.7 KB2.1 MB8.0 MB 73%3.2 KB
5news-out.aioe.org4.5 MB7.5 KB130.0 KB4.6 MB 97%2.5 KB
6newsfeeds.xmission.com3.2 MB2.2 KB320.0 KB3.5 MB 91%3.3 KB
7news.redatomik.org3.1 MB10.2 KB461.3 KB3.5 MB 86%3.7 KB
8newsfeed.neva.ru2.9 MB748.2 KB8.4 MB12.1 MB 23%4.7 KB
9newsfeed.fu-berlin.de2.1 MB0.0 KB720.4 KB2.8 MB 75%2.5 KB
10xanadu-bbs.net465.2 KB0.0 KB186.8 KB651.9 KB 71%3.8 KB
11news.swapon.de123.2 KB0.0 KB0.0 KB123.2 KB100%2.5 KB
12news.freedyn.net112.7 KB0.0 KB193.5 KB306.2 KB 36%7.0 KB
13news.fcku.it103.8 KB2.3 KB251.4 KB357.5 KB 29%2.6 KB
14nntp.pasdenom.info64.4 KB2.3 KB4.7 KB71.4 KB 90%2.2 KB
15news.bbs.geek.nz18.8 KB0.0 KB445.1 KB463.9 KB 4%58.0 KB
16localhost5.0 KB0.0 KB0.0 KB5.0 KB100%1.7 KB
TOTAL: 1666.3 MB818.9 KB67.7 MB134.8 MB 49%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 13 04:15:00 - 04:59:59 399 1.8% 0.152.0 MB 3.1% 0.75
Jul 13 05:00:00 - 05:59:59 464 2.1% 0.131.4 MB 2.1% 0.39
Jul 13 06:00:00 - 06:59:59 642 3.0% 0.182.0 MB 3.1% 0.58
Jul 13 07:00:00 - 07:59:59 863 4.0% 0.242.7 MB 4.1% 0.76
Jul 13 08:00:00 - 08:59:59 880 4.1% 0.242.8 MB 4.3% 0.80
Jul 13 09:00:00 - 09:59:59 981 4.5% 0.273.0 MB 4.6% 0.85
Jul 13 10:00:00 - 10:59:59 1028 4.8% 0.292.9 MB 4.4% 0.81
Jul 13 11:00:00 - 11:59:59 935 4.3% 0.263.2 MB 4.9% 0.91
Jul 13 12:00:00 - 12:59:59 1055 4.9% 0.292.5 MB 3.8% 0.71
Jul 13 13:00:00 - 13:59:59 1253 5.8% 0.353.8 MB 5.8% 1.07
Jul 13 14:00:00 - 14:59:59 1204 5.6% 0.333.7 MB 5.7% 1.06
Jul 13 15:00:00 - 15:59:59 1436 6.6% 0.403.6 MB 5.6% 1.03
Jul 13 16:00:00 - 16:59:59 1423 6.6% 0.404.3 MB 6.6% 1.23
Jul 13 17:00:00 - 17:59:59 1127 5.2% 0.313.3 MB 5.0% 0.93
Jul 13 18:00:00 - 18:59:59 1106 5.1% 0.313.5 MB 5.3% 0.99
Jul 13 19:00:00 - 19:59:59 1196 5.5% 0.334.1 MB 6.3% 1.16
Jul 13 20:00:00 - 20:59:59 1071 5.0% 0.303.3 MB 5.1% 0.95
Jul 13 21:00:00 - 21:59:59 953 4.4% 0.262.8 MB 4.2% 0.78
Jul 13 22:00:00 - 22:59:59 821 3.8% 0.232.6 MB 4.0% 0.75
Jul 13 23:00:00 - 23:59:59 614 2.8% 0.171.7 MB 2.6% 0.49
Jul 14 00:00:00 - 00:59:59 595 2.8% 0.171.6 MB 2.4% 0.45
Jul 14 01:00:00 - 01:59:59 505 2.3% 0.141.3 MB 2.0% 0.38
Jul 14 02:00:00 - 02:59:59 444 2.1% 0.121.5 MB 2.3% 0.42
Jul 14 03:00:00 - 03:59:59 451 2.1% 0.131.3 MB 1.9% 0.36
Jul 14 04:00:00 - 04:15:00 154 0.7% 0.17493.9 KB 0.7% 0.55
TOTAL: 24:00:00 21600 100.0% 0.2565.2 MB 100.0% 0.77
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 4150 310 0 5 4 0 0 0 3831
2newsfeed.neva.ru 1522 173 0 30 0 0 0 0 1319
3feeder.eternal-september.org 836 98 0 0 0 0 0 0 738
4news-out.mixmin.net 783 8 0 1 0 0 0 0 774
5csiph-out.news.weretis.net 684 252 0 1 0 0 0 0 431
6newsfeed.fu-berlin.de 573 26 0 0 0 0 0 0 547
7news-out.aioe.org 102 86 0 1 0 0 0 0 15
8news.fcku.it 50 23 0 0 0 0 0 0 27
9news.freedyn.net 21 1 0 0 0 0 0 0 20
10xanadu-bbs.net 17 0 0 0 0 0 0 0 17
11newsfeeds.xmission.com 11 0 0 0 0 0 0 0 11
12news.redatomik.org 7 0 0 1 0 0 0 0 6
13news.swapon.de 6 0 0 0 0 0 0 0 6
14nntp.pasdenom.info 3 1 0 0 0 0 0 0 2
15news.bbs.geek.nz 1 0 0 0 0 0 0 0 1
TOTAL: 15 8766 978 0 39 4 0 0 0 7745

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 207
lada.talk 83
lada.auto 68
it.annunci.varie 39
gmane.linux.alsa.devel 38
it.annunci.immobiliari 38
it.annunci.commerciali 37
alt.windows7.general 33
alt.survival 24
mozilla.support.seamonkey 19
spline.eisfair 17
mozilla.dev.platform 16
alt.biology 16
gmane.linux.kernel 16
alt.politics.usa 15
mozilla.dev.security.policy 14
cakewalk.audio 14
alt.computer.workshop 14
mpc.lists.freebsd.office 13
mpc.lists.nanog 12
TOTAL: 133 978

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

GroupsCount
nz.politics.announce 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5540
EMP (phn path) 800
EMP (phn nph) 110
Too many newsgroups 83
Scoring filter (8) 25
Too many newsgroups (low_xpost) 20
Scoring filter (10) 20
HTML Multipart 15
Binary: misplaced sfv 13
Binary Payload 12
User-issued cancel 12
EMP (phl) 11
Binary: misplaced par 10
Scoring filter (13) 10
Binary: misplaced txt 9
Scoring filter (11) 7
HTML post 4
Scoring filter (15) 4
Binary: misplaced nfo 3
Scoring filter (14) 3
TOTAL: 36 6734

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com3306262
TOTAL: 13306262

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
csiph-out.feeder.erje.net 183
csiph-out.news.weretis.net 174
feeder.eternal-september.org 143
news-out.mixmin.net 17
newsfeeds.xmission.com 5
news.freedyn.net 2
xanadu-bbs.net 2
news.fcku.it 2
news.redatomik.org 1
news.bbs.geek.nz 1
TOTAL: 10 530
Including strange strings
newsfeed.fu-berlin.de 341
csiph-out.news.weretis.net 42
csiph-out.feeder.erje.net 36
news-out.mixmin.net 27
news-out.aioe.org 12
news.swapon.de 6
newsfeeds.xmission.com 5
newsfeed.neva.ru 3
news.redatomik.org 3
nntp.pasdenom.info 1
TOTAL: 11 477
No colon-space in header
csiph-out.feeder.erje.net 4
TOTAL: 1 4
TOTAL: 3 1011

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 38752 920 20033 78 0 0 2%23:59:19
2news.freedyn.net 22803 763 20746 3 0 0 3%23:51:55
3xanadu-bbs 22373 599 20887 9 0 71 2%23:59:55
4fu-berlin.de 20493 522 19971 0 0 0 2%23:55:07
5usenet.pasdenom.info 22491 116 20109 1351 0 5 0%23:59:52
6news.redatomik.org 20668 17 20123 2 0 0 0%23:50:04
7aioe 18217 12 17611 1 0 0 0%23:58:20
8eternal-september 18622 9 17669 0 0 0 0%23:59:50
9weretis.net 17548 6 17386 0 0 0 0%23:53:20
10xmission 20925 5 19825 0 0 0 0%23:59:43
11neva.ru 19927 4 19616 54 0 0 0%23:59:17
12news.swapon.de 1995 4 1962 0 0 0 0%23:46:03
13news.mixmin.net 19401 4 18770 0 0 0 0%23:52:25
14news.fcku.it 2588 1 2521 0 0 0 0%22:21:55
15bwh 0 0 0 0 0 20961 0%23:50:05
16au2pb 0 0 0 0 0 20975 0%23:50:04
17erje 13337 0 13202 20 0 0 0%23:55:43
TOTAL: 17 280140 2982 250431 1518 0 42012 1%405:02:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net7.9 MB16.5 KB7.9 MB0.1 KB/s10.5 KB23:51:55
2xanadu-bbs7.2 MB25.8 KB7.3 MB0.1 KB/s12.2 KB23:59:55
3fu-berlin.de7.0 MB0.0 KB7.0 MB0.1 KB/s13.6 KB23:55:07
4news.bbs.geek.nz2.3 MB268.3 KB2.6 MB0.0 KB/s2.7 KB23:59:19
5usenet.pasdenom.info413.9 KB8.5 MB8.9 MB0.1 KB/s6.2 KB23:59:52
6news.redatomik.org70.0 KB30.8 KB100.8 KB0.0 KB/s5.3 KB23:50:04
7eternal-september23.7 KB0.0 KB23.7 KB0.0 KB/s2.6 KB23:59:50
8aioe21.8 KB2.1 KB23.9 KB0.0 KB/s1.8 KB23:58:20
9weretis.net10.2 KB0.0 KB10.2 KB0.0 KB/s1.7 KB23:53:20
10xmission8.7 KB0.0 KB8.7 KB0.0 KB/s1.7 KB23:59:43
11news.swapon.de7.8 KB0.0 KB7.8 KB0.0 KB/s1.9 KB23:46:03
12neva.ru7.3 KB157.8 KB165.1 KB0.0 KB/s2.8 KB23:59:17
13news.mixmin.net7.2 KB0.0 KB7.2 KB0.0 KB/s1.8 KB23:52:25
14news.fcku.it2.3 KB0.0 KB2.3 KB0.0 KB/s2.3 KB22:21:55
15bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:05
16au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:04
17erje0.0 KB84.4 KB84.4 KB0.0 KB/s4.2 KB23:55:43
TOTAL: 1724.9 MB9.1 MB34.1 MB0.0 KB/s7.7 KB405:02:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-03-70-24-219-221.dsl.bell.ca2520225601754.4 MB 1228 0 017:55:03
2144.138.90.254 48 74231.1 KB 54 0 000:35:27
3tempe0.bbox.io 15 1636.6 KB 5 1 104:59:24
424.178.45.75 11 36.0 KB 3 2 203:17:39
TOTAL: 42594225694754.7 MB 1290 3 329:18:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca2520225601754.4 MB 1228 0 017:55:03
2unresolved 69 77237.2 KB 57 2 204:16:56
3*.bbox.io 15 1636.6 KB 5 1 104:59:24
4*.nielsenmedia.com 4 00.0 KB 0 0 001:36:44
5*.hsd1.wa.comcast.net 1 00.0 KB 0 0 000:30:00
TOTAL: 52609225694754.7 MB 1290 3 329:18:09

NNRP auth users [Top 20]:

UserConn
moussa 48
ohlandl 2
kev009 1
TOTAL: 3 51

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-03-70-24-219-221.dsl.bell.ca 247.597 101.922 0.00017:55:03
tempe0.bbox.io 1.473 0.293 0.00404:59:24
24.178.45.75 1.027 0.222 0.00703:17:39
challenger.nielsenmedia.com 0.329 0.054 0.00001:36:44
144.138.90.254 4.435 1.120 0.17200:35:27
c-174-61-130-222.hsd1.wa.comcast.net 0.061 0.015 0.00000:30:00
5.51.176.30 0.417 0.413 0.00000:22:40
216.239.174.218 0.089 0.008 0.00000:00:57
108.178.59.51 0.161 0.038 0.00000:00:04
69.175.42.100 0.163 0.037 0.00000:00:04
198.20.101.134 0.096 0.008 0.00000:00:02
TOTAL: 11 255.848 104.130 0.18329:18:09

Curious NNRP server explorers [Top 20]:

SystemConn
challenger.nielsenmedia.com 4
5.51.176.30 4
108.178.59.51 2
69.175.42.100 2
216.239.174.218 1
c-174-61-130-222.hsd1.wa.comcast.net 1
198.20.101.134 1
TOTAL: 7 15

NNRP client timeouts [Top 20]:

SystemConnPeer
tempe0.bbox.io 7 0
mtrlpq2314w-lp140-03-70-24-219-221.dsl.bell.ca 7 7
challenger.nielsenmedia.com 3 0
24.178.45.75 3 0
c-174-61-130-222.hsd1.wa.comcast.net 1 0
TOTAL: 5 21 7

Newsgroup request counts (by category):

CategoryCountPct
1alt 225502 99.9%
2comp 110 0.0%
3uk 41 0.0%
4rec 25 0.0%
5talk 6 0.0%
6soc 4 0.0%
7linux 4 0.0%
8sci 1 0.0%
9misc 1 0.0%
TOTAL: 9 225694100.0%

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

NewsgroupCount
1alt.fan.rush-limbaugh 225463
2comp.arch 36
3comp.os.vms 36
4uk.legal 25
5alt.home.repair 22
6comp.sys.ibm.ps2.hardware 9
7rec.boats 7
8alt.atheism 6
9comp.os.linux.misc 6
10comp.arch.fpga 6
11talk.politics.misc 5
12rec.autos.sport.f1 5
13uk.d-i-y 4
14linux.kernel 4
15rec.arts.tv 3
16alt.folklore.computers 3
17comp.os.os2.apps 3
18soc.culture.polish 3
19uk.rec.cycling 3
20comp.arch.embedded 3
21alt.binaries.series.tv.divx.french.d 3
22comp.lang.python 3
23rec.sport.tennis 2
24uk.net.news.moderation 2
25comp.sys.apple2 2
26rec.arts.tv.uk.coronation-st 2
27rec.aviation.soaring 2
28uk.rec.sheds 2
29alt.sports.basketball.nba.gs-warriors 2
30alt.comp.os.windows-10 2
31uk.politics.misc 2
32uk.radio.amateur 1
33rec.crafts.metalworking 1
34comp.mobile.android 1
35soc.genealogy.britain 1
36uk.rec.gardening 1
37comp.lang.java.programmer 1
38uk.comp.sys.mac 1
39comp.os.msdos.misc 1
40sci.electronics.basics 1
41comp.sys.ibm.pc.hardware.storage 1
42misc.survivalism 1
43rec.sport.golf 1
44comp.lang.php 1
45alt.slack 1
46talk.politics.guns 1
47rec.arts.comics.strips 1
48comp.sys.ibm.pc.games.action 1
49rec.arts.drwho 1
TOTAL: 49 225694