Daily Usenet report for paganini.linuxd.org

Apr 18 00:00:01 -- Apr 19 00:00:01

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Apr 18 00:00:01 paganini nnrpd[18850]: feeder.eternal-september.org rejected Flushing log and syslog files
Apr 18 00:00:01 paganini nnrpd[18852]: feeder.eternal-september.org rejected Flushing log and syslog files
Apr 18 00:00:01 paganini nnrpd[18856]: feeder.eternal-september.org rejected Flushing log and syslog files
Apr 18 00:00:28 paganini nnrpd[19213]: feeder.eternal-september.org noperm ihave without permission
Apr 18 00:00:58 paganini nnrpd[19272]: feeder.eternal-september.org noperm ihave without permission
Apr 18 00:01:01 paganini nnrpd[19275]: feeder.eternal-september.org noperm ihave without permission
Apr 18 00:01:01 paganini nnrpd[19274]: feeder.eternal-september.org noperm ihave without permission
Apr 18 00:01:01 paganini nnrpd[19273]: feeder.eternal-september.org noperm ihave without permission
Apr 18 10:05:47 paganini overchan[22256]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 40237 67.5%9.1 MB 79.3%
innd 16867 28.3%2.0 MB 17.8%
innfeed 2402 4.0%321.0 KB 2.7%
nocem 104 0.2%13.4 KB 0.1%
nnrpd 36 0.1%4.2 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 59647 100.0%11.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 285280 58.7%
Negative hits 155434 32.0%
Do not exist 39812 8.2%
Cache misses 5664 1.2%
TOTAL: 4 486190 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.277 0.0%141 0.000 1.965 30.600
article cleanup00:00:00.242 0.0%40108 0.000 0.006 0.027
article logging00:00:00.359 0.0%40164 0.000 0.009 0.135
article parse00:00:01.120 0.0%121050 0.002 0.009 0.020
article write00:00:37.143 0.0%23729 0.090 1.565 7.677
artlog/artcncl00:00:00.000 0.0%129 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.253 0.0%541607 0.000 0.000 0.002
hisgrep/artcncl00:00:00.001 0.0%137 0.000 0.007 0.143
hishave/artcncl00:00:00.002 0.0%141 0.000 0.014 0.053
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:21.882 0.0%519664 0.013 0.042 0.461
history sync00:00:00.087 0.0%364 0.000 0.239 24.000
history write00:00:57.854 0.1%40102 0.033 1.443 6.249
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:55:15.726 99.6%529759 25.584 162.556 366.598
nntp read00:00:02.898 0.0%540334 0.003 0.005 0.009
overview write00:00:24.806 0.0%23729 0.037 1.045 4.576
perl filter00:02:20.246 0.2%40102 1.332 3.497 41.893
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.410 0.0%72865 0.017 0.033 0.067
TOTAL: 24:00:59.25424:00:05.306 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.057 0.0%25042 0.000 0.002 0.015
article prepare00:00:00.013 0.0%171712 0.000 0.000 0.002
article read00:00:03.173 0.0%23653 0.013 0.134 2.634
backlog stats00:00:00.251 0.0%552167 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.505 0.0%365312 0.003 0.007 0.013
data write00:00:04.273 0.0%344327 0.007 0.012 0.019
idle23:52:39.109100.0%552167 93.598 155.676 346.894
status file00:00:05.908 0.0%189 0.000 31.259 137.000
TOTAL: 23:53:06.89723:52:55.289100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:01.418 49.7%18 37.333 78.778 274.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%39 0.000 0.026 0.167
TOTAL: 00:00:02.85400:00:01.419 49.7%----

Control commands to INND:

CommandNumber
L 1
flush 1
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 167

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 2 54547 7386 45199 1962 13%48:24:04
2vc89.vc.panix.com 1 8361 4227 3293 841 50%24:08:42
3feeder.eternal-september.org 9 72295 4226 65300 2769 5%25:05:49
4news.albasani.net 2 30568 3600 24173 2795 11%23:40:00
5newsfeed.neva.ru 136 84516 2207 75301 7008 2%71:35:24
6etla.org 1 21912 1347 20565 0 6%22:34:33
7news.fcku.it 10 1679 424 1247 8 25%22:17:34
8news-out.mixmin.net 3 26056 289 24885 882 1%21:57:02
9news.netfront.net 1 35644 73 35559 12 0%22:35:19
10nntp.pasdenom.info 4 23402 55 23346 1 0%25:10:19
11localhost 25 0 0 0 0 0%00:00:00
12news.stack.nl 1 0 0 0 0 0%00:10:00
TOTAL: 12 195 358980 23834 318868 16278 6%307:38:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net21.3 MB36.4 KB18.5 MB39.9 MB 53%4.4 KB
2vc89.vc.panix.com18.2 MB84.4 KB6.2 MB24.5 MB 74%5.0 KB
3feeder.eternal-september.org11.5 MB36.3 KB28.9 MB40.5 MB 28%5.9 KB
4news.albasani.net9.5 MB0.0 KB86.7 MB96.3 MB 9%15.4 KB
5newsfeed.neva.ru5.7 MB19.5 KB53.8 MB59.6 MB 9%6.6 KB
6etla.org4.9 MB0.0 KB0.0 KB4.9 MB100%3.7 KB
7news-out.mixmin.net894.9 KB0.0 KB1.6 MB2.5 MB 35%2.1 KB
8news.fcku.it850.0 KB0.0 KB13.3 KB863.3 KB 98%2.0 KB
9news.netfront.net201.4 KB0.0 KB549.3 KB750.7 KB 26%8.8 KB
10nntp.pasdenom.info117.1 KB0.0 KB0.6 KB117.7 KB 99%2.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: 1273.2 MB176.6 KB196.4 MB269.8 MB 27%6.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 18 00:00:01 - 00:59:59 1023 4.3% 0.283.1 MB 4.2% 0.88
Apr 18 01:00:00 - 01:59:59 758 3.2% 0.213.0 MB 4.1% 0.86
Apr 18 02:00:00 - 02:59:59 713 3.0% 0.202.1 MB 2.9% 0.60
Apr 18 03:00:00 - 03:59:59 592 2.5% 0.162.2 MB 3.0% 0.63
Apr 18 04:00:00 - 04:59:59 634 2.7% 0.182.2 MB 3.0% 0.63
Apr 18 05:00:00 - 05:59:59 652 2.7% 0.181.9 MB 2.6% 0.54
Apr 18 06:00:00 - 06:59:59 497 2.1% 0.141.8 MB 2.4% 0.50
Apr 18 07:00:00 - 07:59:59 645 2.7% 0.182.6 MB 3.5% 0.73
Apr 18 08:00:00 - 08:59:59 804 3.4% 0.222.9 MB 3.9% 0.82
Apr 18 09:00:00 - 09:59:59 837 3.5% 0.232.0 MB 2.7% 0.56
Apr 18 10:00:00 - 10:59:59 987 4.2% 0.272.4 MB 3.3% 0.68
Apr 18 11:00:00 - 11:59:59 1164 4.9% 0.324.0 MB 5.4% 1.13
Apr 18 12:00:00 - 12:59:59 1143 4.8% 0.322.9 MB 4.0% 0.84
Apr 18 13:00:00 - 13:59:59 1256 5.3% 0.354.0 MB 5.4% 1.13
Apr 18 14:00:00 - 14:59:59 1109 4.7% 0.312.9 MB 3.9% 0.82
Apr 18 15:00:00 - 15:59:59 1182 5.0% 0.333.2 MB 4.3% 0.90
Apr 18 16:00:00 - 16:59:59 1163 4.9% 0.323.6 MB 5.0% 1.04
Apr 18 17:00:00 - 17:59:59 1321 5.6% 0.373.8 MB 5.2% 1.09
Apr 18 18:00:00 - 18:59:59 1358 5.7% 0.383.9 MB 5.3% 1.11
Apr 18 19:00:00 - 19:59:59 1356 5.7% 0.384.3 MB 5.9% 1.23
Apr 18 20:00:00 - 20:59:59 1280 5.4% 0.364.8 MB 6.6% 1.37
Apr 18 21:00:00 - 21:59:59 1112 4.7% 0.313.1 MB 4.2% 0.87
Apr 18 22:00:00 - 22:59:59 1128 4.8% 0.313.8 MB 5.2% 1.09
Apr 18 23:00:00 - 00:00:01 1002 4.2% 0.282.7 MB 3.7% 0.76
TOTAL: 24:00:00 23716 100.0% 0.2773.1 MB 100.0% 0.87
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7043 1130 0 1 0 0 0 0 5912
2news.albasani.net 2829 129 0 0 0 0 0 0 2700
3feeder.eternal-september.org 2810 220 0 1 0 0 0 0 2589
4linuxd-out.news.weretis.net 1889 909 0 1 0 0 0 0 979
5news-out.mixmin.net 975 12 0 0 0 0 0 0 963
6vc89.vc.panix.com 820 3 0 3 0 0 0 0 814
7news.netfront.net 15 8 0 0 0 0 0 0 7
8news.fcku.it 6 0 0 0 0 0 0 0 6
9etla.org 3 0 0 0 0 0 0 0 3
10nntp.pasdenom.info 2 2 0 0 0 0 0 0 0
TOTAL: 10 16392 2413 0 6 0 0 0 013973

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 248
ut.test 205
alt.politics 122
alt.windows7.general 89
mailing.freebsd.pkg-fallout 82
lada.talk 77
mailing.freebsd.ports-bugs 73
pld.cvs.commit 71
mailing.freebsd.svn-ports-all 70
it-alt.sport.calcio.juventus 68
alt.survival 67
mailing.freebsd.svn-ports-head 66
lada.auto 49
mailing.freebsd.svn-src-all 47
fa.freebsd.cvs-all 47
alt.politics.scorched-earth 46
mailing.freebsd.svn-src-head 40
gmane.linux.alsa.devel 36
mailing.unix.dovecot 25
24hoursupport.helpdesk 24
TOTAL: 218 2413

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9748
EMP (phn path) 2322
EMP (phl) 1122
EMP (phn nph) 343
Too many newsgroups 206
PFM bot misc 109
Binary Image: misplaced jpg 17
Binary: non-binary distribution 16
User-issued cancel 14
Too many newsgroups (meow) 7
Binary Payload 7
HTML post 6
TOTAL: 12 13917

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 27248 2479 9752 11512 0 24 9%24:01:59
2news.netfront.net 43133 1458 22108 48 0 85 3%23:58:11
3etla.org 27859 453 23228 3 0 64 1%23:57:46
4news.fcku.it 23458 305 1155 21898 0 54 1%23:57:50
5news.killfile.org 38811 194 21746 1809 0 28 0%24:01:45
6nntp.pasdenom.info 29992 139 22550 940 0 988 0%24:00:03
7weretis.net 16904 116 15987 0 0 5 0%23:59:57
8neva.ru 25556 114 21014 299 0 0 0%24:00:01
9news.albasani.net 22880 63 18715 1237 0 49 0%23:57:04
10news.stack.nl 29784 15 23590 28 0 135 0%23:59:51
11eternal-september 20490 5 19489 3 0 2 0%24:07:09
TOTAL: 11 306115 5341 199334 37777 0 1434 1%264:01:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org8.8 MB4.8 KB8.8 MB0.1 KB/s19.8 KB23:57:46
2news.netfront.net6.8 MB1.7 MB8.4 MB0.1 KB/s5.7 KB23:58:11
3vc89.vc.panix.com6.6 MB31.7 MB38.4 MB0.5 KB/s2.8 KB24:01:59
4news.fcku.it1.5 MB68.8 MB70.3 MB0.8 KB/s3.2 KB23:57:50
5news.killfile.org544.1 KB6.0 MB6.5 MB0.1 KB/s3.3 KB24:01:45
6nntp.pasdenom.info410.5 KB1.6 MB2.0 MB0.0 KB/s1.9 KB24:00:03
7neva.ru361.3 KB701.6 KB1.0 MB0.0 KB/s2.6 KB24:00:01
8weretis.net197.7 KB0.0 KB197.7 KB0.0 KB/s1.7 KB23:59:57
9news.albasani.net148.3 KB6.8 MB6.9 MB0.1 KB/s5.5 KB23:57:04
10news.stack.nl82.0 KB48.8 KB130.8 KB0.0 KB/s3.0 KB23:59:51
11eternal-september14.2 KB4.1 KB18.4 KB0.0 KB/s2.3 KB24:07:09
TOTAL: 1125.4 MB117.3 MB142.8 MB0.2 KB/s3.4 KB264:01:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1feeder.eternal-september.org 8 00.0 KB 0 0 000:00:01
2eac1aag159.osk.mesh.ad.jp 1 00.0 KB 0 0 000:00:01
TOTAL: 2 9 00.0 KB 0 0 000:00:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.eternal-september.org 8 00.0 KB 0 0 000:00:01
2*.osk.mesh.ad.jp 1 00.0 KB 0 0 000:00:01
TOTAL: 2 9 00.0 KB 0 0 000:00:02

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
eac1aag159.osk.mesh.ad.jp 0.052 0.004 0.00000:00:01
feeder.eternal-september.org 0.460 0.028 0.00000:00:01
TOTAL: 2 0.512 0.032 0.00000:00:02