Daily Usenet report for paganini.linuxd.org

Jun 21 00:00:02 -- Jun 22 00:00:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Jun 21 14:06:00 paganini overchan[16216]: input line too long, skipping
Jun 21 14:06:35 paganini overchan[16216]: input line too long, skipping
Jun 21 14:06:48 paganini overchan[16216]: input line too long, skipping
Jun 21 14:06:52 paganini overchan[16216]: input line too long, skipping
Jun 21 14:08:37 paganini overchan[16216]: input line too long, skipping
Jun 21 14:10:01 paganini overchan[16216]: input line too long, skipping
Jun 21 14:12:26 paganini overchan[16216]: input line too long, skipping
Jun 21 14:12:32 paganini overchan[16216]: input line too long, skipping
Jun 21 14:13:17 paganini overchan[16216]: input line too long, skipping
Jun 21 14:18:23 paganini overchan[16216]: input line too long, skipping
Jun 21 14:21:09 paganini overchan[16216]: input line too long, skipping
Jun 21 21:56:54 paganini overchan[16216]: input line too long, skipping
Jun 22 00:00:02 paganini overchan[29991]: 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
innfeed 98303 51.9%12.4 MB 45.0%
nnrpd 48337 25.5%5.5 MB 20.2%
inn 32236 17.0%8.0 MB 29.1%
innd 10278 5.4%1.5 MB 5.6%
nocem 62 0.0%8.9 KB 0.0%
overchan 14 0.0%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 189231 100.0%27.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 113230 54.9%
Negative hits 60967 29.6%
Do not exist 31522 15.3%
Cache misses 482 0.2%
TOTAL: 4 206201 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.395 0.0%176 0.000 2.244 28.000
article cleanup00:00:00.194 0.0%31632 0.000 0.006 0.024
article logging00:00:00.253 0.0%32075 0.000 0.008 0.041
article parse00:00:00.665 0.0%48719 0.000 0.014 0.065
article write00:00:55.637 0.1%22397 0.096 2.484 22.865
artlog/artcncl00:00:00.000 0.0%83 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.112 0.0%211299 0.000 0.001 0.005
hisgrep/artcncl00:00:00.001 0.0%175 0.000 0.006 0.026
hishave/artcncl00:00:00.002 0.0%176 0.000 0.011 0.100
hissync/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.435 0.0%206942 0.012 0.060 1.596
history sync00:00:00.117 0.0%405 0.000 0.289 16.667
history write00:00:30.227 0.0%31631 0.000 0.956 6.013
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:12.694 99.7%208422 21.959 413.741 1813.532
nntp read00:00:01.555 0.0%214280 0.000 0.007 0.015
overview write00:00:23.457 0.0%22397 0.000 1.047 3.467
perl filter00:01:02.825 0.1%31631 0.921 1.986 7.333
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.236 0.0%67371 0.000 0.018 0.046
TOTAL: 24:01:07.41224:00:21.805 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.109 0.0%41956 0.000 0.003 0.012
article prepare00:00:00.004 0.0%30876 0.000 0.000 0.028
article read00:00:03.889 0.0%6293 0.000 0.618 47.583
backlog stats00:00:00.204 0.0%328998 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.470 0.0%182428 0.001 0.008 0.023
data write00:00:02.795 0.0%160543 0.008 0.017 0.032
idle23:43:11.883 99.3%328998 35.648 259.551 545.198
status file00:09:52.638 0.7%41065 8.667 14.432 37.886
TOTAL: 23:53:36.51023:53:12.992100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:42:23.371 99.4%48815 37.627 52.102 196.741
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.864 0.0%98946 0.003 0.009 0.025
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 00:42:38.37600:42:24.235 99.4%----

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 9 48306 19111 27678 1517 39%48:42:01
2newsfeed.neva.ru 138 67952 2856 57432 7664 4%71:39:55
3news.fcku.it 3 6663 414 6201 48 6%22:10:14
4nntp.pasdenom.info 4 19547 87 19441 19 0%23:22:54
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 179 142468 22468 110752 9248 15%165:55:04
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net72.4 MB13.6 KB6.0 MB78.5 MB 92%3.9 KB
2newsfeed.neva.ru7.9 MB0.0 KB30.4 MB38.3 MB 20%3.7 KB
3news.fcku.it912.6 KB0.0 KB752.1 KB1.6 MB 54%3.6 KB
4nntp.pasdenom.info189.8 KB0.0 KB164.0 KB353.8 KB 53%3.3 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 581.4 MB13.6 KB37.3 MB118.7 MB 68%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 21 00:00:02 - 00:59:59 591 2.6% 0.161.9 MB 2.3% 0.54
Jun 21 01:00:00 - 01:59:59 472 2.1% 0.131.5 MB 1.8% 0.43
Jun 21 02:00:00 - 02:59:59 362 1.6% 0.101.1 MB 1.3% 0.31
Jun 21 03:00:00 - 03:59:59 350 1.6% 0.101.1 MB 1.3% 0.30
Jun 21 04:00:00 - 04:59:59 467 2.1% 0.131.5 MB 1.8% 0.42
Jun 21 05:00:00 - 05:59:59 305 1.4% 0.08984.3 KB 1.2% 0.27
Jun 21 06:00:00 - 06:59:59 459 2.0% 0.131.8 MB 2.2% 0.51
Jun 21 07:00:00 - 07:59:59 377 1.7% 0.101.3 MB 1.5% 0.36
Jun 21 08:00:00 - 08:59:59 436 1.9% 0.121.4 MB 1.7% 0.41
Jun 21 09:00:00 - 09:59:59 669 3.0% 0.192.1 MB 2.6% 0.59
Jun 21 10:00:00 - 10:59:59 713 3.2% 0.201.9 MB 2.4% 0.55
Jun 21 11:00:00 - 11:59:59 721 3.2% 0.202.1 MB 2.6% 0.60
Jun 21 12:00:00 - 12:59:59 794 3.5% 0.222.3 MB 2.8% 0.66
Jun 21 13:00:00 - 13:59:59 701 3.1% 0.191.8 MB 2.2% 0.50
Jun 21 14:00:00 - 14:59:59 4091 18.2% 1.1419.6 MB 24.0% 5.57
Jun 21 15:00:00 - 15:59:59 1218 5.4% 0.344.9 MB 6.0% 1.39
Jun 21 16:00:00 - 16:59:59 1200 5.3% 0.334.1 MB 5.1% 1.17
Jun 21 17:00:00 - 17:59:59 1493 6.6% 0.414.7 MB 5.8% 1.35
Jun 21 18:00:00 - 18:59:59 1173 5.2% 0.333.7 MB 4.6% 1.06
Jun 21 19:00:00 - 19:59:59 1293 5.8% 0.365.1 MB 6.2% 1.45
Jun 21 20:00:00 - 20:59:59 1194 5.3% 0.333.8 MB 4.6% 1.08
Jun 21 21:00:00 - 21:59:59 1097 4.9% 0.303.2 MB 3.9% 0.90
Jun 21 22:00:00 - 22:59:59 1143 5.1% 0.323.9 MB 4.7% 1.10
Jun 21 23:00:00 - 23:59:59 1126 5.0% 0.315.9 MB 7.2% 1.67
Jun 22 00:00:00 - 00:00:02 15 0.1% 7.5034.5 KB 0.0% 17.26
TOTAL: 24:00:00 22460 100.0% 0.2681.5 MB 100.0% 0.97
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7690 441 0 0 0 0 0 0 7249
2linuxd-out.news.weretis.net 1939 555 0 1 0 0 0 0 1383
3news.fcku.it 59 4 0 0 0 0 0 0 55
4nntp.pasdenom.info 4 1 0 0 0 0 0 0 3
TOTAL: 4 9692 1001 0 1 0 0 0 0 8690

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 154
lada.talk 105
spline.eisfair 56
mpc.lists.freebsd.ports.bugs 50
it-alt.sport.calcio.juventus 47
lada.auto 39
it.annunci.varie 37
alt.windows7.general 36
mpc.lists.nanog 34
it.annunci.immobiliari 30
alt.survival 30
mozilla.support.thunderbird 28
mozilla.dev.security.policy 26
mozilla.support.seamonkey 23
gmane.linux.alsa.devel 20
it.annunci.commerciali 19
free.it.religioni.scientology 18
mozilla.dev.platform 18
it.comp.os.win.windows10 18
mozilla.general 17
TOTAL: 100 1001

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7268
EMP (phn path) 698
EMP (phl) 170
Too many newsgroups 46
EMP (phn nph) 23
User-issued cancel 23
Binary: non-binary distribution 4
Binary Payload 4
Binary: misplaced lnk 3
Too many newsgroups (low_xpost) 3
Binary: misplaced 002 1
Angle-bracket bot 1
Too many newsgroups (meow) 1
Binary: misplaced 006 1
TOTAL: 14 8246

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 419
newsfeed.neva.ru 24
news.fcku.it 1
TOTAL: 3 444
TOTAL: 1 444

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 37890 2354 19052 856 0 1909 6%23:57:40
2news.fcku.it 26786 1553 17694 2688 0 3105 5%23:59:46
3weretis.net 3877 110 3307 0 0 44 2%23:57:40
4eternal-september 24293 44 19225 9 0 835 0%23:59:46
5neva.ru 26191 30 19346 135 0 78 0%23:59:40
6news.netfront.net 2741 0 0 0 0 25171 0%23:59:44
7etla.org 0 0 0 0 0 22460 0%23:59:47
8news.albasani.net 2865 0 0 0 0 24371 0%23:59:46
9vc89.vc.panix.com 2841 0 0 0 0 25300 0%23:59:46
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11news.stack.nl 2426 0 0 0 0 24731 0%23:59:46
12news.killfile.org 2849 0 0 0 0 25308 0%23:59:46
TOTAL: 12 132759 4091 78624 3688 0 153312 3%264:03:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info8.5 MB1.9 MB10.4 MB0.1 KB/s3.3 KB23:57:40
2news.fcku.it5.2 MB11.7 MB16.9 MB0.2 KB/s4.1 KB23:59:46
3eternal-september331.0 KB118.2 KB449.2 KB0.0 KB/s8.5 KB23:59:46
4neva.ru184.7 KB531.7 KB716.5 KB0.0 KB/s4.3 KB23:59:40
5weretis.net158.0 KB0.0 KB158.0 KB0.0 KB/s1.4 KB23:57:40
6news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:47
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
9vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
TOTAL: 1214.3 MB14.2 MB28.5 MB0.0 KB/s3.8 KB264:03:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 88 26.1 KB 2 0 000:42:12
TOTAL: 1 88 26.1 KB 2 0 000:42:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 88 26.1 KB 2 0 000:42:12
2unresolved 1 00.0 KB 0 0 000:00:25
TOTAL: 2 89 26.1 KB 2 0 000:42:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 9.504 2.064 0.00000:42:12
88.67.84.37 0.104 0.016 0.00000:00:25
TOTAL: 2 9.608 2.080 0.00000:42:38

Curious NNRP server explorers [Top 20]:

SystemConn
88.67.84.37 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1de 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1de.comp.os.unix.linux.misc 1
2de.sci.physik 1
TOTAL: 2 2