Daily Usenet report for paganini.linuxd.org

Sep 25 00:00:02 -- Sep 26 00:00:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Sep 25 01:49:31 paganini overchan[11386]: input line too long, skipping
Sep 25 08:30:22 paganini overchan[11386]: input line too long, skipping
Sep 25 08:39:23 paganini overchan[11386]: input line too long, skipping
Sep 25 08:40:41 paganini overchan[11386]: input line too long, skipping
Sep 25 14:51:21 paganini overchan[11386]: input line too long, skipping
Sep 26 00:00:02 paganini overchan[30478]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)

Log entries by program:

Program nameLines%LinesSize%Size
inn 48678 62.1%10.6 MB 75.7%
innd 20540 26.2%2.3 MB 16.6%
nnrpd 6560 8.4%687.4 KB 4.8%
innfeed 2500 3.2%424.0 KB 2.9%
nocem 71 0.1%8.3 KB 0.1%
overchan 7 0.0%0.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 78357 100.0%14.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 333579 59.8%
Negative hits 176406 31.6%
Do not exist 47723 8.6%
Cache misses 150 0.0%
TOTAL: 4 557858 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.436 0.0%176 0.000 2.477 35.200
article cleanup00:00:00.347 0.0%48116 0.000 0.007 0.037
article logging00:00:00.488 0.0%48431 0.000 0.010 0.173
article parse00:00:01.243 0.0%134525 0.000 0.009 0.024
article write00:01:03.581 0.1%27049 0.287 2.351 48.299
artlog/artcncl00:00:00.002 0.0%170 0.000 0.012 0.167
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.327 0.0%607590 0.000 0.001 0.003
hisgrep/artcncl00:00:00.002 0.0%174 0.000 0.011 1.000
hishave/artcncl00:00:00.002 0.0%176 0.000 0.011 0.111
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:25.438 0.0%562366 0.017 0.045 0.321
history sync00:00:00.015 0.0%297 0.000 0.051 0.500
history write00:00:45.765 0.1%48109 0.027 0.951 4.000
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:54:58.189 99.6%600815 59.355 143.302 405.513
nntp read00:00:03.854 0.0%612393 0.003 0.006 0.012
overview write00:00:24.078 0.0%27049 0.023 0.890 2.818
perl filter00:01:49.613 0.1%48108 1.221 2.278 12.571
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.260 0.0%81412 0.000 0.015 0.065
TOTAL: 24:00:20.71123:59:34.640 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.075 0.0%28888 0.000 0.003 0.025
article prepare00:00:00.021 0.0%152156 0.000 0.000 0.003
article read00:00:14.089 0.0%23017 0.020 0.612 6.306
backlog stats00:00:00.277 0.0%644276 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.492 0.0%413954 0.002 0.006 0.011
data write00:00:03.685 0.0%391176 0.005 0.009 0.018
idle23:52:30.631100.0%644276 73.884 133.407 345.448
status file00:00:05.194 0.0%205 0.000 25.337 103.000
TOTAL: 23:53:10.83923:52:56.464100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:34:32.577 98.7%15826 34.857 130.960 235.118
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.215 0.0%31764 0.000 0.007 0.056
readart00:00:07.044 0.3%7812 0.344 0.902 17.500
TOTAL: 00:34:59.16900:34:39.836 99.1%----

Control commands to INND:

CommandNumber
L 1
flush 6
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 171

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 1 67271 7129 56986 3156 10%50:21:56
2feeder.eternal-september.org 4 43868 4911 35407 3550 11%24:35:52
3vc89.vc.panix.com 1 7466 4191 2429 846 56%23:28:21
4news-out.mixmin.net 5 34108 2810 28947 2351 8%24:34:35
5news.albasani.net 3 33218 2749 28521 1948 8%23:42:17
6newsfeed.neva.ru 141 103578 2253 92208 9117 2%71:26:20
7news.fcku.it 1 6512 1960 4522 30 30%23:21:59
8etla.org 2 23405 741 22664 0 3%21:51:37
9news.netfront.net 4 71157 125 71000 32 0%35:45:40
10nntp.pasdenom.info 2 25398 56 25337 5 0%21:32:17
11localhost 25 0 0 0 0 0%00:00:00
12news.stack.nl 1 0 0 0 0 0%00:10:00
TOTAL: 12 190 415981 26925 368021 21035 6%320:50:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net23.3 MB136.4 KB30.7 MB54.2 MB 43%5.4 KB
2vc89.vc.panix.com15.6 MB4.4 KB5.0 MB20.6 MB 75%4.2 KB
3feeder.eternal-september.org14.1 MB48.1 KB32.4 MB46.5 MB 30%5.6 KB
4news.albasani.net9.1 MB0.0 KB13.6 MB22.7 MB 40%4.9 KB
5newsfeed.neva.ru7.2 MB0.0 KB78.0 MB85.2 MB 8%7.7 KB
6news-out.mixmin.net7.2 MB48.0 KB4.6 MB11.9 MB 60%2.4 KB
7news.fcku.it3.6 MB0.0 KB45.7 KB3.6 MB 98%1.9 KB
8etla.org2.4 MB0.0 KB0.0 KB2.4 MB100%3.3 KB
9news.netfront.net592.8 KB51.2 KB4.2 MB4.9 MB 11%31.8 KB
10nntp.pasdenom.info112.3 KB0.0 KB138.8 KB251.1 KB 44%4.1 KB
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1283.3 MB288.1 KB168.6 MB252.2 MB 33%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 25 00:00:02 - 00:59:59 992 3.7% 0.283.4 MB 4.1% 0.97
Sep 25 01:00:00 - 01:59:59 794 2.9% 0.222.8 MB 3.4% 0.79
Sep 25 02:00:00 - 02:59:59 658 2.4% 0.182.2 MB 2.7% 0.63
Sep 25 03:00:00 - 03:59:59 581 2.2% 0.162.1 MB 2.5% 0.60
Sep 25 04:00:00 - 04:59:59 576 2.1% 0.162.7 MB 3.2% 0.77
Sep 25 05:00:00 - 05:59:59 500 1.9% 0.141.6 MB 1.9% 0.45
Sep 25 06:00:00 - 06:59:59 571 2.1% 0.162.0 MB 2.4% 0.56
Sep 25 07:00:00 - 07:59:59 600 2.2% 0.172.1 MB 2.5% 0.60
Sep 25 08:00:00 - 08:59:59 883 3.3% 0.253.9 MB 4.6% 1.10
Sep 25 09:00:00 - 09:59:59 1184 4.4% 0.333.3 MB 3.9% 0.93
Sep 25 10:00:00 - 10:59:59 1281 4.7% 0.363.6 MB 4.3% 1.03
Sep 25 11:00:00 - 11:59:59 1419 5.3% 0.394.6 MB 5.5% 1.31
Sep 25 12:00:00 - 12:59:59 1247 4.6% 0.353.0 MB 3.6% 0.86
Sep 25 13:00:00 - 13:59:59 1253 4.6% 0.353.1 MB 3.8% 0.89
Sep 25 14:00:00 - 14:59:59 1249 4.6% 0.353.4 MB 4.1% 0.98
Sep 25 15:00:00 - 15:59:59 1467 5.4% 0.415.2 MB 6.2% 1.47
Sep 25 16:00:00 - 16:59:59 1585 5.9% 0.444.2 MB 5.1% 1.21
Sep 25 17:00:00 - 17:59:59 1699 6.3% 0.475.0 MB 5.9% 1.41
Sep 25 18:00:00 - 18:59:59 1623 6.0% 0.454.5 MB 5.3% 1.27
Sep 25 19:00:00 - 19:59:59 1520 5.6% 0.424.1 MB 4.9% 1.16
Sep 25 20:00:00 - 20:59:59 1393 5.2% 0.394.1 MB 4.9% 1.16
Sep 25 21:00:00 - 21:59:59 1409 5.2% 0.395.2 MB 6.3% 1.48
Sep 25 22:00:00 - 22:59:59 1284 4.8% 0.363.5 MB 4.2% 1.01
Sep 25 23:00:00 - 23:59:59 1248 4.6% 0.353.7 MB 4.5% 1.06
Sep 26 00:00:00 - 00:00:02 6 0.0% 3.0028.1 KB 0.0% 14.04
TOTAL: 24:00:00 27022 100.0% 0.3183.4 MB 100.0% 0.99
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 9201 1799 0 0 0 0 0 0 7402
2feeder.eternal-september.org 3598 233 0 1 0 0 0 0 3364
3linuxd-out.news.weretis.net 3200 1349 0 3 0 0 0 0 1848
4news-out.mixmin.net 2384 15 0 1 0 0 0 0 2368
5news.albasani.net 2106 166 0 0 0 0 0 0 1940
6vc89.vc.panix.com 928 4 0 1 0 0 0 0 923
7news.fcku.it 40 25 0 0 0 0 0 0 15
8news.netfront.net 16 0 0 0 0 1 0 0 15
9nntp.pasdenom.info 13 7 0 0 0 0 0 0 6
TOTAL: 9 21486 3598 0 6 0 1 0 017881

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 652
ut.test 188
lada.talk 186
mailing.freebsd.svn-ports-head 127
mailing.freebsd.svn-ports-all 127
alt.politics 119
lada.auto 106
mozilla.dev.tree-alerts 95
it-alt.sport.calcio.juventus 87
mailing.freebsd.ports-bugs 75
mailing.dragonflybsd.commits 66
mailing.gcc.gcc-cvs 54
mailing.freebsd.pkg-fallout 51
mpc.lists.nanog 49
mailing.freebsd.bugs 47
fa.freebsd.bugs 46
mozilla.support.firefox 44
it.comp.os.win.windows10 43
mailing.openssl.dev 42
mailing.freebsd.svn-src-all 37
TOTAL: 266 3598

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13262
EMP (phn path) 2562
EMP (phl) 791
EMP (phn nph) 579
Too many newsgroups (low_xpost) 114
PFM bot misc 69
Too many newsgroups 64
User-issued cancel 40
Binary: non-binary distribution 31
Binary Payload 30
Binary Image: misplaced jpg 15
HTML post 9
Too many newsgroups (meow) 3
Binary: misplaced ARJ 1
User-issued spam cancel 1
TOTAL: 15 17571

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 144
news.albasani.net 88
feeder.eternal-september.org 35
news-out.mixmin.net 22
news.fcku.it 11
vc89.vc.panix.com 6
newsfeed.neva.ru 2
news.netfront.net 1
TOTAL: 8 309
TOTAL: 1 309

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 26789 2537 14944 7591 0 0 9%23:59:51
2vc89.vc.panix.com 30041 2333 9641 15046 0 80 7%23:59:49
3news.netfront.net 39042 1949 19598 30 0 5620 4%23:59:51
4weretis.net 21116 865 18700 0 0 0 4%23:59:36
5etla.org 34337 644 26351 26 0 394 1%23:59:51
6neva.ru 31438 547 23364 767 0 2 1%23:59:51
7news.albasani.net 28659 233 21859 2088 0 69 0%23:59:51
8nntp.pasdenom.info 36106 172 26128 648 0 58 0%23:59:51
9news.killfile.org 44931 155 24744 2119 0 193 0%23:59:51
10news.stack.nl 45372 155 26585 255 0 946 0%23:59:51
11eternal-september 23879 1 21932 0 0 0 0%23:59:43
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 361710 9591 233846 28570 0 7362 2%264:07:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it9.7 MB29.5 MB39.2 MB0.5 KB/s4.0 KB23:59:51
2news.netfront.net8.3 MB388.3 KB8.7 MB0.1 KB/s4.5 KB23:59:51
3vc89.vc.panix.com7.9 MB41.9 MB49.8 MB0.6 KB/s2.9 KB23:59:49
4etla.org6.2 MB139.1 KB6.4 MB0.1 KB/s9.7 KB23:59:51
5weretis.net1.5 MB0.0 KB1.5 MB0.0 KB/s1.8 KB23:59:36
6neva.ru1.0 MB1.4 MB2.4 MB0.0 KB/s1.9 KB23:59:51
7news.stack.nl665.1 KB822.9 KB1.5 MB0.0 KB/s3.6 KB23:59:51
8nntp.pasdenom.info652.8 KB1.3 MB1.9 MB0.0 KB/s2.4 KB23:59:51
9news.albasani.net529.7 KB9.8 MB10.3 MB0.1 KB/s4.5 KB23:59:51
10news.killfile.org506.4 KB7.0 MB7.4 MB0.1 KB/s3.4 KB23:59:51
11eternal-september6.1 KB0.0 KB6.1 KB0.0 KB/s6.1 KB23:59:43
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 1237.0 MB92.1 MB129.1 MB0.1 KB/s3.5 KB264:07:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1x4db30b1a.dyn.telefonica.de 41 2851.2 KB 23 0 000:00:58
2mtrlpq2314w-lp130-04-1177984284.dsl.bell.ca 135 616.7 KB 5 0 000:33:45
3x4db3272b.dyn.telefonica.de 7 213.6 KB 2 0 000:00:09
TOTAL: 3 183 3681.6 KB 30 0 000:34:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dyn.telefonica.de 48 3064.9 KB 25 0 000:01:07
2*.dsl.bell.ca 135 616.7 KB 5 0 000:33:45
3*.dsl.klmzmi.ameritech.net 1 00.0 KB 0 0 000:00:04
TOTAL: 3 184 3681.6 KB 30 0 000:34:58

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp130-04-1177984284.dsl.bell.ca 12.340 1.328 0.00000:33:45
x4db30b1a.dyn.telefonica.de 2.872 0.188 0.00000:00:58
x4db3272b.dyn.telefonica.de 0.388 0.040 0.00000:00:09
ppp-69-214-2-96.dsl.klmzmi.ameritech.net 0.056 0.004 0.00000:00:04
TOTAL: 4 15.656 1.560 0.00000:34:58

Curious NNRP server explorers [Top 20]:

SystemConn
ppp-69-214-2-96.dsl.klmzmi.ameritech.net 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1de 30 83.3%
2alt 4 11.1%
3uk 1 2.8%
4rec 1 2.8%
TOTAL: 4 36100.0%

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

NewsgroupCount
1de.talk.jokes 14
2de.comp.security.misc 4
3de.etc.finanz.boerse 3
4de.comm.technik.dsl 3
5de.comm.software.mailserver 2
6de.alt.rec.digitalfotografie 2
7alt.usenet.kooks 2
8alt.fan.rush-limbaugh 1
9de.comp.os.unix.networking.misc 1
10alt.assassination.jfk 1
11rec.arts.tv 1
12uk.legal 1
13de.comm.provider.usenet 1
TOTAL: 13 36