Daily Usenet report for paganini.linuxd.org

Apr 9 00:00:02 -- Apr 10 00:00:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Apr 9 00:00:25 paganini nnrpd[5972]: ceres.etla.org noperm ihave without permission
Apr 9 00:00:56 paganini nnrpd[6036]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
Apr 9 09:29:53 paganini overchan[839]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 47493 71.5%10.2 MB 82.1%
innd 16208 24.4%1.9 MB 15.2%
innfeed 2017 3.0%271.5 KB 2.1%
nnrpd 594 0.9%66.9 KB 0.5%
nocem 88 0.1%10.8 KB 0.1%
overchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 66401 100.0%12.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 313809 56.4%
Negative hits 193940 34.8%
Do not exist 46595 8.4%
Cache misses 2223 0.4%
TOTAL: 4 556567 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.429 0.0%220 0.000 6.495 74.000
article cleanup00:00:00.312 0.0%46707 0.000 0.007 0.023
article logging00:00:01.627 0.0%46863 0.000 0.035 1.359
article parse00:00:01.219 0.0%135424 0.001 0.009 0.031
article write00:01:04.408 0.1%28812 0.090 2.235 12.760
artlog/artcncl00:00:00.001 0.0%209 0.000 0.005 0.250
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.255 0.0%601634 0.000 0.000 0.002
hisgrep/artcncl00:00:00.034 0.0%209 0.000 0.163 2.818
hishave/artcncl00:00:00.003 0.0%220 0.000 0.014 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:35.984 0.0%560462 0.014 0.064 0.527
history sync00:00:00.246 0.0%297 0.000 0.828 93.000
history write00:01:26.140 0.1%46693 0.045 1.845 7.212
hiswrite/artcncl00:00:00.002 0.0%11 0.000 0.182 1.000
idle23:42:27.114 99.5%589473 24.916 144.785 478.952
nntp read00:00:03.233 0.0%602912 0.002 0.005 0.009
overview write00:00:43.664 0.1%28812 0.024 1.515 5.755
perl filter00:02:39.698 0.2%46693 1.153 3.420 40.132
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:09.495 0.0%117532 0.043 0.081 0.152
TOTAL: 23:50:18.22423:49:14.864 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.081 0.0%33317 0.000 0.002 0.015
article prepare00:00:00.011 0.0%92136 0.000 0.000 0.003
article read00:00:22.858 0.0%20354 0.000 1.123 19.027
backlog stats00:00:00.264 0.0%529414 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.578 0.0%347244 0.003 0.007 0.014
data write00:00:03.986 0.0%321951 0.005 0.012 0.022
idle24:02:19.655 99.9%529414 81.449 163.463 411.586
status file00:00:09.873 0.0%180 0.000 54.850 617.000
TOTAL: 24:03:12.60124:02:59.306100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:25:29.064 99.2%526 37.667 2906.966262938.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.009 0.0%1181 0.000 0.008 0.222
TOTAL: 00:25:40.85200:25:29.073 99.2%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 68057 9521 55246 3290 13%48:25:20
2feeder.eternal-september.org 5 43107 5712 34529 2866 13%24:30:47
3vc89.vc.panix.com 1 9120 4725 3873 522 51%24:24:28
4newsfeed.neva.ru 143 100386 3116 88438 8832 3%71:27:33
5news.albasani.net 5 34540 2722 30278 1540 7%23:48:17
6news-out.mixmin.net 5 33641 1946 30821 874 5%24:01:44
7etla.org 3 32671 1201 31470 0 3%23:49:06
8news.netfront.net 1 41914 89 41820 5 0%22:35:19
9localhost 25 0 0 0 0 0%00:00:00
10news.stack.nl 3 0 0 0 0 0%00:22:04
TOTAL: 10 196 363436 29032 316475 17929 7%263:24:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net28.2 MB3.0 KB27.5 MB55.7 MB 50%4.5 KB
2vc89.vc.panix.com17.0 MB26.1 KB3.2 MB20.3 MB 83%4.0 KB
3feeder.eternal-september.org15.5 MB0.0 KB30.7 MB46.2 MB 33%5.5 KB
4news.albasani.net8.3 MB2.9 KB85.5 MB93.7 MB 8%22.5 KB
5newsfeed.neva.ru8.0 MB257.4 KB71.5 MB79.8 MB 10%6.8 KB
6news-out.mixmin.net4.8 MB0.0 KB1.5 MB6.4 MB 75%2.3 KB
7etla.org4.3 MB0.0 KB0.0 KB4.3 MB100%3.7 KB
8news.netfront.net196.6 KB0.0 KB315.3 KB512.0 KB 38%5.4 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1086.4 MB289.4 KB220.3 MB306.9 MB 28%6.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 9 00:00:02 - 00:59:59 1053 3.6% 0.292.8 MB 3.2% 0.79
Apr 9 01:00:00 - 01:59:59 819 2.8% 0.232.0 MB 2.3% 0.57
Apr 9 02:00:00 - 02:59:59 785 2.7% 0.222.5 MB 2.8% 0.70
Apr 9 03:00:00 - 03:59:59 610 2.1% 0.171.8 MB 2.1% 0.51
Apr 9 04:00:00 - 04:59:59 621 2.1% 0.172.1 MB 2.4% 0.60
Apr 9 05:00:00 - 05:59:59 544 1.9% 0.151.5 MB 1.7% 0.42
Apr 9 06:00:00 - 06:59:59 646 2.2% 0.182.2 MB 2.5% 0.62
Apr 9 07:00:00 - 07:59:59 740 2.6% 0.212.2 MB 2.6% 0.63
Apr 9 08:00:00 - 08:59:59 920 3.2% 0.262.7 MB 3.1% 0.76
Apr 9 09:00:00 - 09:59:59 1277 4.4% 0.353.0 MB 3.5% 0.86
Apr 9 10:00:00 - 10:59:59 1379 4.8% 0.383.7 MB 4.3% 1.05
Apr 9 11:00:00 - 11:59:59 1390 4.8% 0.394.2 MB 4.8% 1.19
Apr 9 12:00:00 - 12:59:59 1478 5.1% 0.415.7 MB 6.6% 1.63
Apr 9 13:00:00 - 13:59:59 1330 4.6% 0.373.9 MB 4.5% 1.11
Apr 9 14:00:00 - 14:59:59 1487 5.1% 0.413.9 MB 4.6% 1.12
Apr 9 15:00:00 - 15:59:59 1578 5.4% 0.444.4 MB 5.0% 1.24
Apr 9 16:00:00 - 16:59:59 1604 5.5% 0.454.2 MB 4.9% 1.20
Apr 9 17:00:00 - 17:59:59 1503 5.2% 0.424.4 MB 5.1% 1.25
Apr 9 18:00:00 - 18:59:59 1715 5.9% 0.484.9 MB 5.6% 1.39
Apr 9 19:00:00 - 19:59:59 1734 6.0% 0.486.4 MB 7.4% 1.82
Apr 9 20:00:00 - 20:59:59 1588 5.5% 0.445.5 MB 6.4% 1.58
Apr 9 21:00:00 - 21:59:59 1452 5.0% 0.404.8 MB 5.6% 1.38
Apr 9 22:00:00 - 22:59:59 1364 4.7% 0.383.6 MB 4.2% 1.04
Apr 9 23:00:00 - 00:00:02 1360 4.7% 0.383.9 MB 4.5% 1.10
TOTAL: 24:00:00 28977 100.0% 0.3486.3 MB 100.0% 1.02
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 8978 2355 0 11 0 0 0 0 6612
2linuxd-out.news.weretis.net 3386 1762 0 1 0 0 0 0 1623
3feeder.eternal-september.org 2936 333 0 0 0 0 0 0 2603
4news.albasani.net 1575 142 0 1 0 0 0 0 1432
5news-out.mixmin.net 909 23 0 0 0 0 0 0 886
6vc89.vc.panix.com 515 3 0 1 0 0 0 0 511
7news.netfront.net 6 1 0 0 0 0 0 0 5
8etla.org 2 0 0 0 0 0 0 0 2
TOTAL: 8 18307 4619 0 14 0 0 0 013674

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 984
mailing.freebsd.pkg-fallout 262
ut.test 189
lada.auto 149
alt.politics 148
alt.windows7.general 125
alt.politics.scorched-earth 104
lada.talk 103
mailing.freebsd.svn-ports-all 101
mailing.freebsd.svn-ports-head 95
it-alt.sport.calcio.juventus 95
mailing.freebsd.svn-src-all 85
fa.freebsd.cvs-all 85
mailing.freebsd.ports-bugs 70
mpc.lists.nanog 61
mailing.unix.samba 59
gmane.linux.alsa.devel 56
mailing.freebsd.svn-src-head 52
mailing.openbsd.ports-changes 51
mailing.database.pgsql-general 48
TOTAL: 278 4619

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9822
EMP (phn path) 2313
EMP (phl) 960
EMP (phn nph) 232
Too many newsgroups 75
User-issued cancel 42
Binary Payload 29
Binary Image: misplaced jpg 20
Binary: non-binary distribution 17
HTML post 7
HTML Multipart without Text/Plain. 1
TOTAL: 11 13518

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 33380 2196 12347 14431 3 276 6%24:00:00
2news.netfront.net 51633 908 27937 64 0 689 1%24:01:03
3etla.org 34844 395 28528 5 0 693 1%23:57:15
4news.killfile.org 46761 208 25822 2992 1 294 0%24:01:42
5neva.ru 29982 28 25519 67 0 63 0%24:00:01
6news.stack.nl 36192 17 28889 40 0 2166 0%24:01:28
7news.albasani.net 30267 15 24499 1608 0 82 0%23:56:31
8weretis.net 19862 6 18930 0 0 1 0%24:00:20
9eternal-september 24090 4 23010 1 0 3 0%23:52:03
TOTAL: 9 307011 3777 215481 19208 4 4267 1%215:50:23
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org10.2 MB56.5 KB10.2 MB0.1 KB/s26.2 KB23:57:15
2vc89.vc.panix.com6.3 MB39.9 MB46.2 MB0.5 KB/s2.8 KB24:00:00
3news.netfront.net5.3 MB3.3 MB8.7 MB0.1 KB/s9.1 KB24:01:03
4news.killfile.org614.4 KB9.8 MB10.4 MB0.1 KB/s3.3 KB24:01:42
5news.stack.nl72.7 KB128.3 KB201.0 KB0.0 KB/s3.5 KB24:01:28
6neva.ru38.7 KB297.2 KB335.9 KB0.0 KB/s3.5 KB24:00:01
7news.albasani.net35.7 KB7.3 MB7.4 MB0.1 KB/s4.6 KB23:56:31
8weretis.net17.0 KB0.0 KB17.0 KB0.0 KB/s2.8 KB24:00:20
9eternal-september15.8 KB2.5 KB18.3 KB0.0 KB/s3.7 KB23:52:03
TOTAL: 922.6 MB60.9 MB83.5 MB0.1 KB/s3.7 KB215:50:23
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
174.205.216.160 130 00.0 KB 0 0 000:25:39
22001:ba8:1f1:f1ef::2 1 00.0 KB 0 0 000:00:00
3ceres.etla.org 1 00.0 KB 0 0 000:00:00
TOTAL: 3 132 00.0 KB 0 0 000:25:40

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
3unresolved 130 00.0 KB 0 0 000:25:39
TOTAL: 3 132 00.0 KB 0 0 000:25:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
74.205.216.160 6.364 0.592 0.00000:25:39
ceres.etla.org 0.072 0.012 0.00000:00:00
2001:ba8:1f1:f1ef::2 0.056 0.012 0.00000:00:00
TOTAL: 3 6.492 0.616 0.00000:25:40

NNRP client timeouts [Top 20]:

SystemConnPeer
74.205.216.160 2 0
TOTAL: 1 2 0