Daily Usenet report for paganini.linuxd.org

Feb 2 00:00:01 -- Feb 3 00:00:07

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Feb 2 00:00:13 paganini nnrpd[31488]: ceres.etla.org noperm ihave without permission
Feb 2 00:00:44 paganini nnrpd[31497]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
Feb 2 15:23:37 paganini overchan[30592]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)
Feb 2 18:54:11 paganini pgpverify[19405]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 54808 70.5%10.9 MB 80.9%
innd 20943 26.9%2.3 MB 17.0%
innfeed 1859 2.4%278.6 KB 2.0%
nocem 123 0.2%14.4 KB 0.1%
nnrpd 9 0.0%1.0 KB 0.0%
controlchan 5 0.0%0.7 KB 0.0%
overchan 2 0.0%0.1 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 77750 100.0%13.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 314337 53.9%
Negative hits 210137 36.1%
Do not exist 54143 9.3%
Cache misses 4160 0.7%
TOTAL: 4 582777 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.605 0.0%485 0.000 5.371 34.000
article cleanup00:00:00.309 0.0%54223 0.000 0.006 0.021
article logging00:00:01.122 0.0%54307 0.000 0.021 1.546
article parse00:00:01.265 0.0%139088 0.000 0.009 0.027
article write00:01:11.814 0.1%32041 0.069 2.241 11.242
artlog/artcncl00:00:00.005 0.0%475 0.000 0.011 0.100
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.231 0.0%595044 0.000 0.000 0.002
hisgrep/artcncl00:00:00.106 0.0%483 0.000 0.219 2.818
hishave/artcncl00:00:00.278 0.0%485 0.000 0.573 0.905
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:34.199 0.0%585878 0.016 0.058 0.431
history sync00:00:00.327 0.0%356 0.000 0.919 94.000
history write00:01:53.784 0.1%54214 0.063 2.099 9.783
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:52:17.860 99.4%577730 67.256 148.751 524.527
nntp read00:00:03.152 0.0%595152 0.002 0.005 0.009
overview write00:00:49.384 0.1%32041 0.029 1.541 4.688
perl filter00:02:32.147 0.2%54214 1.045 2.806 7.516
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:08.337 0.0%128340 0.017 0.065 0.102
TOTAL: 24:00:48.14523:59:36.925 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.087 0.0%33924 0.000 0.003 0.012
article prepare00:00:00.013 0.0%94280 0.000 0.000 0.003
article read00:00:18.610 0.0%22861 0.000 0.814 15.804
backlog stats00:00:00.190 0.0%516685 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.566 0.0%344724 0.003 0.007 0.014
data write00:00:04.150 0.0%316836 0.006 0.013 0.025
idle23:52:07.609 99.9%516685 88.885 166.306 458.238
status file00:00:06.885 0.0%178 0.000 38.680 164.000
TOTAL: 23:52:56.54923:52:40.110100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.246 53.8%6 41.000 41.000 41.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%12 0.000 0.000 0.000
TOTAL: 00:00:00.45700:00:00.246 53.8%----

Control commands to INND:

CommandNumber
L 1
flush 1
flushlogs 2
go 2
logmode 2
mode 148
name 2
newgroup 1
pause 2
paused 2
reload 2
reserve 2
TOTAL: 12 167

Newsgroups created:

GroupMode
alt.binaries.prophecyy
TOTAL1

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
153fishare@gmail.com100011
moderator@dana.de000100
TOTAL100111

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 2 71473 11111 56695 3667 15%48:31:20
2feeder.eternal-september.org 8 49854 5184 39304 5366 10%24:54:45
3etla.org 6 37088 4369 32713 6 11%24:07:49
4vc89.vc.panix.com 5 8628 4307 3984 337 49%24:17:40
5news-out.mixmin.net 8 38789 3574 33664 1551 9%24:27:38
6newsfeed.neva.ru 142 113712 3325 99378 11009 2%70:59:07
7news.netfront.net 3 33962 41 33900 21 0%18:35:20
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 199 353506 31911 299638 21957 9%235:53:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net44.4 MB7.3 KB13.4 MB57.9 MB 76%4.0 KB
2etla.org19.4 MB0.0 KB50.8 KB19.5 MB 99%4.6 KB
3feeder.eternal-september.org14.9 MB4.0 KB61.4 MB76.3 MB 19%7.4 KB
4vc89.vc.panix.com14.8 MB80.3 KB3.7 MB18.5 MB 79%4.1 KB
5news-out.mixmin.net10.2 MB1.8 KB4.9 MB15.1 MB 67%3.0 KB
6newsfeed.neva.ru9.2 MB1.1 KB84.2 MB93.4 MB 9%6.7 KB
7news.netfront.net1.8 MB0.0 KB1.6 MB3.4 MB 52%56.7 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 8114.7 MB94.4 KB169.3 MB284.1 MB 40%5.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 2 00:00:01 - 00:59:59 979 3.1% 0.272.8 MB 2.4% 0.78
Feb 2 01:00:00 - 01:59:59 785 2.4% 0.223.9 MB 3.4% 1.11
Feb 2 02:00:00 - 02:59:59 686 2.1% 0.195.1 MB 4.4% 1.45
Feb 2 03:00:00 - 03:59:59 578 1.8% 0.161.9 MB 1.6% 0.54
Feb 2 04:00:00 - 04:59:59 857 2.7% 0.243.7 MB 3.2% 1.06
Feb 2 05:00:00 - 05:59:59 718 2.2% 0.202.9 MB 2.6% 0.84
Feb 2 06:00:00 - 06:59:59 987 3.1% 0.273.7 MB 3.2% 1.06
Feb 2 07:00:00 - 07:59:59 662 2.1% 0.182.5 MB 2.1% 0.70
Feb 2 08:00:00 - 08:59:59 788 2.5% 0.222.6 MB 2.2% 0.73
Feb 2 09:00:00 - 09:59:59 1103 3.4% 0.313.3 MB 2.9% 0.95
Feb 2 10:00:00 - 10:59:59 1235 3.9% 0.343.0 MB 2.6% 0.85
Feb 2 11:00:00 - 11:59:59 1396 4.4% 0.393.9 MB 3.4% 1.12
Feb 2 12:00:00 - 12:59:59 1284 4.0% 0.363.3 MB 2.8% 0.92
Feb 2 13:00:00 - 13:59:59 1456 4.5% 0.404.0 MB 3.4% 1.13
Feb 2 14:00:00 - 14:59:59 1609 5.0% 0.455.1 MB 4.4% 1.46
Feb 2 15:00:00 - 15:59:59 2036 6.4% 0.577.0 MB 6.1% 2.00
Feb 2 16:00:00 - 16:59:59 2060 6.4% 0.577.9 MB 6.9% 2.26
Feb 2 17:00:00 - 17:59:59 2000 6.2% 0.5610.2 MB 8.8% 2.90
Feb 2 18:00:00 - 18:59:59 1989 6.2% 0.556.7 MB 5.8% 1.91
Feb 2 19:00:00 - 19:59:59 1957 6.1% 0.546.4 MB 5.5% 1.82
Feb 2 20:00:00 - 20:59:59 1867 5.8% 0.528.1 MB 7.0% 2.32
Feb 2 21:00:00 - 21:59:59 1715 5.4% 0.485.6 MB 4.9% 1.61
Feb 2 22:00:00 - 22:59:59 1686 5.3% 0.476.1 MB 5.3% 1.74
Feb 2 23:00:00 - 23:59:59 1600 5.0% 0.445.7 MB 4.9% 1.61
Feb 3 00:00:00 - 00:00:07 21 0.1% 3.0068.7 KB 0.1% 9.82
TOTAL: 24:00:06 32054 100.0% 0.37115.6 MB 100.0% 1.37
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 11106 2123 0 1 0 0 0 0 8982
2feeder.eternal-september.org 5404 240 0 2 0 0 0 0 5162
3linuxd-out.news.weretis.net 3746 1469 0 3 0 0 0 0 2274
4news-out.mixmin.net 1610 20 0 1 0 0 0 0 1589
5vc89.vc.panix.com 361 3 0 2 0 0 0 0 356
6news.netfront.net 32 0 0 0 0 0 0 0 32
7etla.org 19 0 0 0 0 0 0 0 19
TOTAL: 7 22278 3855 0 9 0 0 0 018414

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 832
lada.talk 159
ut.test 155
alt.politics 121
it-alt.sport.calcio.juventus 107
mailing.freebsd.svn-src-all 88
fa.freebsd.cvs-all 87
lada.auto 73
mailing.freebsd.ports-bugs 64
mailing.freebsd.svn-ports-all 62
gmane.linux.alsa.devel 61
mailing.freebsd.svn-ports-head 60
alt.survival 57
mailing.freebsd.svn-src-head 57
alt.windows7.general 50
fa.freebsd.bugs 47
mailing.freebsd.bugs 47
pld.cvs.commit 46
yahoo.tekscopes 44
gmane.comp.gis.openstreetmap.tagging 41
TOTAL: 308 3855

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13725
EMP (phn path) 3397
EMP (phl) 700
EMP (phn nph) 145
PFM bot misc 129
Too many newsgroups 85
Binary Image: misplaced jpg 65
User-issued cancel 36
Binary: non-binary distribution 15
Binary Payload 14
hierarchy violation - crosspost outside cl 10
HTML post 4
Too many newsgroups (low_xpost) 2
Too many newsgroups (meow) 2
TOTAL: 14 18329

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 38540 993 13482 17492 0 351 2%23:56:53
2etla.org 38303 376 31574 1 0 361 0%23:55:52
3news.netfront.net 55127 331 31588 45 0 617 0%23:59:40
4news.killfile.org 52721 142 27630 4310 0 384 0%24:02:41
5news.stack.nl 34466 22 31741 34 0 245 0%23:57:36
6neva.ru 32365 9 28411 10 0 149 0%23:59:26
7eternal-september 28149 8 26680 7 0 66 0%24:02:27
8weretis.net 21909 4 20980 0 0 10 0%24:01:12
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 9 301580 1885 212086 21899 0 2183 0%192:05:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org14.9 MB4.9 KB14.9 MB0.2 KB/s40.6 KB23:55:52
2news.netfront.net9.0 MB952.5 KB10.0 MB0.1 KB/s27.1 KB23:59:40
3vc89.vc.panix.com3.5 MB63.6 MB67.1 MB0.8 KB/s3.7 KB23:56:53
4news.killfile.org526.8 KB17.9 MB18.4 MB0.2 KB/s4.2 KB24:02:41
5news.stack.nl112.8 KB116.6 KB229.4 KB0.0 KB/s4.1 KB23:57:36
6neva.ru34.7 KB186.0 KB220.7 KB0.0 KB/s11.6 KB23:59:26
7eternal-september30.6 KB10.4 KB41.0 KB0.0 KB/s2.7 KB24:02:27
8weretis.net8.3 KB0.0 KB8.3 KB0.0 KB/s2.1 KB24:01:12
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 928.1 MB82.7 MB110.8 MB0.2 KB/s4.8 KB192:05:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12001:ba8:1f1:f1ef::2 1 00.0 KB 0 0 000:00:00
2ceres.etla.org 1 00.0 KB 0 0 000:00:00
TOTAL: 2 2 00.0 KB 0 0 000:00:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 00.0 KB 0 0 000:00:00
2*.etla.org 1 00.0 KB 0 0 000:00:00
TOTAL: 2 2 00.0 KB 0 0 000:00:00

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ceres.etla.org 0.072 0.008 0.00000:00:00
2001:ba8:1f1:f1ef::2 0.064 0.000 0.00000:00:00
TOTAL: 2 0.136 0.008 0.00000:00:00