Daily Usenet report for csiph.com

Jul 14 04:15:00 -- Jul 15 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 14 06:00:04 csiph nnrpd[74007]: 144.138.90.254 rejected Expiring process 70789

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 37956 44.3%4.1 MB 31.6%
inn 31180 36.4%6.8 MB 51.9%
innd 13439 15.7%1.6 MB 12.4%
innfeed 3146 3.7%541.8 KB 4.0%
nocem 42 0.0%4.4 KB 0.0%
TOTAL: 5 85763 100.0%13.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 356214 55.0%
Negative hits 260965 40.3%
Do not exist 30363 4.7%
Cache misses 432 0.1%
TOTAL: 4 647974 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.265 0.0%156 0.000 8.109 48.600
article cleanup00:00:00.244 0.0%30131 0.000 0.008 0.029
article logging00:00:07.294 0.0%30624 0.000 0.238 2.544
article parse00:00:06.552 0.0%86142 0.000 0.076 1.104
article write00:04:27.347 0.3%22426 0.282 11.921 64.759
artlog/artcncl00:00:00.020 0.0%129 0.000 0.155 1.875
artlog/artparse00:00:00.227 0.0%442 0.000 0.514 9.500
data move00:00:00.371 0.0%610998 0.000 0.001 0.014
hisgrep/artcncl00:00:00.304 0.0%153 0.000 1.987 26.000
hishave/artcncl00:00:00.112 0.0%156 0.000 0.718 12.000
hishave/artparse00:00:00.003 0.0%442 0.000 0.007 0.125
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:17.713 0.2%651901 0.002 0.303 1.604
history sync00:00:06.882 0.0%345 0.000 19.948 100.667
history write00:05:11.949 0.4%30128 0.953 10.354 63.409
hiswrite/artcncl00:00:00.027 0.0%3 0.000 9.000 18.000
hiswrite/artparse00:00:05.175 0.0%442 0.000 11.708 70.500
idle23:33:41.521 98.1%587336 83.277 144.417 446.855
nntp read00:00:02.881 0.0%622208 0.001 0.005 0.015
overview write00:10:40.045 0.7%22426 1.668 28.540 275.590
perl filter00:01:04.309 0.1%30093 1.652 2.137 3.333
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.428 0.0%44890 0.000 0.010 0.031
TOTAL: 24:00:49.98423:58:54.669 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.052 0.0%22455 0.000 0.002 0.025
article prepare00:00:00.001 0.0%21284 0.000 0.000 0.005
article read00:00:01.558 0.0%2783 0.000 0.560 23.636
backlog stats00:00:00.181 0.0%378957 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.933 0.0%305923 0.001 0.006 0.014
data write00:00:01.709 0.0%291026 0.002 0.006 0.012
idle23:53:44.404100.0%378957 137.182 227.003 594.752
status file00:00:00.479 0.0%275 0.000 1.742 44.000
TOTAL: 23:53:59.38323:53:50.317100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.013 0.0%3 0.000 4.333 13.000
idle16:38:32.657 99.3%49462 82.417 1211.287900041.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.510 0.0%99622 0.000 0.005 0.077
readart00:03:13.495 0.3%12174 0.000 15.894 242.000
TOTAL: 16:45:22.55016:41:46.675 99.6%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1153 95940 5579 86188 4173 5%95:00:47
2csiph-out.news.weretis.net 5 52792 5557 46686 549 10%59:09:11
3feeder.eternal-september.org 1 27663 3245 23611 807 11%23:59:49
4news-out.mixmin.net 3 23765 2267 20638 860 9%24:08:52
5news.redatomik.org 1 18775 1615 17152 8 8%19:43:29
6newsfeed.neva.ru 147 30179 1218 27546 1415 4%72:18:06
7news-out.aioe.org 4 21781 964 20762 55 4%24:04:36
8newsfeed.fu-berlin.de 48 22727 936 21538 253 4%32:26:12
9newsfeeds.xmission.com 2 21438 801 20632 5 3%24:22:04
10news.fcku.it 1 9907 80 9769 58 0%23:59:57
11news.swapon.de 1 1861 49 1811 1 2%23:24:35
12xanadu-bbs.net 5 335 49 283 3 14%10:30:30
13news.freedyn.net 2 24415 30 24360 25 0%23:59:46
14nntp.pasdenom.info 3 21136 29 21097 10 0%24:02:04
15news.bbs.geek.nz 1 21309 19 21290 0 0%23:59:47
16localhost 32 1 1 0 0 100%00:00:08
TOTAL: 16 1409 394024 22439 363363 8222 5%505:09:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net23.4 MB9.8 KB25.6 MB49.1 MB 47%5.2 KB
2csiph-out.news.weretis.net16.5 MB2.6 KB12.9 MB29.4 MB 56%4.9 KB
3feeder.eternal-september.org8.7 MB0.0 KB11.2 MB19.9 MB 43%5.0 KB
4news-out.mixmin.net7.7 MB37.5 KB2.3 MB10.0 MB 76%3.3 KB
5news.redatomik.org3.7 MB34.8 KB126.0 KB3.8 MB 95%2.4 KB
6newsfeed.neva.ru3.4 MB0.0 KB6.4 MB9.9 MB 34%3.8 KB
7news-out.aioe.org3.1 MB2.5 KB99.4 KB3.2 MB 96%3.2 KB
8newsfeeds.xmission.com2.1 MB0.0 KB321.3 KB2.4 MB 86%3.0 KB
9newsfeed.fu-berlin.de2.0 MB0.0 KB533.8 KB2.6 MB 79%2.2 KB
10news.swapon.de141.7 KB0.0 KB0.7 KB142.4 KB 99%2.8 KB
11news.freedyn.net136.4 KB0.0 KB162.0 KB298.4 KB 45%5.4 KB
12xanadu-bbs.net127.0 KB0.0 KB7.3 KB134.3 KB 94%2.6 KB
13news.fcku.it122.2 KB0.0 KB340.9 KB463.1 KB 26%3.4 KB
14nntp.pasdenom.info62.2 KB0.0 KB14.3 KB76.5 KB 81%2.0 KB
15news.bbs.geek.nz47.2 KB0.0 KB0.0 KB47.2 KB100%2.5 KB
16localhost1.3 KB0.0 KB0.0 KB1.3 KB100%1.3 KB
TOTAL: 1671.3 MB87.3 KB60.1 MB131.4 MB 54%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 14 04:15:00 - 04:59:59 403 1.8% 0.152.1 MB 3.0% 0.80
Jul 14 05:00:00 - 05:59:59 694 3.1% 0.194.1 MB 5.7% 1.15
Jul 14 06:00:00 - 06:59:59 722 3.2% 0.202.6 MB 3.7% 0.75
Jul 14 07:00:00 - 07:59:59 963 4.3% 0.272.7 MB 3.8% 0.77
Jul 14 08:00:00 - 08:59:59 1040 4.6% 0.292.6 MB 3.6% 0.73
Jul 14 09:00:00 - 09:59:59 1113 5.0% 0.313.4 MB 4.8% 0.97
Jul 14 10:00:00 - 10:59:59 888 4.0% 0.252.4 MB 3.3% 0.67
Jul 14 11:00:00 - 11:59:59 1022 4.6% 0.283.1 MB 4.3% 0.87
Jul 14 12:00:00 - 12:59:59 1119 5.0% 0.313.5 MB 4.9% 0.99
Jul 14 13:00:00 - 13:59:59 1166 5.2% 0.323.4 MB 4.7% 0.96
Jul 14 14:00:00 - 14:59:59 1398 6.2% 0.395.2 MB 7.3% 1.47
Jul 14 15:00:00 - 15:59:59 1259 5.6% 0.353.9 MB 5.5% 1.11
Jul 14 16:00:00 - 16:59:59 1206 5.4% 0.343.1 MB 4.4% 0.89
Jul 14 17:00:00 - 17:59:59 1299 5.8% 0.363.6 MB 5.1% 1.03
Jul 14 18:00:00 - 18:59:59 1179 5.3% 0.333.4 MB 4.8% 0.98
Jul 14 19:00:00 - 19:59:59 1159 5.2% 0.323.8 MB 5.3% 1.08
Jul 14 20:00:00 - 20:59:59 1018 4.5% 0.283.6 MB 5.0% 1.01
Jul 14 21:00:00 - 21:59:59 1038 4.6% 0.293.3 MB 4.6% 0.94
Jul 14 22:00:00 - 22:59:59 757 3.4% 0.212.4 MB 3.3% 0.67
Jul 14 23:00:00 - 23:59:59 706 3.2% 0.201.9 MB 2.7% 0.55
Jul 15 00:00:00 - 00:59:59 610 2.7% 0.172.0 MB 2.8% 0.56
Jul 15 01:00:00 - 01:59:59 659 2.9% 0.182.2 MB 3.1% 0.63
Jul 15 02:00:00 - 02:59:59 428 1.9% 0.121.5 MB 2.0% 0.41
Jul 15 03:00:00 - 03:59:59 448 2.0% 0.121.3 MB 1.8% 0.37
Jul 15 04:00:00 - 04:15:01 104 0.5% 0.12325.2 KB 0.4% 0.36
TOTAL: 24:00:01 22398 100.0% 0.2671.2 MB 100.0% 0.84
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 4216 393 0 1 1 0 0 0 3821
2newsfeed.neva.ru 1404 148 0 0 0 0 0 0 1256
3news-out.mixmin.net 901 8 0 1 0 0 0 0 892
4feeder.eternal-september.org 820 85 0 0 0 0 0 0 735
5newsfeed.fu-berlin.de 587 19 0 0 0 0 0 0 568
6csiph-out.news.weretis.net 507 155 0 0 0 0 0 0 352
7news.fcku.it 61 15 0 0 0 0 0 0 46
8news-out.aioe.org 57 52 0 0 0 0 0 0 5
9news.freedyn.net 26 0 0 0 0 0 0 0 26
10news.redatomik.org 22 0 0 1 0 0 0 0 21
11xanadu-bbs.net 22 0 0 0 0 0 0 0 22
12news.swapon.de 11 0 0 0 0 0 0 0 11
13nntp.pasdenom.info 10 1 0 0 0 0 0 0 9
14newsfeeds.xmission.com 8 0 0 0 0 0 0 0 8
TOTAL: 14 8652 876 0 3 1 0 0 0 7772

Unwanted newsgroups [Top 20]:

NewsgroupCount
it-alt.sport.calcio.juventus 209
lada.talk 60
ut.test 41
it.annunci.immobiliari 39
it.annunci.commerciali 39
it.annunci.varie 37
lada.auto 36
mpc.lists.nanog 26
cakewalk.audio 21
gmane.comp.gis.openstreetmap.tagging 21
alt.slack.goathead 17
alt.windows7.general 15
mozilla.support.seamonkey 14
mozilla.dev.security.policy 13
alt.computer.workshop 12
mpc.lists.freebsd.office 11
alt.survival 10
lada.mobile 10
mozilla.dev.platform 10
mozilla.general 10
TOTAL: 117 876

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

GroupsCount
nz.politics.announce 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5600
EMP (phn path) 597
EMP (phn nph) 173
EMP (phl) 118
Too many newsgroups 66
User-issued cancel 29
Scoring filter (8) 27
HTML Multipart 25
Scoring filter (12) 23
Scoring filter (10) 21
Binary Payload 20
Too many newsgroups (low_xpost) 16
Scoring filter (11) 11
Scoring filter (9) 11
Scoring filter (15) 10
Scoring filter (16) 7
Poison newsgroup 7
User-issued spam cancel 6
Scoring filter (28) 5
Scoring filter (24) 5
TOTAL: 35 6801

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com3804141
TOTAL: 13804141

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
csiph-out.feeder.erje.net 35
TOTAL: 1 35
Bad Message-ID's offered
csiph-out.feeder.erje.net 4
TOTAL: 1 4
Huge articles
csiph-out.feeder.erje.net 177
csiph-out.news.weretis.net 130
feeder.eternal-september.org 109
news-out.mixmin.net 12
newsfeeds.xmission.com 6
news.fcku.it 4
news.freedyn.net 2
xanadu-bbs.net 1
news.redatomik.org 1
TOTAL: 9 442
Including strange strings
newsfeed.fu-berlin.de 364
news-out.mixmin.net 42
csiph-out.feeder.erje.net 36
csiph-out.news.weretis.net 14
news.redatomik.org 14
news.swapon.de 10
feeder.eternal-september.org 8
news-out.aioe.org 3
newsfeed.neva.ru 2
newsfeeds.xmission.com 1
TOTAL: 10 494
TOTAL: 4 975

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.freedyn.net 23391 951 21350 8 0 0 4%23:50:01
2news.bbs.geek.nz 39470 861 20636 81 0 0 2%23:50:06
3xanadu-bbs 22924 796 21402 2 0 86 3%23:59:55
4fu-berlin.de 21223 708 20515 0 0 0 3%23:50:06
5usenet.pasdenom.info 23027 136 20574 1658 0 4 0%23:59:49
6news.redatomik.org 20427 13 19894 7 0 1 0%23:58:14
7weretis.net 15453 5 15326 1 0 0 0%23:50:42
8xmission 21988 4 20770 1 0 0 0%23:59:55
9news.fcku.it 2583 3 2516 0 0 0 0%22:26:48
10erje 16866 2 16691 7 0 0 0%23:50:06
11neva.ru 20466 2 20119 71 0 0 0%23:59:49
12aioe 18711 2 18064 3 0 0 0%23:59:28
13news.mixmin.net 19551 1 19028 0 0 0 0%23:56:42
14eternal-september 18866 1 18114 0 0 0 0%23:59:55
15news.swapon.de 1906 0 1885 0 0 0 0%23:50:06
16au2pb 0 0 0 0 0 21598 0%23:50:08
17bwh 0 0 0 0 0 21591 0%23:50:08
TOTAL: 17 286852 3485 256884 1839 0 43280 1%405:01:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.freedyn.net10.7 MB13.6 KB10.7 MB0.1 KB/s11.4 KB23:50:01
2xanadu-bbs10.1 MB7.7 KB10.1 MB0.1 KB/s13.0 KB23:59:55
3fu-berlin.de9.9 MB0.0 KB9.9 MB0.1 KB/s14.3 KB23:50:06
4news.bbs.geek.nz2.4 MB328.8 KB2.7 MB0.0 KB/s3.0 KB23:50:06
5usenet.pasdenom.info403.7 KB11.6 MB12.0 MB0.1 KB/s6.9 KB23:59:49
6news.redatomik.org24.1 KB27.6 KB51.7 KB0.0 KB/s2.6 KB23:58:14
7aioe10.1 KB8.4 KB18.6 KB0.0 KB/s3.7 KB23:59:28
8weretis.net8.3 KB4.8 KB13.1 KB0.0 KB/s2.2 KB23:50:42
9xmission7.0 KB4.8 KB11.8 KB0.0 KB/s2.4 KB23:59:55
10erje5.2 KB10.6 KB15.8 KB0.0 KB/s1.8 KB23:50:06
11news.fcku.it4.5 KB0.0 KB4.5 KB0.0 KB/s1.5 KB22:26:48
12neva.ru3.0 KB145.8 KB148.8 KB0.0 KB/s2.0 KB23:59:49
13news.mixmin.net1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:56:42
14eternal-september1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:59:55
15news.swapon.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:06
16au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:08
17bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:08
TOTAL: 1733.6 MB12.2 MB45.8 MB0.0 KB/s8.8 KB405:01:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-03-70-24-219-221.dsl.bell.ca2450 139325.3 KB 106 0 002:45:39
2144.138.90.254 48 79285.5 KB 55 0 000:35:49
3204-73-239-109.cust.centrio.cz 6 57.4 KB 3 1 002:31:09
4tempe0.bbox.io 18 37.1 KB 1 0 006:21:18
TOTAL: 42522 226625.4 KB 165 1 016:45:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca2450 139325.3 KB 106 0 002:45:39
2unresolved 57 79285.5 KB 55 0 001:52:40
3*.cust.centrio.cz 6 57.4 KB 3 1 002:31:09
4*.bbox.io 18 37.1 KB 1 0 006:21:18
5*.nielsenmedia.com 7 00.0 KB 0 0 002:44:04
6*.19-1.cable.virginm.net 1 00.0 KB 0 0 000:00:10
7*.hsd1.wa.comcast.net 1 00.0 KB 0 0 000:30:01
TOTAL: 72540 226625.4 KB 165 1 016:45:03

NNRP auth users [Top 20]:

UserConn
moussa 47
ctomczyk 6
TOTAL: 2 53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
tempe0.bbox.io 1.576 0.239 0.00006:21:18
mtrlpq2314w-lp140-03-70-24-219-221.dsl.bell.ca 214.335 38.243 0.00002:45:39
challenger.nielsenmedia.com 0.364 0.118 0.00002:44:04
204-73-239-109.cust.centrio.cz 0.606 0.127 0.02202:31:09
216.239.174.218 0.195 0.033 0.00000:46:38
144.138.90.254 5.492 1.112 0.24000:35:49
c-174-61-130-222.hsd1.wa.comcast.net 0.081 0.024 0.00000:30:01
24.178.45.75 0.086 0.016 0.00000:30:00
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 0.150 0.016 0.00000:00:10
69.175.42.100 0.168 0.032 0.00000:00:04
108.178.59.51 0.162 0.008 0.00000:00:04
198.20.101.134 0.057 0.008 0.00000:00:02
TOTAL: 12 223.272 39.976 0.26216:45:03

Curious NNRP server explorers [Top 20]:

SystemConn
challenger.nielsenmedia.com 7
216.239.174.218 3
69.175.42.100 2
108.178.59.51 2
198.20.101.134 1
24.178.45.75 1
c-174-61-130-222.hsd1.wa.comcast.net 1
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net 1
TOTAL: 8 18

NNRP client timeouts [Top 20]:

SystemConnPeer
tempe0.bbox.io 8 0
challenger.nielsenmedia.com 5 0
204-73-239-109.cust.centrio.cz 4 0
c-174-61-130-222.hsd1.wa.comcast.net 1 0
24.178.45.75 1 0
216.239.174.218 1 0
TOTAL: 6 20 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 102 45.1%
2uk 54 23.9%
3alt 31 13.7%
4rec 22 9.7%
5soc 6 2.7%
6pl 5 2.2%
7sci 3 1.3%
8misc 2 0.9%
9aus 1 0.4%
TOTAL: 9 226100.0%

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

NewsgroupCount
1comp.arch 42
2comp.os.vms 17
3uk.legal 15
4comp.lang.python 13
5uk.d-i-y 13
6alt.home.repair 11
7uk.media.radio.archers 10
8comp.arch.embedded 10
9rec.boats 10
10comp.arch.fpga 9
11alt.comp.os.windows-10 9
12alt.os.linux.mint 6
13soc.culture.polish 5
14pl.comp.www 5
15uk.rec.sheds 4
16comp.mobile.android 4
17rec.arts.tv.uk.coronation-st 4
18uk.rec.cycling 3
19alt.atheism 3
20rec.sport.tennis 2
21uk.railway 2
22uk.radio.amateur 2
23sci.physics.relativity 2
24uk.comp.sys.mac 2
25comp.os.cpm 2
26comp.os.linux.misc 2
27rec.autos.sport.f1 2
28uk.sport.cricket 1
29aus.cars 1
30misc.news.internet.discuss 1
31soc.retirement 1
32alt.sports.football.pro.sd-chargers 1
33misc.survivalism 1
34comp.sys.ibm.pc.games.action 1
35rec.arts.tv 1
36alt.stupidity 1
37comp.misc 1
38comp.ai.neural-nets 1
39rec.arts.sf.written 1
40rec.running 1
41uk.rec.audio 1
42sci.electronics.basics 1
43uk.politics.misc 1
44rec.aviation.soaring 1
TOTAL: 44 226