Daily Usenet report for paganini.linuxd.org

Nov 19 00:00:01 -- Nov 20 00:00:01

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Nov 19 15:25:22 paganini pgpverify[26595]: pgpverify: verification failed
Nov 19 15:25:22 paganini pgpverify[26603]: pgpverify: verification failed
Nov 19 15:25:22 paganini pgpverify[26611]: pgpverify: verification failed
Nov 19 15:25:22 paganini pgpverify[26619]: pgpverify: verification failed
Nov 19 15:25:22 paganini pgpverify[26627]: pgpverify: verification failed
Nov 19 15:25:22 paganini pgpverify[26635]: pgpverify: verification failed
Nov 19 15:26:29 paganini pgpverify[26694]: pgpverify: verification failed
Nov 19 15:26:29 paganini pgpverify[26702]: pgpverify: verification failed
Nov 19 15:26:29 paganini pgpverify[26710]: pgpverify: verification failed
Nov 19 15:26:29 paganini pgpverify[26718]: pgpverify: verification failed
Nov 19 15:26:30 paganini pgpverify[26726]: pgpverify: verification failed
Nov 19 15:26:30 paganini pgpverify[26734]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 59052 58.3%11.1 MB 66.6%
innd 38782 38.3%5.2 MB 31.0%
innfeed 2928 2.9%335.2 KB 2.0%
nnrpd 411 0.4%41.1 KB 0.2%
nocem 111 0.1%14.3 KB 0.1%
controlchan 12 0.0%0.9 KB 0.0%
pgpverify 12 0.0%2.1 KB 0.0%
TOTAL: 7 101308 100.0%16.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 312851 52.4%
Negative hits 224972 37.7%
Do not exist 58576 9.8%
Cache misses 179 0.0%
TOTAL: 4 596578 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.278 0.0%280 0.000 0.993 23.000
article cleanup00:00:00.371 0.0%58604 0.000 0.006 0.167
article logging00:00:00.768 0.0%58770 0.000 0.013 3.971
article parse00:00:01.577 0.0%168711 0.000 0.009 0.200
article write00:00:57.240 0.1%30479 0.000 1.878 84.429
artlog/artcncl00:00:00.001 0.0%273 0.000 0.004 0.143
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.230 0.0%621959 0.000 0.000 0.010
hisgrep/artcncl00:00:00.183 0.0%268 0.000 0.683 8.000
hishave/artcncl00:00:00.004 0.0%280 0.000 0.014 0.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:28.313 0.0%597016 0.000 0.047 3.693
history sync00:00:00.377 0.0%876 0.000 0.430 302.000
history write00:01:20.964 0.1%58598 0.000 1.382 36.368
hiswrite/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
idle23:51:21.239 99.4%616259 33.635 139.359 1171.135
nntp read00:00:03.428 0.0%631433 0.000 0.005 0.043
overview write00:00:37.764 0.0%30479 0.000 1.239 109.000
perl filter00:02:54.711 0.2%58597 0.512 2.982 73.786
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.887 0.0%122103 0.000 0.065 0.208
TOTAL: 23:59:41.91323:57:55.335 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.068 0.0%32044 0.000 0.002 0.250
article prepare00:00:00.005 0.0%84158 0.000 0.000 0.062
article read00:00:17.934 0.0%20252 0.000 0.886 70.500
backlog stats00:00:00.157 0.0%404753 0.000 0.000 0.024
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.260 0.0%273756 0.000 0.008 0.048
data write00:00:03.118 0.0%248114 0.000 0.013 0.071
idle23:59:15.321100.0%404753 62.527 213.353 3554.444
status file00:00:08.388 0.0%181 0.000 46.343 887.000
TOTAL: 23:59:55.62823:59:47.251100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:09:29.043 99.0%381 88.000 20391.189450081.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.295 0.0%960 0.000 0.307 1.000
readart00:00:00.188 0.0%61 0.000 3.082 15.500
TOTAL: 02:10:46.20102:09:29.526 99.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet.org.uk0001200
TOTAL0001200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 28 72523 10807 57566 4150 14%48:56:42
2feeder.eternal-september.org 18 53844 6259 42362 5223 11%24:30:10
3news.killfile.org 1 11116 4725 5691 700 42%23:58:56
4news-out.mixmin.net 5 36266 3915 31341 1010 10%24:17:49
5newsfeed.neva.ru 180 112067 3214 91695 17158 2%71:40:30
6ceres.etla.org 14 31290 1714 29576 0 5%25:07:30
7news.netfront.net 1 57957 69 57868 20 0%23:36:23
8localhost 26 1 1 0 0 100%00:00:00
TOTAL: 8 273 375064 30704 316099 28261 8%242:08:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net65.0 MB2.8 KB22.6 MB87.7 MB 74%6.0 KB
2feeder.eternal-september.org21.4 MB0.0 KB48.4 MB69.8 MB 30%6.2 KB
3news.killfile.org17.1 MB175.7 KB5.6 MB22.8 MB 74%4.3 KB
4news-out.mixmin.net9.8 MB0.0 KB2.4 MB12.2 MB 80%2.5 KB
5newsfeed.neva.ru9.2 MB0.0 KB145.9 MB155.1 MB 5%7.8 KB
6ceres.etla.org4.8 MB0.0 KB0.0 KB4.8 MB100%2.9 KB
7news.netfront.net4.6 MB0.0 KB1.5 MB6.1 MB 75%70.3 KB
8localhost0.7 KB0.0 KB0.0 KB0.7 KB100%0.7 KB
TOTAL: 8131.9 MB178.6 KB226.3 MB358.4 MB 36%6.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 19 00:00:01 - 00:59:59 1232 4.0% 0.347.9 MB 6.2% 2.24
Nov 19 01:00:00 - 01:59:59 814 2.7% 0.233.2 MB 2.5% 0.92
Nov 19 02:00:00 - 02:59:59 740 2.4% 0.212.2 MB 1.7% 0.63
Nov 19 03:00:00 - 03:59:59 617 2.0% 0.178.1 MB 6.3% 2.30
Nov 19 04:00:00 - 04:59:59 647 2.1% 0.182.4 MB 1.9% 0.69
Nov 19 05:00:00 - 05:59:59 620 2.0% 0.172.1 MB 1.6% 0.58
Nov 19 06:00:00 - 06:59:59 568 1.9% 0.161.7 MB 1.3% 0.48
Nov 19 07:00:00 - 07:59:59 601 2.0% 0.172.0 MB 1.6% 0.58
Nov 19 08:00:00 - 08:59:59 1034 3.4% 0.293.2 MB 2.5% 0.92
Nov 19 09:00:00 - 09:59:59 1210 4.0% 0.343.6 MB 2.9% 1.04
Nov 19 10:00:00 - 10:59:59 1345 4.4% 0.374.5 MB 3.5% 1.28
Nov 19 11:00:00 - 11:59:59 1549 5.1% 0.434.3 MB 3.4% 1.24
Nov 19 12:00:00 - 12:59:59 1389 4.6% 0.393.3 MB 2.6% 0.94
Nov 19 13:00:00 - 13:59:59 1431 4.7% 0.403.9 MB 3.0% 1.10
Nov 19 14:00:00 - 14:59:59 1543 5.1% 0.436.3 MB 4.9% 1.79
Nov 19 15:00:00 - 15:59:59 1781 5.8% 0.4912.2 MB 9.5% 3.46
Nov 19 16:00:00 - 16:59:59 1822 6.0% 0.5110.0 MB 7.8% 2.85
Nov 19 17:00:00 - 17:59:59 1843 6.0% 0.515.5 MB 4.3% 1.57
Nov 19 18:00:00 - 18:59:59 1690 5.5% 0.475.0 MB 3.9% 1.41
Nov 19 19:00:00 - 19:59:59 1683 5.5% 0.474.7 MB 3.7% 1.34
Nov 19 20:00:00 - 20:59:59 1569 5.1% 0.446.7 MB 5.2% 1.90
Nov 19 21:00:00 - 21:59:59 1563 5.1% 0.434.4 MB 3.4% 1.25
Nov 19 22:00:00 - 22:59:59 1661 5.4% 0.465.9 MB 4.6% 1.67
Nov 19 23:00:00 - 23:59:59 1531 5.0% 0.4314.6 MB 11.5% 4.16
Nov 20 00:00:00 - 00:00:01 1 0.0% 1.001.7 KB 0.0% 1.71
TOTAL: 24:00:00 30484 100.0% 0.35127.7 MB 100.0% 1.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 17075 2751 0 0 0 0 0 014324
2feeder.eternal-september.org 5220 214 0 0 0 0 0 0 5006
3linuxd-out.news.weretis.net 4235 2118 0 1 0 0 0 0 2116
4news-out.mixmin.net 1024 13 0 0 0 0 0 0 1011
5news.killfile.org 707 19 0 6 0 0 0 0 682
6news.netfront.net 26 0 0 0 0 0 0 0 26
7ceres.etla.org 8 0 0 0 0 0 0 0 8
TOTAL: 7 28295 5115 0 7 0 0 0 023173

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 1161
mailing.freebsd.pkg-fallout 297
lada.talk 250
alt.politics 155
lada.auto 149
ut.test 128
mailing.unix.samba 104
mailing.freebsd.ports-bugs 98
it-alt.sport.calcio.juventus 92
mailing.freebsd.svn-ports-all 84
mailing.freebsd.svn-ports-head 84
alt.survival 79
mailing.gcc.gcc-cvs 75
mozilla.community.brasil 75
bofh.link.link.link.link 74
mozilla.general 60
alt.windows7.general 56
time.nuts 55
mpc.lists.freebsd.ports.bugs 55
alt.politics.scorched-earth 47
TOTAL: 344 5115

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 18078
EMP (phn path) 3492
EMP (phl) 856
Too many newsgroups 124
PFM bot misc 119
EMP (phn nph) 118
Binary Image: misplaced jpg 58
User-issued cancel 38
Binary Payload 30
Binary: non-binary distribution 20
Binary: misplaced sfv 12
Too many newsgroups (meow) 12
Binary: misplaced par2 12
Binary: misplaced nzb 12
HTML post 9
Binary: misplaced pdf 7
Binary: misplaced PAR2 5
Too many test groups in crosspost 4
TOTAL: 18 23006

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.killfile.org 33568 580 10497 19376 5 58 1%23:57:53
2etla.org 35641 462 29868 24 0 574 1%23:53:20
3news.netfront.net 54961 413 29989 76 0 807 0%24:00:59
4news.stack.nl 31329 26 29824 21 0 83 0%24:00:19
5neva.ru 28985 14 26999 13 0 39 0%24:01:05
6eternal-september 25702 6 23985 6 0 2 0%23:53:56
7weretis.net 20750 1 19864 7 0 2 0%24:06:28
8news.infinity.loc 0 0 0 0 0 30485 0%24:00:00
TOTAL: 8 230936 1502 171026 19523 5 32050 0%191:54:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org41.2 MB2.6 MB43.8 MB0.5 KB/s92.2 KB23:53:20
2news.netfront.net18.5 MB3.5 MB21.9 MB0.3 KB/s46.0 KB24:00:59
3news.killfile.org2.0 MB87.3 MB89.3 MB1.1 KB/s4.6 KB23:57:53
4neva.ru364.7 KB365.7 KB730.4 KB0.0 KB/s27.1 KB24:01:05
5news.stack.nl205.3 KB33.4 KB238.7 KB0.0 KB/s5.1 KB24:00:19
6eternal-september202.8 KB7.3 KB210.1 KB0.0 KB/s17.5 KB23:53:56
7weretis.net0.7 KB264.5 KB265.3 KB0.0 KB/s33.2 KB24:06:28
8news.infinity.loc0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 862.4 MB94.1 MB156.5 MB0.2 KB/s7.6 KB191:54:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
195.232.225.180 11 61193.8 KB 10 1 002:09:31
TOTAL: 1 11 61193.8 KB 10 1 002:10:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 11 61193.8 KB 10 1 002:09:31
TOTAL: 1 11 61193.8 KB 10 1 002:09:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
95.232.225.180 0.724 0.048 0.00002:09:31
61.145.45.32 0.052 0.000 0.00000:00:10
219.129.233.22 0.032 0.000 0.00000:00:10
198.203.28.9 0.052 0.004 0.00000:00:06
122.241.23.10 0.052 0.000 0.00000:00:04
46.22.98.218 0.052 0.000 0.00000:00:03
95.5.253.76 0.052 0.000 0.00000:00:03
121.204.180.75 0.052 0.000 0.00000:00:02
vc89.vc.panix.com 0.028 0.004 0.00000:00:02
60.22.155.114 0.048 0.004 0.00000:00:02
s010614d64de1df05.vc.shawcable.net 0.048 0.000 0.00000:00:02
113.163.190.61 0.048 0.004 0.00000:00:02
179.26.103.220 0.048 0.004 0.00000:00:01
1.85.99.38 0.052 0.000 0.00000:00:01
061238057133.ctinets.com 0.052 0.000 0.00000:00:01
182.33.123.216 0.048 0.004 0.00000:00:01
220.92.248.211 0.048 0.004 0.00000:00:01
118.216.242.202 0.048 0.004 0.00000:00:01
222.93.109.194 0.048 0.004 0.00000:00:01
39.118.68.19 0.048 0.004 0.00000:00:01
TOTAL: 40 3.052 0.144 0.00002:10:46

NNRP no permission clients:

SystemConn
94.5.28.170 4
cpc15-haye17-2-0-cust412.haye.cable.virginm.net 2
94.156.98.246 2
5ed728a6.cm-7-8a.dynamic.ziggo.nl 2
i5e87c754.versanet.de 2
94.230.137.138 2
113.163.190.61 1
139.206.23.88 1
219.129.233.22 1
110.254.36.21 1
220.92.248.211 1
1.85.99.38 1
222.93.109.194 1
79.174.41.219 1
118.216.242.202 1
218.101.159.183 1
s010614d64de1df05.vc.shawcable.net 1
221.206.221.123 1
46.22.98.218 1
bzq-218-193-177.red.bezeqint.net 1
vc89.vc.panix.com 1
95.5.253.76 1
c-50-158-80-30.hsd1.il.comcast.net 1
119.27.123.8 1
179.26.103.220 1
222.93.9.117 1
113.225.18.64 1
182.45.10.129 1
67.199.185.32 1
27.10.189.242 1
120.5.118.183 1
182.33.123.216 1
60.22.155.114 1
121.204.180.75 1
061238057133.ctinets.com 1
122.241.23.10 1
39.118.68.19 1
198.203.28.9 1
61.145.45.32 1
TOTAL: 39 47

NNRP client timeouts [Top 20]:

SystemConnPeer
95.232.225.180 3 0
TOTAL: 1 3 0

Newsgroup request counts (by category):

CategoryCountPct
1fr 45 73.8%
2it 10 16.4%
3alt 4 6.6%
4de 2 3.3%
TOTAL: 4 61100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 33
2it.test 8
3fr.comp.os.linux.debats 6
4alt.test 4
5fr.usenet.forums.annonces 4
6it.comp.os.linux.sys 2
7fr.test 2
8de.test 2
TOTAL: 8 61