Daily Usenet report for paganini.linuxd.org

Feb 4 00:00:01 -- Feb 5 00:00:05

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Feb 4 00:00:13 paganini nnrpd[27927]: ceres.etla.org noperm ihave without permission
Feb 4 00:00:43 paganini nnrpd[27932]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
Feb 4 04:39:09 paganini pgpverify[26532]: pgpverify: verification failed
Feb 4 04:39:09 paganini controlchan[30590]: skipping newgroup y nl-admin@nic.surfnet.nl (pgpverify failed) in <1423019042.20736@news.a3.xs4all.nl>
Feb 4 08:32:47 paganini overchan[18679]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)
Feb 4 11:50:03 paganini pgpverify[6536]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 46913 70.2%9.9 MB 80.3%
innd 15416 23.1%1.8 MB 14.7%
nnrpd 2577 3.9%282.0 KB 2.2%
innfeed 1802 2.7%319.5 KB 2.5%
nocem 150 0.2%17.2 KB 0.1%
controlchan 6 0.0%0.8 KB 0.0%
pgpverify 2 0.0%0.4 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 8 66868 100.0%12.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 286871 53.8%
Negative hits 192566 36.1%
Do not exist 46270 8.7%
Cache misses 7041 1.3%
TOTAL: 4 532748 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.731 0.0%279 0.000 2.620 40.000
article cleanup00:00:00.286 0.0%46371 0.000 0.006 0.018
article logging00:00:00.670 0.0%46454 0.000 0.014 0.580
article parse00:00:01.095 0.0%111218 0.002 0.010 0.024
article write00:01:21.348 0.1%29547 0.112 2.753 19.317
artlog/artcncl00:00:00.003 0.0%222 0.000 0.014 0.118
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.193 0.0%574726 0.000 0.000 0.001
hisgrep/artcncl00:00:00.071 0.0%273 0.000 0.260 5.222
hishave/artcncl00:00:00.003 0.0%279 0.000 0.011 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:52.401 0.1%538915 0.017 0.097 0.427
history sync00:00:00.244 0.0%317 0.000 0.770 59.500
history write00:02:50.921 0.2%46363 0.328 3.687 11.197
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle23:40:53.218 99.3%557345 27.553 152.963 343.284
nntp read00:00:03.098 0.0%574048 0.003 0.005 0.009
overview write00:01:13.630 0.1%29547 0.010 2.492 8.096
perl filter00:01:53.647 0.1%46361 1.145 2.451 38.907
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.338 0.0%118560 0.002 0.062 0.125
TOTAL: 23:50:32.09923:49:18.897 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.088 0.0%31417 0.000 0.003 0.018
article prepare00:00:00.010 0.0%83122 0.000 0.000 0.002
article read00:00:18.206 0.0%20298 0.016 0.897 14.069
backlog stats00:00:00.177 0.0%471196 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.427 0.0%314323 0.003 0.008 0.015
data write00:00:03.709 0.0%289307 0.008 0.013 0.029
idle23:52:21.464 99.9%471196 112.734 182.390 556.495
status file00:00:06.247 0.0%159 0.000 39.289 189.000
TOTAL: 23:53:05.10423:52:52.328100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle11:41:58.764 95.7%374722 40.333 112.400 375.200
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:17:49.594 2.4%962376 0.000 1.111 11.942
readart00:13:31.932 1.8%371954 0.072 2.183 42.000
TOTAL: 12:13:45.04212:13:20.290 99.9%----

Control commands to INND:

CommandNumber
L 1
flush 1
flushlogs 2
go 2
logmode 2
mode 148
name 2
newgroup 1
pause 2
paused 2
reload 2
reserve 2
TOTAL: 12 167

Newsgroups created:

GroupMode
alt.binaries.historyy
TOTAL1

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
153fishare@gmail.com100011
admin@openwatcom.news-admin.org000100
TOTAL100111

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 7 68302 10940 53746 3616 16%48:11:36
2feeder.eternal-september.org 14 44514 5795 35902 2817 13%26:29:46
3vc89.vc.panix.com 5 8805 4026 4437 342 45%24:03:45
4newsfeed.neva.ru 144 97958 3133 89656 5169 3%71:38:23
5news-out.mixmin.net 4 40065 3107 32187 4771 7%23:29:52
6etla.org 8 40444 2366 38075 3 5%23:46:27
7news.netfront.net 2 14128 13 14053 62 0%09:26:21
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 209 314216 29380 268056 16780 9%227:06:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net37.8 MB0.0 KB28.8 MB66.6 MB 56%4.7 KB
2feeder.eternal-september.org26.8 MB6.1 KB37.2 MB64.0 MB 41%7.6 KB
3vc89.vc.panix.com14.4 MB185.2 KB3.8 MB18.4 MB 78%4.3 KB
4newsfeed.neva.ru8.1 MB6.0 KB15.9 MB24.0 MB 33%3.0 KB
5news-out.mixmin.net7.3 MB0.0 KB28.5 MB35.8 MB 20%4.7 KB
6etla.org6.6 MB0.0 KB14.1 KB6.6 MB 99%2.8 KB
7news.netfront.net36.3 KB0.0 KB3.8 MB3.8 MB 0%51.7 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 8101.1 MB197.3 KB118.0 MB219.3 MB 46%4.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 4 00:00:01 - 00:59:59 1198 4.0% 0.334.0 MB 3.9% 1.13
Feb 4 01:00:00 - 01:59:59 902 3.0% 0.253.0 MB 3.0% 0.85
Feb 4 02:00:00 - 02:59:59 860 2.9% 0.2416.6 MB 16.5% 4.73
Feb 4 03:00:00 - 03:59:59 592 2.0% 0.162.3 MB 2.3% 0.66
Feb 4 04:00:00 - 04:59:59 660 2.2% 0.181.9 MB 1.9% 0.55
Feb 4 05:00:00 - 05:59:59 717 2.4% 0.203.4 MB 3.3% 0.95
Feb 4 06:00:00 - 06:59:59 624 2.1% 0.172.0 MB 2.0% 0.56
Feb 4 07:00:00 - 07:59:59 645 2.2% 0.182.0 MB 2.0% 0.56
Feb 4 08:00:00 - 08:59:59 972 3.3% 0.273.0 MB 3.0% 0.86
Feb 4 09:00:00 - 09:59:59 1101 3.7% 0.313.1 MB 3.0% 0.87
Feb 4 10:00:00 - 10:59:59 1318 4.4% 0.373.0 MB 3.0% 0.87
Feb 4 11:00:00 - 11:59:59 1443 4.9% 0.403.7 MB 3.7% 1.06
Feb 4 12:00:00 - 12:59:59 1531 5.1% 0.434.6 MB 4.5% 1.30
Feb 4 13:00:00 - 13:59:59 1380 4.6% 0.384.0 MB 3.9% 1.13
Feb 4 14:00:00 - 14:59:59 1605 5.4% 0.454.4 MB 4.3% 1.24
Feb 4 15:00:00 - 15:59:59 1567 5.3% 0.444.7 MB 4.7% 1.34
Feb 4 16:00:00 - 16:59:59 1668 5.6% 0.465.0 MB 5.0% 1.42
Feb 4 17:00:00 - 17:59:59 1729 5.8% 0.485.0 MB 4.9% 1.42
Feb 4 18:00:00 - 18:59:59 1612 5.4% 0.454.2 MB 4.2% 1.20
Feb 4 19:00:00 - 19:59:59 1628 5.5% 0.454.3 MB 4.2% 1.22
Feb 4 20:00:00 - 20:59:59 1571 5.3% 0.443.9 MB 3.9% 1.12
Feb 4 21:00:00 - 21:59:59 1586 5.3% 0.444.9 MB 4.9% 1.40
Feb 4 22:00:00 - 22:59:59 1386 4.7% 0.394.0 MB 4.0% 1.14
Feb 4 23:00:00 - 23:59:59 1429 4.8% 0.404.0 MB 4.0% 1.14
Feb 5 00:00:00 - 00:00:05 10 0.0% 2.0049.9 KB 0.0% 9.98
TOTAL: 24:00:04 29734 100.0% 0.34101.0 MB 100.0% 1.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 5168 2155 0 1 0 0 0 0 3012
2news-out.mixmin.net 4794 19 0 0 0 0 0 0 4775
3linuxd-out.news.weretis.net 3705 1687 0 0 0 2 0 0 2016
4feeder.eternal-september.org 2812 213 0 1 0 0 0 0 2598
5vc89.vc.panix.com 352 3 0 6 0 0 0 0 343
6news.netfront.net 112 1 0 0 0 0 0 0 111
7etla.org 13 0 0 0 0 0 0 0 13
TOTAL: 7 16956 4078 0 8 0 2 0 012868

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 1004
mailing.freebsd.pkg-fallout 220
lada.talk 163
lada.auto 156
alt.politics 136
ut.test 114
it-alt.sport.calcio.juventus 104
tin.it.sport.calcio 76
mailing.postfix.users 69
mailing.freebsd.ports-bugs 63
spline.fli4l 50
mailing.freebsd.svn-src-all 46
fa.freebsd.cvs-all 46
alt.survival 45
mailing.freebsd.net 44
mailing.freebsd.svn-ports-all 43
mailing.gcc.gcc-cvs 41
mpc.lists.freebsd.ports.bugs 41
mailing.freebsd.svn-ports-head 40
pld.cvs.commit 40
TOTAL: 294 4078

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 6620
EMP (md5) 4913
EMP (phl) 767
EMP (phn nph) 212
Too many newsgroups 91
Binary Image: misplaced jpg 88
User-issued cancel 40
Binary: non-binary distribution 24
Binary Payload 20
HTML post 7
Too many newsgroups (low_xpost) 1
Too many newsgroups (meow) 1
TOTAL: 12 12784

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 36090 1089 13534 15073 5 358 3%24:00:13
2etla.org 33443 267 29410 24 0 165 0%24:00:14
3news.netfront.net 51717 234 29326 43 0 722 0%24:00:12
4news.killfile.org 47887 166 25594 3937 4 426 0%24:00:14
5neva.ru 30047 14 26209 10 0 86 0%23:56:20
6news.stack.nl 31401 13 29454 19 0 131 0%24:00:14
7weretis.net 19277 6 18516 0 0 0 0%24:00:11
8eternal-september 24970 4 23891 3 0 4 0%24:00:14
9news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 9 274832 1793 195934 19109 9 1892 0%192:07:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org15.1 MB6.4 MB21.5 MB0.3 KB/s75.6 KB24:00:14
2news.netfront.net13.7 MB639.7 KB14.4 MB0.2 KB/s53.1 KB24:00:12
3vc89.vc.panix.com3.7 MB49.2 MB52.8 MB0.6 KB/s3.3 KB24:00:13
4news.killfile.org555.3 KB17.6 MB18.2 MB0.2 KB/s4.5 KB24:00:14
5neva.ru444.4 KB190.9 KB635.2 KB0.0 KB/s26.5 KB23:56:20
6news.stack.nl50.5 KB32.6 KB83.1 KB0.0 KB/s2.6 KB24:00:14
7weretis.net14.0 KB0.0 KB14.0 KB0.0 KB/s2.3 KB24:00:11
8eternal-september12.9 KB4.6 KB17.5 KB0.0 KB/s2.5 KB24:00:14
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 933.6 MB74.0 MB107.6 MB0.2 KB/s5.3 KB192:07:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-05-1178024259.dsl.bell.ca 1491064661.6 GB 1346 0 012:13:44
TOTAL: 1 1491064661.6 GB 1346 0 012:13:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 1491064661.6 GB 1346 0 012:13:44
2? 1 00.0 KB 0 0 000:00:00
3*.etla.org 1 00.0 KB 0 0 000:00:00
TOTAL: 3 1511064661.6 GB 1346 0 012:13:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-05-1178024259.dsl.bell.ca 48.184 31.284 0.00012:13:44
2001:ba8:1f1:f1ef::2 0.056 0.004 0.00000:00:00
ceres.etla.org 0.072 0.004 0.00000:00:00
TOTAL: 3 48.312 31.292 0.00012:13:44

Curious NNRP server explorers [Top 20]:

SystemConn
ceres.etla.org 1
2001:ba8:1f1:f1ef::2 1
TOTAL: 2 2

Newsgroup request counts (by category):

CategoryCountPct
1alt 45965 43.2%
2linux 23735 22.3%
3fr 16289 15.3%
4rec 14775 13.9%
5misc 5471 5.1%
6sci 90 0.1%
7uk 60 0.1%
8soc 58 0.1%
9can 16 0.0%
10talk 4 0.0%
11comp 3 0.0%
TOTAL: 11 106466100.0%

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

NewsgroupCount
1alt.atheism 25106
2linux.kernel 23735
3alt.fan.rush-limbaugh 16486
4fr.soc.politique 16282
5rec.arts.tv 9579
6misc.test 5470
7rec.food.cooking 4911
8alt.test 4008
9rec.sport.pro-wrestling 133
10alt.usenet.kooks 106
11alt.assassination.jfk 70
12soc.retirement 58
13alt.usage.english 49
14uk.railway 44
15sci.electronics.design 40
16rec.sport.tennis 37
17rec.sport.football.college 36
18sci.physics.relativity 31
19alt.gossip.celebrities 20
20sci.physics 19
21rec.gambling.poker 17
22alt.arts.poetry.comments 17
23rec.games.pinball 17
24alt.support.depression 16
25rec.woodworking 16
26can.politics 16
27uk.rec.motorcycles 16
28alt.comp.freeware 14
29rec.outdoors.rv-travel 13
30alt.home.repair 13
31alt.conspiracy 10
32alt.society.liberalism 10
33alt.messianic 9
34rec.boats 9
35alt.california 7
36rec.crafts.metalworking 7
37alt.astronomy 7
38alt.obituaries 7
39fr.rec.photo 7
40alt.support.diabetes 4
41talk.origins 4
42alt.abortion 3
43comp.lang.python 3
44alt.bible.prophecy 1
45alt.books.louis-lamour 1
46misc.health.alternative 1
47alt.suicide.holiday 1
TOTAL: 47 106466