Daily Usenet report for paganini.linuxd.org

Jul 5 00:00:03 -- Jul 6 00:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 5 16:28:46 paganini overchan[18034]: input line too long, skipping
Jul 6 00:00:02 paganini overchan[5297]: 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 40191 57.4%9.1 MB 72.7%
innd 16626 23.7%1.9 MB 15.2%
nnrpd 10654 15.2%1.1 MB 8.9%
innfeed 2494 3.6%406.6 KB 3.2%
nocem 101 0.1%11.5 KB 0.1%
overchan 3 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 70070 100.0%12.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 285438 59.1%
Negative hits 157657 32.7%
Do not exist 39647 8.2%
Cache misses 105 0.0%
TOTAL: 4 482847 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.542 0.0%158 0.000 3.430 83.500
article cleanup00:00:00.251 0.0%39882 0.000 0.006 0.027
article logging00:00:00.384 0.0%40036 0.000 0.010 0.182
article parse00:00:01.120 0.0%128801 0.000 0.009 0.028
article write00:00:49.277 0.1%23787 0.102 2.072 9.817
artlog/artcncl00:00:00.000 0.0%158 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.330 0.0%553235 0.000 0.001 0.003
hisgrep/artcncl00:00:00.004 0.0%157 0.000 0.025 1.000
hishave/artcncl00:00:00.003 0.0%158 0.000 0.019 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:24.147 0.0%485799 0.018 0.050 0.559
history sync00:00:00.025 0.0%354 0.000 0.071 1.000
history write00:00:40.850 0.0%39880 0.020 1.024 4.458
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:09.472 99.7%540664 55.060 159.377 541.681
nntp read00:00:03.540 0.0%549767 0.003 0.006 0.011
overview write00:00:20.438 0.0%23787 0.022 0.859 4.137
perl filter00:01:30.372 0.1%39877 0.904 2.266 8.418
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.049 0.0%71620 0.003 0.015 0.046
TOTAL: 24:00:52.01424:00:01.804 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.071 0.0%25872 0.000 0.003 0.020
article prepare00:00:00.018 0.0%136828 0.000 0.000 0.003
article read00:00:12.102 0.0%20161 0.029 0.600 11.042
backlog stats00:00:00.288 0.0%560658 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.217 0.0%363385 0.003 0.006 0.013
data write00:00:03.847 0.0%342388 0.006 0.011 0.020
idle23:52:47.981100.0%560658 85.534 153.334 410.146
status file00:00:07.248 0.0%210 0.000 34.514 206.000
TOTAL: 23:53:24.19523:53:13.772100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:47:14.835 98.0%19115 34.308 1089.973 2870.739
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:32.324 0.2%180478 0.000 0.179 0.333
readart00:06:27.269 1.8%190017 0.117 2.038 30.000
TOTAL: 05:54:30.84705:54:14.428 99.9%----

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 2 53941 7465 43695 2781 13%47:43:35
2feeder.eternal-september.org 4 36262 5244 27212 3806 14%24:28:39
3vc89.vc.panix.com 1 7433 4084 2478 871 54%24:32:47
4news.albasani.net 3 29886 2571 26049 1266 8%24:30:04
5newsfeed.neva.ru 146 84817 2247 75656 6914 2%72:47:22
6etla.org 3 19964 952 19012 0 4%21:55:20
7news.fcku.it 11 1516 618 890 8 40%21:13:08
8news-out.mixmin.net 5 20908 277 20350 281 1%19:26:43
9news.netfront.net 1 32794 59 32668 67 0%22:02:36
10nntp.pasdenom.info 1 15006 13 14993 0 0%16:44:00
11localhost 25 0 0 0 0 0%00:00:00
12news.stack.nl 1 0 0 0 0 0%00:10:00
TOTAL: 12 203 302527 23530 263003 15994 7%295:34:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net32.2 MB2.5 KB32.6 MB64.8 MB 49%6.5 KB
2vc89.vc.panix.com17.5 MB0.0 KB6.6 MB24.1 MB 72%5.0 KB
3feeder.eternal-september.org15.6 MB5.2 KB37.0 MB52.5 MB 29%5.9 KB
4news.albasani.net8.7 MB0.0 KB5.6 MB14.3 MB 61%3.8 KB
5newsfeed.neva.ru7.3 MB21.4 KB48.8 MB56.2 MB 13%6.3 KB
6etla.org2.6 MB0.0 KB0.0 KB2.6 MB100%2.8 KB
7news.fcku.it1.1 MB0.0 KB30.6 KB1.1 MB 97%1.9 KB
8news-out.mixmin.net957.0 KB0.0 KB1009.7 KB1.9 MB 48%3.5 KB
9news.netfront.net172.2 KB0.0 KB8.6 MB8.7 MB 1%70.9 KB
10nntp.pasdenom.info20.3 KB0.0 KB0.0 KB20.3 KB100%1.6 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: 1286.2 MB29.1 KB140.1 MB226.3 MB 38%5.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 5 00:00:03 - 00:59:59 936 3.9% 0.262.6 MB 3.1% 0.75
Jul 5 01:00:00 - 01:59:59 571 2.4% 0.162.8 MB 3.2% 0.79
Jul 5 02:00:00 - 02:59:59 531 2.2% 0.151.7 MB 1.9% 0.47
Jul 5 03:00:00 - 03:59:59 694 2.9% 0.192.0 MB 2.3% 0.57
Jul 5 04:00:00 - 04:59:59 467 2.0% 0.131.5 MB 1.8% 0.44
Jul 5 05:00:00 - 05:59:59 439 1.8% 0.121.6 MB 1.8% 0.45
Jul 5 06:00:00 - 06:59:59 540 2.3% 0.157.5 MB 8.7% 2.12
Jul 5 07:00:00 - 07:59:59 557 2.3% 0.153.9 MB 4.6% 1.11
Jul 5 08:00:00 - 08:59:59 601 2.5% 0.172.1 MB 2.4% 0.60
Jul 5 09:00:00 - 09:59:59 942 4.0% 0.264.5 MB 5.2% 1.27
Jul 5 10:00:00 - 10:59:59 995 4.2% 0.285.3 MB 6.2% 1.51
Jul 5 11:00:00 - 11:59:59 1064 4.5% 0.304.4 MB 5.2% 1.26
Jul 5 12:00:00 - 12:59:59 1017 4.3% 0.282.8 MB 3.3% 0.80
Jul 5 13:00:00 - 13:59:59 1137 4.8% 0.323.8 MB 4.4% 1.08
Jul 5 14:00:00 - 14:59:59 1117 4.7% 0.313.0 MB 3.5% 0.84
Jul 5 15:00:00 - 15:59:59 1096 4.6% 0.303.9 MB 4.5% 1.11
Jul 5 16:00:00 - 16:59:59 1202 5.1% 0.333.2 MB 3.7% 0.91
Jul 5 17:00:00 - 17:59:59 1310 5.5% 0.363.7 MB 4.3% 1.06
Jul 5 18:00:00 - 18:59:59 1330 5.6% 0.373.5 MB 4.1% 1.00
Jul 5 19:00:00 - 19:59:59 1537 6.5% 0.434.1 MB 4.8% 1.17
Jul 5 20:00:00 - 20:59:59 1561 6.6% 0.435.3 MB 6.1% 1.50
Jul 5 21:00:00 - 21:59:59 1493 6.3% 0.414.2 MB 4.9% 1.20
Jul 5 22:00:00 - 22:59:59 1362 5.7% 0.384.9 MB 5.8% 1.40
Jul 5 23:00:00 - 23:59:59 1269 5.3% 0.353.5 MB 4.0% 0.99
Jul 6 00:00:00 - 00:00:02 3 0.0% 1.507.0 KB 0.0% 3.49
TOTAL: 23:59:59 23771 100.0% 0.2885.8 MB 100.0% 1.02
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 6902 1035 0 1 0 0 0 0 5866
2feeder.eternal-september.org 3930 329 0 2 0 0 0 0 3599
3linuxd-out.news.weretis.net 2827 1003 0 1 0 0 0 0 1823
4news.albasani.net 1284 112 0 0 0 0 0 0 1172
5vc89.vc.panix.com 855 0 0 0 0 0 0 0 855
6news-out.mixmin.net 341 2 0 0 0 0 0 0 339
7news.netfront.net 101 0 0 0 0 1 0 0 100
8news.fcku.it 20 0 0 0 0 0 0 0 20
TOTAL: 8 16260 2481 0 4 0 1 0 013774

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.pkg-fallout 239
fa.linux.kernel 226
lada.talk 151
alt.politics.scorched-earth 126
alt.politics 126
mailing.freebsd.ports-bugs 121
ut.test 89
alt.survival 58
mailing.freebsd.python 56
alt.windows7.general 56
lada.auto 54
mpc.lists.nanog 49
mailing.freebsd.svn-ports-all 48
it-alt.sport.calcio.juventus 48
pld.cvs.commit 48
mailing.freebsd.svn-ports-head 47
lada.soft 39
fa.freebsd.cvs-all 35
mailing.freebsd.svn-src-all 35
mozilla.support.firefox 32
TOTAL: 201 2481

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9281
EMP (phn path) 2496
EMP (phl) 831
EMP (phn nph) 463
PFM bot misc 206
Too many newsgroups 136
Binary Image: misplaced jpg 107
Binary Payload 30
User-issued cancel 28
Binary Image: misplaced jpeg 22
Binary: non-binary distribution 10
HTML post 3
Binary: misplaced JPG 2
TOTAL: 13 13615

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feeder.eternal-september.org 83
linuxd-out.news.weretis.net 33
news.albasani.net 23
news.fcku.it 12
vc89.vc.panix.com 3
newsfeed.neva.ru 3
TOTAL: 6 157
TOTAL: 1 157

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 42605 2387 21271 27 2 284 5%23:59:52
2vc89.vc.panix.com 26234 2217 8674 12882 1 157 8%23:59:53
3etla.org 28030 398 23373 7 0 261 1%23:59:51
4nntp.pasdenom.info 33556 237 22122 1294 0 150 0%23:59:53
5neva.ru 24814 169 20858 375 0 17 0%23:59:54
6weretis.net 16890 168 15922 0 0 67 0%23:59:54
7news.fcku.it 25110 151 12208 10773 0 0 0%23:59:48
8news.killfile.org 39577 102 22128 1541 1 163 0%23:59:54
9news.albasani.net 24183 80 19636 1469 0 218 0%23:59:54
10news.stack.nl 34625 34 23599 36 0 565 0%23:59:52
11eternal-september 19243 3 18304 6 0 325 0%23:59:54
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 314867 5946 208095 28410 4 2207 1%264:08:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org19.8 MB25.5 KB19.8 MB0.2 KB/s50.0 KB23:59:51
2news.netfront.net19.6 MB685.3 KB20.3 MB0.2 KB/s8.6 KB23:59:52
3vc89.vc.panix.com7.6 MB43.6 MB51.2 MB0.6 KB/s3.5 KB23:59:53
4nntp.pasdenom.info1.1 MB2.0 MB3.0 MB0.0 KB/s2.0 KB23:59:53
5news.fcku.it799.3 KB51.7 MB52.5 MB0.6 KB/s4.9 KB23:59:48
6neva.ru659.7 KB906.1 KB1.5 MB0.0 KB/s2.9 KB23:59:54
7news.killfile.org400.1 KB7.8 MB8.2 MB0.1 KB/s5.1 KB23:59:54
8weretis.net283.0 KB0.0 KB283.0 KB0.0 KB/s1.7 KB23:59:54
9news.albasani.net223.2 KB7.2 MB7.4 MB0.1 KB/s4.9 KB23:59:54
10news.stack.nl111.3 KB85.5 KB196.8 KB0.0 KB/s2.8 KB23:59:52
11eternal-september5.1 KB16.4 KB21.4 KB0.0 KB/s2.4 KB23:59:54
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 1250.5 MB113.9 MB164.3 MB0.2 KB/s4.9 KB264:08:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-05-1178024217.dsl.bell.ca 70 221730.6 KB 62 0 000:19:52
2x55b5f9cf.dyn.telefonica.de 41 78150.6 KB 45 0 000:00:59
3x55b31cc1.dyn.telefonica.de 7 812.5 KB 5 0 000:00:09
TOTAL: 3 118 307893.8 KB 112 0 005:54:30

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 70 221730.6 KB 62 0 000:19:52
2*.dyn.telefonica.de 48 86163.1 KB 50 0 000:01:09
3*.ppp-bb.dion.ne.jp 4 00.0 KB 0 0 005:33:28
TOTAL: 3 122 307893.8 KB 112 0 005:54:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
kd124215166181.ppp-bb.dion.ne.jp 7.000 8.464 0.00005:33:28
mtrlpq2314w-lp140-05-1178024217.dsl.bell.ca 7.052 0.804 0.00000:19:52
x55b5f9cf.dyn.telefonica.de 3.152 0.252 0.00000:00:59
x55b31cc1.dyn.telefonica.de 0.504 0.040 0.00000:00:09
TOTAL: 4 17.708 9.560 0.00005:54:30

Curious NNRP server explorers [Top 20]:

SystemConn
kd124215166181.ppp-bb.dion.ne.jp 4
TOTAL: 1 4

NNRP client timeouts [Top 20]:

SystemConnPeer
kd124215166181.ppp-bb.dion.ne.jp 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1de 86 28.0%
2rec 75 24.4%
3uk 53 17.3%
4alt 39 12.7%
5soc 16 5.2%
6linux 16 5.2%
7misc 14 4.6%
8sci 7 2.3%
9fr 1 0.3%
TOTAL: 9 307100.0%

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

NewsgroupCount
1de.talk.jokes 56
2rec.food.cooking 49
3uk.railway 25
4uk.politics.misc 22
5alt.atheism 21
6alt.abortion 18
7linux.kernel 16
8de.comm.internet.telefonie 14
9misc.health.alternative 13
10rec.photo.digital 13
11soc.culture.usa 11
12rec.sport.tennis 8
13de.comp.security.misc 7
14sci.physics 7
15soc.retirement 5
16de.alt.rec.digitalfotografie 5
17rec.crafts.metalworking 4
18uk.d-i-y 4
19uk.legal 2
20fr.rec.moto 1
21de.comp.os.unix.networking.misc 1
22de.markt.comp.hardware.misc 1
23de.comm.technik.isdn 1
24rec.sport.pro-wrestling 1
25de.etc.finanz.boerse 1
26misc.survivalism 1
TOTAL: 26 307