Daily Usenet report for paganini.linuxd.org

Feb 27 00:00:02 -- Feb 28 00:00:03

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Feb 27 01:28:54 paganini overchan[6326]: input line too long, skipping
Feb 27 09:11:51 paganini overchan[6326]: input line too long, skipping
Feb 27 13:31:07 paganini overchan[6326]: input line too long, skipping
Feb 27 14:57:06 paganini overchan[6326]: input line too long, skipping
Feb 27 15:18:49 paganini overchan[6326]: input line too long, skipping
Feb 27 15:20:33 paganini overchan[6326]: input line too long, skipping
Feb 27 15:35:15 paganini overchan[6326]: input line too long, skipping
Feb 28 00:00:03 paganini overchan[23361]: 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 101158 70.4%12.7 MB 57.1%
inn 28333 19.7%7.7 MB 34.9%
nnrpd 10005 7.0%1.1 MB 4.9%
innd 4002 2.8%684.3 KB 3.0%
nocem 104 0.1%19.9 KB 0.1%
overchan 9 0.0%1.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 143612 100.0%22.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 32510 35.8%
Negative hits 30337 33.4%
Do not exist 27862 30.7%
Cache misses 59 0.1%
TOTAL: 4 90768 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.446 0.0%210 0.000 2.124 35.400
article cleanup00:00:00.174 0.0%27864 0.000 0.006 0.027
article logging00:00:00.219 0.0%28141 0.000 0.008 0.027
article parse00:00:00.649 0.0%44237 0.000 0.015 0.044
article write00:00:46.775 0.1%22916 0.135 2.041 8.654
artlog/artcncl00:00:00.002 0.0%210 0.000 0.010 0.250
data move00:00:00.083 0.0%114460 0.000 0.001 0.007
hisgrep/artcncl00:00:00.000 0.0%140 0.000 0.000 0.000
hishave/artcncl00:00:00.006 0.0%210 0.000 0.029 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.747 0.0%90792 0.013 0.041 0.702
history sync00:00:00.216 0.0%301 0.000 0.718 38.800
history write00:00:27.729 0.0%27864 0.034 0.995 7.333
hiswrite/artcncl00:00:00.003 0.0%70 0.000 0.043 1.000
idle23:57:17.818 99.8%105555 318.852 816.994 2454.898
nntp read00:00:00.921 0.0%105460 0.000 0.009 0.022
overview write00:00:21.972 0.0%22916 0.000 0.959 4.626
perl filter00:00:52.987 0.1%27864 1.009 1.902 19.806
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.062 0.0%68916 0.000 0.015 0.042
TOTAL: 24:00:22.62523:59:54.809100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.096 0.0%36953 0.000 0.003 0.012
article prepare00:00:00.003 0.0%25112 0.000 0.000 0.006
article read00:00:02.546 0.0%6015 0.000 0.423 11.646
backlog stats00:00:00.153 0.0%261218 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.001 0.0%134535 0.001 0.007 0.020
data write00:00:01.997 0.0%111784 0.006 0.018 0.032
idle23:43:51.231 99.3%261218 235.208 327.050 509.535
status file00:09:07.109 0.6%42334 8.302 12.924 28.956
TOTAL: 23:53:23.15623:53:04.136100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:41:34.234 99.3%23833 102.222 104.655 734.091
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.062 0.0%47757 0.002 0.022 6.839
readart00:00:03.565 0.1%14238 0.040 0.250 2.392
TOTAL: 00:41:50.85200:41:38.861 99.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 5 54907 22044 27907 4956 40%48:21:55
2news.fcku.it 1 5536 919 4611 6 16%23:29:20
3localhost 25 0 0 0 0 0%00:00:00
TOTAL: 3 31 60443 22963 32518 4962 37%71:51:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net78.4 MB0.0 KB34.1 MB112.5 MB 69%4.3 KB
2news.fcku.it2.3 MB0.0 KB9.2 KB2.3 MB 99%2.5 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 380.7 MB0.0 KB34.1 MB114.8 MB 70%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 27 00:00:02 - 00:59:59 1185 5.2% 0.333.7 MB 4.6% 1.06
Feb 27 01:00:00 - 01:59:59 752 3.3% 0.212.4 MB 3.0% 0.68
Feb 27 02:00:00 - 02:59:59 678 3.0% 0.192.1 MB 2.6% 0.60
Feb 27 03:00:00 - 03:59:59 536 2.3% 0.151.6 MB 1.9% 0.44
Feb 27 04:00:00 - 04:59:59 496 2.2% 0.141.9 MB 2.3% 0.53
Feb 27 05:00:00 - 05:59:59 458 2.0% 0.132.7 MB 3.4% 0.78
Feb 27 06:00:00 - 06:59:59 439 1.9% 0.121.5 MB 1.9% 0.43
Feb 27 07:00:00 - 07:59:59 560 2.4% 0.161.8 MB 2.2% 0.51
Feb 27 08:00:00 - 08:59:59 681 3.0% 0.193.0 MB 3.7% 0.86
Feb 27 09:00:00 - 09:59:59 909 4.0% 0.253.8 MB 4.7% 1.08
Feb 27 10:00:00 - 10:59:59 899 3.9% 0.253.0 MB 3.8% 0.87
Feb 27 11:00:00 - 11:59:59 965 4.2% 0.276.3 MB 7.8% 1.80
Feb 27 12:00:00 - 12:59:59 989 4.3% 0.273.5 MB 4.3% 0.99
Feb 27 13:00:00 - 13:59:59 1115 4.9% 0.315.9 MB 7.3% 1.67
Feb 27 14:00:00 - 14:59:59 1014 4.4% 0.283.2 MB 3.9% 0.90
Feb 27 15:00:00 - 15:59:59 1278 5.6% 0.353.5 MB 4.4% 1.01
Feb 27 16:00:00 - 16:59:59 1195 5.2% 0.333.6 MB 4.5% 1.03
Feb 27 17:00:00 - 17:59:59 1295 5.7% 0.363.4 MB 4.2% 0.96
Feb 27 18:00:00 - 18:59:59 1349 5.9% 0.374.3 MB 5.3% 1.23
Feb 27 19:00:00 - 19:59:59 1374 6.0% 0.385.8 MB 7.2% 1.65
Feb 27 20:00:00 - 20:59:59 1209 5.3% 0.343.2 MB 3.9% 0.90
Feb 27 21:00:00 - 21:59:59 1255 5.5% 0.353.6 MB 4.5% 1.02
Feb 27 22:00:00 - 22:59:59 1237 5.4% 0.344.0 MB 5.0% 1.14
Feb 27 23:00:00 - 23:59:59 1032 4.5% 0.292.7 MB 3.4% 0.77
Feb 28 00:00:00 - 00:00:03 6 0.0% 2.0026.7 KB 0.0% 8.90
TOTAL: 24:00:01 22906 100.0% 0.2780.6 MB 100.0% 0.96
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1linuxd-out.news.weretis.net 5206 2096 0 0 0 0 0 0 3110
2news.fcku.it 11 6 0 0 0 0 0 0 5
TOTAL: 2 5217 2102 0 0 0 0 0 0 3115

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 297
mailing.freebsd.pkg-fallout 150
time.nuts 123
lada.talk 89
mailing.freebsd.svn-ports-all 56
mailing.freebsd.svn-ports-head 56
mailing.openssl.cvs 50
mailing.freebsd.ports-bugs 40
mpc.lists.freebsd.ports.bugs 40
it-alt.sport.calcio.juventus 38
mailing.openbsd.ports-changes 38
lada.auto 38
uk.radio.amateur.moderated 37
mozilla.dev.tree-alerts 35
alt.survival 34
spline.eisfair.dev 30
alt.politics 30
free.it.religioni.scientology 28
mailing.freebsd.svn-src-all 25
fa.openbsd.source-changes 25
TOTAL: 192 2102

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 2731
Binary Payload 34
Too many newsgroups 22
User-issued cancel 21
User-issued spam cancel 10
EMP (phr path) 8
HTML post 6
EMP (md5) 5
EMP (phn nph) 1
TOTAL: 9 2838

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 272
news.fcku.it 5
TOTAL: 2 277
TOTAL: 1 277

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 30285 1457 16348 4155 0 25 4%23:59:49
2neva.ru 32443 203 20754 313 0 42 0%23:59:47
3weretis.net 998 170 770 0 0 0 17%22:58:28
4news.killfile.org 2836 0 0 0 0 25741 0%23:59:49
5news.albasani.net 2856 0 0 0 0 24790 0%23:59:49
6nntp.pasdenom.info 0 0 0 0 0 22815 0%23:57:42
7news.netfront.net 2743 0 0 0 0 25589 0%23:59:48
8news.stack.nl 2859 0 0 0 0 25691 0%23:59:49
9etla.org 0 0 0 0 0 22906 0%23:59:49
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11eternal-september 0 0 0 0 0 19549 0%23:59:49
12vc89.vc.panix.com 2835 0 0 0 0 25740 0%23:59:49
TOTAL: 12 77855 1830 37872 4468 0 192888 2%263:04:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it8.9 MB26.1 MB35.0 MB0.4 KB/s6.4 KB23:59:49
2neva.ru587.4 KB1.6 MB2.2 MB0.0 KB/s4.4 KB23:59:47
3weretis.net328.1 KB0.0 KB328.1 KB0.0 KB/s1.9 KB22:58:28
4news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
5news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
6nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:42
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
8news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
9etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
12vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:49
TOTAL: 129.8 MB27.8 MB37.5 MB0.0 KB/s6.1 KB263:04:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-01-845526598.dsl.bell.ca 48 1020.5 KB 6 0 000:41:41
TOTAL: 1 48 1020.5 KB 6 0 000:41:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 48 1020.5 KB 6 0 000:41:41
2unresolved 1 00.0 KB 0 0 000:00:09
TOTAL: 2 49 1020.5 KB 6 0 000:41:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-01-845526598.dsl.bell.ca 4.860 1.496 0.00000:41:41
179.48.248.132 0.128 0.064 0.00000:00:09
TOTAL: 2 4.988 1.560 0.00000:41:50

Curious NNRP server explorers [Top 20]:

SystemConn
179.48.248.132 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1alt 10100.0%
TOTAL: 1 10100.0%

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

NewsgroupCount
1alt.usage.english 5
2alt.happy.valley 3
3alt.drugs.heroin 2
TOTAL: 3 10