Daily Usenet report for paganini.linuxd.org

May 3 00:00:09 -- May 4 00:00:28

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 3 14:47:50 paganini overchan[624]: input line too long, skipping
May 4 00:00:24 paganini overchan[17322]: 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
nnrpd 282205 65.7%29.0 MB 56.2%
innfeed 100838 23.5%12.1 MB 23.4%
inn 37019 8.6%9.0 MB 17.4%
innd 9563 2.2%1.6 MB 3.0%
nocem 58 0.0%9.0 KB 0.0%
overchan 3 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 429687 100.0%51.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 110950 47.4%
Positive hits 86850 37.1%
Do not exist 35981 15.4%
Cache misses 178 0.1%
TOTAL: 4 233959 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:24.294 0.0%236 0.000 102.941 928.000
article cleanup00:00:00.460 0.0%36383 0.000 0.013 0.608
article logging00:00:24.943 0.0%36724 0.000 0.679 7.315
article parse00:00:00.805 0.0%55817 0.003 0.014 0.073
article write01:00:06.124 4.2%24569 23.586 146.775 478.642
artlog/artcncl00:00:00.020 0.0%160 0.000 0.125 1.071
data move00:00:00.782 0.0%224858 0.000 0.003 0.223
hisgrep/artcncl00:00:05.804 0.0%226 0.000 25.681 154.000
hishave/artcncl00:00:04.222 0.0%236 0.000 17.890 87.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:31:01.642 2.2%234180 0.101 7.950 13.704
history sync00:00:01.305 0.0%376 0.000 3.471 131.667
history write00:32:15.973 2.2%36024 1.152 53.741 160.552
hiswrite/artcncl00:00:00.343 0.0%10 0.000 34.300 53.500
idle20:28:57.653 85.6%155615 242.547 473.847 1304.604
nntp read00:00:03.132 0.0%222744 0.000 0.014 0.399
overview write01:02:19.740 4.3%24569 22.162 152.214 3393.844
perl filter00:08:02.451 0.6%36024 1.818 13.392 79.954
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.549 0.0%73826 0.000 0.021 0.710
TOTAL: 23:55:11.75223:43:51.242 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.092 0.0%38765 0.000 0.002 0.013
article prepare00:00:00.001 0.0%2128 0.000 0.000 0.031
article read00:00:15.813 0.0%532 0.000 29.724 288.500
backlog stats00:00:00.163 0.0%227327 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.349 0.0%140826 0.000 0.010 0.092
data write00:00:01.800 0.0%116687 0.006 0.015 0.068
idle22:31:35.764 94.3%227327 247.324 356.736 552.657
status file01:11:02.403 5.0%42163 23.444 101.093 569.750
TOTAL: 23:53:44.27223:42:57.385 99.2%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle26:33:15.188 94.7%711215 96.961 134.411600158.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:13.296 0.0%1423074 0.000 0.009 0.500
readart00:31:28.487 1.9%24976 26.953 75.612 158.715
TOTAL: 28:02:52.52727:04:56.971 96.6%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 7 58268 17872 37307 3089 30%48:29:40
2newsfeed.neva.ru 143 54341 5743 40182 8416 10%72:05:21
3news.fcku.it 1 10573 1007 9322 244 9%22:57:44
4nntp.pasdenom.info 3 0 0 0 0 0%00:30:09
5localhost 25 0 0 0 0 0%00:00:20
TOTAL: 5 179 123182 24622 86811 11749 19%144:03:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net59.5 MB755.1 KB21.1 MB81.4 MB 73%4.0 KB
2newsfeed.neva.ru20.0 MB1.2 MB27.8 MB49.0 MB 40%3.5 KB
3news.fcku.it5.0 MB15.2 KB1.6 MB6.6 MB 75%5.4 KB
4nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 584.5 MB1.9 MB50.5 MB137.0 MB 61%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 3 00:00:09 - 00:59:59 857 3.5% 0.242.4 MB 2.9% 0.70
May 3 01:00:00 - 01:59:59 728 3.0% 0.203.9 MB 4.6% 1.12
May 3 02:00:00 - 02:59:59 698 2.8% 0.193.9 MB 4.6% 1.11
May 3 03:00:00 - 03:59:59 895 3.6% 0.253.1 MB 3.7% 0.88
May 3 04:00:00 - 04:59:59 584 2.4% 0.162.2 MB 2.6% 0.63
May 3 05:00:00 - 05:59:59 441 1.8% 0.121.5 MB 1.8% 0.43
May 3 06:00:00 - 06:59:59 545 2.2% 0.151.8 MB 2.1% 0.51
May 3 07:00:00 - 07:59:59 541 2.2% 0.152.5 MB 3.0% 0.71
May 3 08:00:00 - 08:59:59 767 3.1% 0.214.4 MB 5.2% 1.26
May 3 09:00:00 - 09:59:59 912 3.7% 0.252.9 MB 3.4% 0.81
May 3 10:00:00 - 10:59:59 1009 4.1% 0.283.5 MB 4.1% 0.99
May 3 11:00:00 - 11:59:59 1097 4.4% 0.303.7 MB 4.4% 1.05
May 3 12:00:00 - 12:59:59 1108 4.5% 0.314.4 MB 5.2% 1.25
May 3 13:00:00 - 13:59:59 1145 4.6% 0.323.5 MB 4.2% 1.00
May 3 14:00:00 - 14:59:59 1273 5.2% 0.353.7 MB 4.4% 1.06
May 3 15:00:00 - 15:59:59 1325 5.4% 0.373.5 MB 4.2% 1.00
May 3 16:00:00 - 16:59:59 1359 5.5% 0.384.0 MB 4.8% 1.15
May 3 17:00:00 - 17:59:59 1396 5.7% 0.394.7 MB 5.5% 1.32
May 3 18:00:00 - 18:59:59 1334 5.4% 0.374.4 MB 5.2% 1.25
May 3 19:00:00 - 19:59:59 1401 5.7% 0.394.7 MB 5.5% 1.33
May 3 20:00:00 - 20:59:59 1412 5.7% 0.393.8 MB 4.5% 1.08
May 3 21:00:00 - 21:59:59 1285 5.2% 0.363.5 MB 4.1% 0.99
May 3 22:00:00 - 22:59:59 1350 5.5% 0.384.6 MB 5.4% 1.30
May 3 23:00:00 - 23:59:59 1184 4.8% 0.333.9 MB 4.6% 1.12
May 4 00:00:00 - 00:00:28 14 0.1% 0.5060.2 KB 0.1% 2.15
TOTAL: 24:00:19 24660 100.0% 0.2984.6 MB 100.0% 1.00
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 8554 1884 0 235 0 0 0 0 6435
2linuxd-out.news.weretis.net 3349 1907 0 115 0 0 0 0 1327
3news.fcku.it 295 1 0 9 0 0 0 0 285
TOTAL: 3 12198 3792 0 359 0 0 0 0 8047

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 1268
mailing.freebsd.pkg-fallout 272
mailing.freebsd.svn-ports-all 91
mailing.freebsd.ports-bugs 88
mailing.freebsd.svn-ports-head 79
it-alt.sport.calcio.juventus 75
mailing.freebsd.svn-src-all 73
fa.freebsd.cvs-all 72
lada.talk 69
ut.test 68
mailing.openbsd.source-changes 57
mailing.gcc.gcc-cvs 56
alt.survival 52
mailing.freebsd.svn-src-head 47
fa.openbsd.source-changes 46
lada.auto 44
mailing.database.pgsql-general 43
mailing.freebsd.current 42
fa.freebsd.current 41
mozilla.dev.platform 40
TOTAL: 235 3792

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5073
EMP (phn path) 1226
EMP (phl) 757
PFM bot misc 334
EMP (phn nph) 213
Too many newsgroups 50
User-issued cancel 17
Binary Payload 14
Too many newsgroups (meow) 9
HTML post 6
Binary: non-binary distribution 4
Binary: misplaced patc 1
TOTAL: 12 7704

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 263
newsfeed.neva.ru 76
news.fcku.it 4
TOTAL: 3 343
TOTAL: 1 343

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 23716 8 23527 8 0 17 0%23:59:54
2nntp.pasdenom.info 25802 6 24034 512 0 170 0%23:57:52
3vc89.vc.panix.com 2821 0 0 0 0 27480 0%23:59:58
4news.stack.nl 2848 0 0 0 0 27400 0%23:59:59
5news.mixmin.net 0 0 0 0 0 0 0%00:10:00
6etla.org 0 0 0 0 0 24660 0%23:59:59
7neva.ru 18876 0 18782 0 0 0 0%23:59:59
8news.killfile.org 2832 0 0 0 0 27491 0%23:59:58
9weretis.net 6647 0 6631 0 0 21 0%23:59:24
10news.netfront.net 2743 0 0 0 0 27270 0%23:59:58
11eternal-september 0 0 0 0 0 20737 0%23:59:59
12news.albasani.net 2845 0 0 0 0 26669 0%23:59:59
TOTAL: 12 89130 14 72974 520 0 181915 0%264:06:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info94.4 KB858.1 KB952.5 KB0.0 KB/s1.8 KB23:57:52
2news.fcku.it16.7 KB133.0 KB149.7 KB0.0 KB/s9.4 KB23:59:54
3vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
4news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
5news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
6etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
7neva.ru0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
8news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
9weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:24
10news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:58
11eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
12news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:59
TOTAL: 12111.1 KB991.1 KB1.1 MB0.0 KB/s2.1 KB264:06:59
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1bas2-montrealak-1177634386.dsl.bell.ca 24 3211.5 MB 88 0 021:37:01
TOTAL: 1 24 3211.5 MB 88 0 028:02:47

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 24 3211.5 MB 88 0 021:37:01
2unresolved 3 00.0 KB 0 0 001:04:04
3*.nielsenmedia.com 17 00.0 KB 0 0 005:21:41
TOTAL: 3 44 3211.5 MB 88 0 028:02:47

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
bas2-montrealak-1177634386.dsl.bell.ca 26.032 38.152 0.00021:37:01
challenger.nielsenmedia.com 1.028 0.156 0.00005:21:41
71.98.160.36 0.176 0.008 0.00001:04:04
TOTAL: 3 27.236 38.316 0.00028:02:47

Curious NNRP server explorers [Top 20]:

SystemConn
challenger.nielsenmedia.com 17
71.98.160.36 3
TOTAL: 2 20

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 10 0
71.98.160.36 2 0
TOTAL: 2 12 0

Newsgroup request counts (by category):

CategoryCountPct
1alt 155 48.3%
2free 111 34.6%
3soc 11 3.4%
4hr 9 2.8%
5sci 9 2.8%
6talk 6 1.9%
7fr 5 1.6%
8uk 4 1.2%
9it 2 0.6%
10muc 2 0.6%
11sac 1 0.3%
12can 1 0.3%
13microsoft 1 0.3%
14chi 1 0.3%
15rec 1 0.3%
16christnet 1 0.3%
17comp 1 0.3%
TOTAL: 17 321100.0%

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

NewsgroupCount
1free.at 110
2alt.drugs.heroin 105
3soc.culture.israel 7
4alt.home.repair 7
5hr.soc.politika 7
6alt.atheism 6
7alt.religion.christian.roman-catholic 5
8sci.physics 5
9alt.drugs.hard 4
10alt.drugs.cannabis.nl 4
11alt.drugs.chemistry 3
12sci.skeptic 3
13alt.comp.os.windows-10 3
14talk.bizarre 3
15alt.christnet.christianlife 3
16talk.politics.misc 3
17fr.sci.zetetique 2
18uk.legal 2
19alt.politics.democrats 2
20hr.alt.drugs 2
21alt.usenet.kooks 2
22alt.happy.valley 2
23soc.culture.usa 1
24alt.politics.republicans 1
25sac.politics 1
26it.sport.calcio.milan 1
27alt.fan.rush-limbaugh 1
28muc.lists.freebsd.security 1
29alt.privacy 1
30uk.telecom.voip 1
31alt.os.linux 1
32fr.sci.physique 1
33fr.soc.politique 1
34christnet.philosophy 1
35alt.true-crime 1
36soc.culture.indian 1
37uk.rec.motorcycles 1
38alt.hacking 1
39microsoft.public.windowsxp.general 1
40alt.california 1
41soc.men 1
42soc.culture.cuba 1
43comp.dsp 1
44fr.sci.philo 1
45free.uk.btinternet.chatter.refugees 1
46muc.lists.freebsd.current 1
47alt.tv.pol-incorrect 1
48can.community.military 1
49alt.politics.bush 1
50chi.general 1
51sci.electronics.repair 1
52it.arti.trash 1
53rec.arts.tv 1
TOTAL: 53 321