Daily Usenet report for csiph.com

Feb 23 04:15:00 -- Feb 24 04:15:00

Log entries by program:

Program nameLines%LinesSize%Size
inn 42446 60.7%8.0 MB 72.1%
innd 23553 33.7%2.5 MB 22.7%
innfeed 3199 4.6%513.2 KB 4.5%
nnrpd 546 0.8%61.7 KB 0.5%
nocem 126 0.2%13.9 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 69871 100.0%11.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 430947 57.6%
Negative hits 275573 36.8%
Do not exist 41467 5.5%
Cache misses 540 0.1%
TOTAL: 4 748527 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.874 0.0%373 0.000 2.343 23.000
article cleanup00:00:00.279 0.0%41420 0.000 0.007 0.020
article logging00:00:02.722 0.0%41946 0.000 0.065 0.742
article parse00:00:02.651 0.0%139118 0.002 0.019 0.272
article write00:01:59.777 0.1%23349 0.216 5.130 28.493
artlog/artcncl00:00:00.018 0.0%317 0.000 0.057 0.333
artlog/artparse00:00:00.055 0.0%204 0.000 0.270 22.000
data move00:00:00.254 0.0%704776 0.000 0.000 0.001
hisgrep/artcncl00:00:00.200 0.0%370 0.000 0.541 15.000
hishave/artcncl00:00:00.067 0.0%373 0.000 0.180 2.400
hishave/artparse00:00:00.001 0.0%201 0.000 0.005 0.111
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:26.778 0.1%750034 0.003 0.116 0.609
history sync00:00:04.389 0.0%360 0.000 12.192 94.667
history write00:02:56.883 0.2%41383 0.206 4.274 28.271
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hiswrite/artparse00:00:01.041 0.0%201 0.000 5.179 23.000
idle23:47:28.056 99.1%691774 75.104 123.809 358.335
nntp read00:00:03.308 0.0%715237 0.002 0.005 0.008
overview write00:03:51.498 0.3%23349 0.805 9.915 174.151
perl filter00:01:45.311 0.1%41380 1.349 2.545 3.843
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.432 0.0%46817 0.000 0.009 0.027
TOTAL: 24:00:55.74523:59:44.594 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.075 0.0%23445 0.000 0.003 0.018
article prepare00:00:00.010 0.0%54252 0.000 0.000 0.004
article read00:00:01.724 0.0%10173 0.032 0.169 1.871
backlog stats00:00:00.282 0.0%446570 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.280 0.0%340298 0.002 0.007 0.012
data write00:00:01.989 0.0%322513 0.002 0.006 0.011
idle23:52:52.267100.0%446570 112.703 192.517 546.029
status file00:00:00.230 0.0%281 0.000 0.819 14.000
TOTAL: 23:53:12.65323:52:58.857100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:02.668 0.0%978 2.728 2.728 2.728
idle21:28:54.575100.0%1353 214.000 57157.853600119.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.009 0.0%2786 0.000 0.003 0.100
readart00:00:00.266 0.0%26 0.000 10.231 56.000
TOTAL: 21:29:27.98921:28:57.518100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1csiph-out.feeder.erje.net 1152 133902 7682 115690 10530 5%94:58:14
2csiph-out.news.weretis.net 6 53861 5379 46902 1580 9%50:21:45
3feeder.eternal-september.org 2 37362 3396 30170 3796 9%24:07:48
4news-out.aioe.org 2 22075 1734 20310 31 7%24:09:56
5newsfeed.neva.ru 146 58603 1117 55107 2379 1%72:09:35
6newsfeed.fu-berlin.de 47 22685 1052 20859 774 4%29:48:35
7newsfeeds.xmission.com 3 24599 993 23600 6 4%29:03:05
8news.redatomik.org 1 23243 907 22333 3 3%26:06:15
9news-out.mixmin.net 2 25544 662 24764 118 2%23:59:47
10news.freedyn.net 3 26325 180 25970 175 0%24:09:50
11news.fcku.it 2 11047 153 10810 84 1%23:59:33
12nntp.pasdenom.info 4 22003 104 21892 7 0%23:56:05
13news.swapon.de 3 2883 62 2764 57 2%25:45:34
14xanadu-bbs.net 15 1031 29 991 11 2%26:08:51
15news.bbs.geek.nz 2 16490 26 16463 1 0%23:59:27
16localhost 40 6 6 0 0 100%00:00:02
TOTAL: 16 1430 481659 23482 438625 19552 4%522:44:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1csiph-out.feeder.erje.net24.3 MB190.7 KB67.3 MB91.8 MB 26%5.2 KB
2csiph-out.news.weretis.net17.1 MB13.2 KB19.6 MB36.6 MB 46%5.4 KB
3feeder.eternal-september.org9.2 MB0.0 KB52.6 MB61.8 MB 14%8.8 KB
4news-out.aioe.org4.1 MB0.0 KB45.9 KB4.2 MB 98%2.4 KB
5news-out.mixmin.net3.3 MB53.9 KB700.9 KB4.1 MB 81%5.4 KB
6newsfeeds.xmission.com3.3 MB0.0 KB380.5 KB3.7 MB 89%3.8 KB
7newsfeed.neva.ru3.0 MB17.9 KB20.2 MB23.3 MB 13%6.8 KB
8news.redatomik.org2.7 MB13.2 KB68.3 KB2.8 MB 97%3.2 KB
9newsfeed.fu-berlin.de2.4 MB0.0 KB2.1 MB4.5 MB 52%2.5 KB
10news.freedyn.net679.4 KB0.0 KB2.4 MB3.1 MB 21%8.8 KB
11nntp.pasdenom.info260.3 KB0.0 KB21.6 KB281.8 KB 92%2.5 KB
12xanadu-bbs.net235.0 KB0.0 KB50.8 KB285.8 KB 82%7.1 KB
13news.fcku.it226.1 KB0.0 KB238.2 KB464.4 KB 48%2.0 KB
14news.swapon.de160.4 KB0.0 KB180.6 KB341.0 KB 47%2.9 KB
15news.bbs.geek.nz63.9 KB0.0 KB1.8 KB65.7 KB 97%2.4 KB
16localhost10.6 KB0.0 KB0.0 KB10.6 KB100%1.8 KB
TOTAL: 1671.1 MB288.9 KB165.9 MB237.3 MB 29%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 23 04:15:00 - 04:59:59 358 1.5% 0.131.0 MB 1.5% 0.39
Feb 23 05:00:00 - 05:59:59 698 3.0% 0.192.9 MB 4.0% 0.81
Feb 23 06:00:00 - 06:59:59 551 2.4% 0.151.8 MB 2.6% 0.52
Feb 23 07:00:00 - 07:59:59 688 2.9% 0.192.7 MB 3.9% 0.78
Feb 23 08:00:00 - 08:59:59 972 4.2% 0.272.5 MB 3.6% 0.72
Feb 23 09:00:00 - 09:59:59 1076 4.6% 0.302.8 MB 4.0% 0.80
Feb 23 10:00:00 - 10:59:59 1010 4.3% 0.283.2 MB 4.5% 0.90
Feb 23 11:00:00 - 11:59:59 1076 4.6% 0.302.9 MB 4.1% 0.82
Feb 23 12:00:00 - 12:59:59 1128 4.8% 0.313.1 MB 4.4% 0.89
Feb 23 13:00:00 - 13:59:59 1156 5.0% 0.323.2 MB 4.5% 0.90
Feb 23 14:00:00 - 14:59:59 1151 4.9% 0.322.9 MB 4.2% 0.84
Feb 23 15:00:00 - 15:59:59 1096 4.7% 0.303.1 MB 4.4% 0.88
Feb 23 16:00:00 - 16:59:59 1425 6.1% 0.405.0 MB 7.1% 1.42
Feb 23 17:00:00 - 17:59:59 1488 6.4% 0.414.7 MB 6.6% 1.34
Feb 23 18:00:00 - 18:59:59 1299 5.6% 0.363.9 MB 5.5% 1.11
Feb 23 19:00:00 - 19:59:59 1188 5.1% 0.333.3 MB 4.6% 0.93
Feb 23 20:00:00 - 20:59:59 1197 5.1% 0.333.5 MB 4.9% 0.99
Feb 23 21:00:00 - 21:59:59 1166 5.0% 0.323.2 MB 4.5% 0.91
Feb 23 22:00:00 - 22:59:59 1159 5.0% 0.323.5 MB 5.0% 1.00
Feb 23 23:00:00 - 23:59:59 906 3.9% 0.252.9 MB 4.0% 0.82
Feb 24 00:00:00 - 00:59:59 762 3.3% 0.212.2 MB 3.2% 0.64
Feb 24 01:00:00 - 01:59:59 551 2.4% 0.151.8 MB 2.5% 0.50
Feb 24 02:00:00 - 02:59:59 660 2.8% 0.182.8 MB 3.9% 0.79
Feb 24 03:00:00 - 03:59:59 467 2.0% 0.131.6 MB 2.2% 0.44
Feb 24 04:00:00 - 04:15:00 123 0.5% 0.14402.1 KB 0.6% 0.45
TOTAL: 24:00:00 23351 100.0% 0.2770.9 MB 100.0% 0.84
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1csiph-out.feeder.erje.net 9288 417 0 31 2 0 0 0 8838
2feeder.eternal-september.org 3813 49 0 0 0 0 0 0 3764
3newsfeed.neva.ru 2364 219 0 3 0 0 0 0 2142
4csiph-out.news.weretis.net 1606 213 0 1 0 0 0 0 1392
5newsfeed.fu-berlin.de 1184 25 0 0 0 0 0 0 1159
6news.freedyn.net 176 14 0 0 0 0 0 0 162
7news-out.mixmin.net 123 4 0 2 0 0 0 0 117
8news.fcku.it 85 0 0 1 0 0 0 0 84
9news.swapon.de 63 0 0 0 0 0 0 0 63
10news-out.aioe.org 41 30 0 1 0 0 0 0 10
11xanadu-bbs.net 11 0 0 0 0 0 0 0 11
12newsfeeds.xmission.com 8 1 0 0 0 0 0 0 7
13news.redatomik.org 8 0 0 1 0 0 0 0 7
14nntp.pasdenom.info 7 5 0 0 0 0 0 0 2
15news.bbs.geek.nz 1 0 0 0 0 0 0 0 1
TOTAL: 15 18778 977 0 40 2 0 0 017759

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 160
it-alt.sport.calcio.juventus 91
lada.talk 66
eagle.userchat.eng 49
alt.windows7.general 27
lada.auto 26
mozilla.dev.security.policy 25
mpc.lists.nanog 25
fido.enet.sysop 25
mozilla.dev.platform 22
mpc.lists.freebsd.ports.bugs 21
mozilla.support.seamonkey 19
mozilla.tools.taskcluster 14
mozilla.support.thunderbird 12
gmane.comp.gis.openstreetmap 12
gmane.linux.alsa.devel 10
fido.linux 10
gmane.comp.gis.openstreetmap.tagging 9
mozilla.dev.tech.crypto 9
gmane.comp.bacula.user 9
TOTAL: 149 977

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

GroupsCount
sci.space.news 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14024
EMP (phn path) 2226
EMP (phl) 481
EMP (phn nph) 119
Too many newsgroups 45
User-issued cancel 16
Scoring filter (12) 15
Binary Payload 15
HTML Multipart 15
Scoring filter (10) 15
Scoring filter (9) 14
Scoring filter (8) 9
EMP (fsl) 9
Binary Image: misplaced jpg 7
Scoring filter (11) 6
Scoring filter (14) 5
Scoring filter (16) 4
HTML Image Tags 3
Scoring filter (15) 2
HTML post 2
TOTAL: 22 17034

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1190149149
TOTAL: 11190149149

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
feeder.eternal-september.org 110
csiph-out.news.weretis.net 65
news.freedyn.net 8
news-out.mixmin.net 7
newsfeeds.xmission.com 4
news.fcku.it 2
news.redatomik.org 1
newsfeed.fu-berlin.de 1
TOTAL: 8 198
Including strange strings
newsfeed.fu-berlin.de 389
csiph-out.feeder.erje.net 54
csiph-out.news.weretis.net 29
feeder.eternal-september.org 14
news-out.aioe.org 9
newsfeed.neva.ru 8
news.swapon.de 7
news.redatomik.org 5
news-out.mixmin.net 4
newsfeeds.xmission.com 3
TOTAL: 12 524
No colon-space in header
csiph-out.feeder.erje.net 3
TOTAL: 1 3
TOTAL: 3 725

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.geek.nz 35810 8500 13797 231 2 0 23%23:50:08
2news.freedyn.net 24184 928 22144 4 0 0 3%23:50:08
3xanadu-bbs 26420 860 22454 4 0 3 3%23:59:49
4fu-berlin.de 21897 671 21220 0 0 0 3%23:49:58
5erje 16095 371 15056 46 0 0 2%23:50:08
6usenet.pasdenom.info 26259 240 21697 1309 0 88 0%23:59:51
7xmission 26613 143 21548 7 0 53 0%23:59:51
8aioe 21919 99 19706 12 0 0 0%23:52:18
9news.redatomik.org 22878 49 21617 8 0 0 0%23:50:08
10weretis.net 16680 18 15836 3 0 17 0%23:58:31
11eternal-september 21621 10 18918 0 0 3 0%23:59:51
12news.mixmin.net 22679 9 21406 0 0 0 0%23:50:08
13news.swapon.de 2211 5 2095 1 0 1 0%23:47:40
14news.fcku.it 3177 4 3035 0 0 0 0%23:18:54
15neva.ru 22710 2 21174 20 0 2 0%23:59:44
16bwh 0 0 0 0 0 22547 0%23:50:14
17au2pb 0 0 0 0 0 22561 0%23:50:15
TOTAL: 17 311153 11909 261703 1645 2 45275 3%405:37:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.bbs.geek.nz22.5 MB1.3 MB23.8 MB0.3 KB/s2.8 KB23:50:08
2news.freedyn.net6.3 MB14.8 KB6.3 MB0.1 KB/s6.9 KB23:50:08
3xanadu-bbs5.8 MB16.0 KB5.8 MB0.1 KB/s6.9 KB23:59:49
4fu-berlin.de5.3 MB0.0 KB5.3 MB0.1 KB/s8.1 KB23:49:58
5erje1.7 MB225.3 KB1.9 MB0.0 KB/s4.7 KB23:50:08
6usenet.pasdenom.info751.3 KB6.6 MB7.3 MB0.1 KB/s4.8 KB23:59:51
7xmission345.5 KB15.1 KB360.6 KB0.0 KB/s2.4 KB23:59:51
8aioe276.1 KB53.9 KB330.0 KB0.0 KB/s3.0 KB23:52:18
9news.redatomik.org138.3 KB59.2 KB197.5 KB0.0 KB/s3.5 KB23:50:08
10weretis.net51.1 KB11.7 KB62.9 KB0.0 KB/s3.0 KB23:58:31
11news.mixmin.net22.0 KB0.0 KB22.0 KB0.0 KB/s2.4 KB23:50:08
12eternal-september21.9 KB0.0 KB21.9 KB0.0 KB/s2.2 KB23:59:51
13news.swapon.de10.9 KB1.1 KB11.9 KB0.0 KB/s2.0 KB23:47:40
14news.fcku.it6.5 KB0.0 KB6.5 KB0.0 KB/s1.6 KB23:18:54
15neva.ru4.6 KB71.9 KB76.5 KB0.0 KB/s3.5 KB23:59:44
16bwh0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:14
17au2pb0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:15
TOTAL: 1743.2 MB8.4 MB51.6 MB0.0 KB/s3.9 KB405:37:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dhcp-089-099-203-254.chello.nl 32 814.0 KB 4 0 008:43:16
2tempe0.bbox.io 13 712.3 KB 2 0 003:32:40
368-185-181-64.dhcp.mdsn.wi.charter.com 26 712.3 KB 7 6 506:05:49
4194-73-239-109.cust.centrio.cz 11 22.8 KB 2 1 001:33:00
TOTAL: 4 82 2645.5 KB 16 7 521:29:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.chello.nl 32 814.0 KB 4 0 008:43:16
2*.bbox.io 13 712.3 KB 2 0 003:32:40
3*.dhcp.mdsn.wi.charter.com 26 712.3 KB 7 6 506:05:49
4*.cust.centrio.cz 11 22.8 KB 2 1 001:33:00
5unresolved 2 24.2 KB 1 0 000:30:46
6*.137.22.98.dynamic.ip.windstream.net 1 00.0 KB 0 0 001:03:53
TOTAL: 6 85 2645.5 KB 16 7 521:29:27

NNRP auth users [Top 20]:

UserConn
ohlandl 5
ctomczyk 3
TOTAL: 2 8

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dhcp-089-099-203-254.chello.nl 2.639 0.541 0.00008:43:16
68-185-181-64.dhcp.mdsn.wi.charter.com 2.444 0.515 0.02106:05:49
tempe0.bbox.io 1.183 0.293 0.00003:32:40
194-73-239-109.cust.centrio.cz 0.924 0.173 0.01101:33:00
h201.137.22.98.dynamic.ip.windstream.net 0.054 0.135 0.00001:03:53
1.126.48.100 0.143 0.030 0.00400:30:38
106.75.75.176 0.093 0.008 0.00000:00:04
71.6.146.185 0.083 0.015 0.00000:00:03
TOTAL: 8 7.563 1.710 0.03621:29:27

Curious NNRP server explorers [Top 20]:

SystemConn
106.75.75.176 1
71.6.146.185 1
h201.137.22.98.dynamic.ip.windstream.net 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
tempe0.bbox.io 7 0
68-185-181-64.dhcp.mdsn.wi.charter.com 5 0
194-73-239-109.cust.centrio.cz 3 0
1.126.48.100 1 0
TOTAL: 4 16 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 24 92.3%
2pl 2 7.7%
TOTAL: 2 26100.0%

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

NewsgroupCount
1comp.sys.ibm.ps2.hardware 24
2pl.comp.lang.javascript 2
TOTAL: 2 26