Daily Usenet report for paganini.linuxd.org

Nov 15 00:00:01 -- Nov 16 00:00:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Nov 15 17:00:04 paganini pgpverify[3854]: pgpverify: verification failed
Nov 15 17:27:30 paganini overchan[7600]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)
Nov 15 17:52:52 paganini overchan[9879]: 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
inn 42203 59.6%9.1 MB 68.6%
innd 24689 34.8%3.7 MB 27.9%
innfeed 3068 4.3%392.8 KB 2.9%
nnrpd 769 1.1%74.7 KB 0.5%
nocem 128 0.2%14.8 KB 0.1%
controlchan 5 0.0%0.5 KB 0.0%
overchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 70867 100.0%13.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 207918 50.2%
Negative hits 164165 39.7%
Do not exist 41716 10.1%
Cache misses 139 0.0%
TOTAL: 4 413938 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.739 0.0%290 0.000 2.548 255.000
article cleanup00:00:00.262 0.0%41737 0.000 0.006 0.333
article logging00:00:00.311 0.0%41907 0.000 0.007 0.167
article parse00:00:01.063 0.0%97085 0.000 0.011 0.167
article write00:00:49.665 0.1%28065 0.000 1.770 62.417
artlog/artcncl00:00:00.001 0.0%289 0.000 0.003 0.250
data move00:00:00.163 0.0%445567 0.000 0.000 0.011
hisgrep/artcncl00:00:00.058 0.0%257 0.000 0.226 16.000
hishave/artcncl00:00:00.003 0.0%290 0.000 0.010 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:16.669 0.0%414250 0.000 0.040 1.834
history sync00:00:00.343 0.0%1131 0.000 0.303 188.000
history write00:00:59.593 0.1%41731 0.000 1.428 33.571
hiswrite/artcncl00:00:00.000 0.0%33 0.000 0.000 0.000
idle23:53:27.682 99.6%432274 32.030 198.966 1231.551
nntp read00:00:02.368 0.0%442371 0.000 0.005 0.025
overview write00:00:32.763 0.0%28065 0.000 1.167 26.588
perl filter00:01:52.395 0.1%41731 0.524 2.693 55.169
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:06.401 0.0%112540 0.000 0.057 0.200
TOTAL: 23:59:45.17123:58:10.479 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.083 0.0%29105 0.000 0.003 0.143
article prepare00:00:00.009 0.0%76298 0.000 0.000 0.083
article read00:00:17.037 0.0%18130 0.000 0.940 143.000
backlog stats00:00:00.142 0.0%379069 0.000 0.000 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.090 0.0%253916 0.000 0.008 0.120
data write00:00:03.040 0.0%230896 0.000 0.013 0.074
idle23:58:34.776100.0%379069 49.684 227.702 1586.211
status file00:00:06.164 0.0%204 0.000 30.216 362.000
TOTAL: 23:59:10.95523:59:03.341100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:39:31.213 99.0%640 84.444 14955.020 50423.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.434 0.0%1906 0.000 0.228 1.000
readart00:00:00.281 0.0%232 0.049 1.211 1.658
TOTAL: 02:41:10.47202:39:31.928 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 6
reserve 2
TOTAL: 11 171

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 2 60915 10937 46809 3169 17%48:13:13
2feeder.eternal-september.org 4 37080 5001 30229 1850 13%24:21:56
3news.killfile.org 1 9476 4812 4123 541 50%24:28:44
4newsfeed.neva.ru 147 83341 3531 72730 7080 4%71:53:42
5news-out.mixmin.net 3 32791 2544 29387 860 7%24:01:05
6ceres.etla.org 1 25280 1250 24030 0 4%23:30:06
7localhost 26 1 1 0 0 100%00:00:00
8news.stack.nl 1 0 0 0 0 0%00:10:00
TOTAL: 8 185 248884 28076 207308 13500 11%216:38:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net87.8 MB42.1 KB11.9 MB99.7 MB 88%7.2 KB
2news.killfile.org22.0 MB115.4 KB5.2 MB27.3 MB 80%5.2 KB
3feeder.eternal-september.org17.6 MB0.0 KB21.1 MB38.7 MB 45%5.8 KB
4newsfeed.neva.ru11.5 MB3.5 KB33.8 MB45.2 MB 25%4.4 KB
5news-out.mixmin.net5.9 MB0.0 KB2.2 MB8.1 MB 73%2.4 KB
6ceres.etla.org3.4 MB0.0 KB0.0 KB3.4 MB100%2.8 KB
7localhost2.1 KB0.0 KB0.0 KB2.1 KB100%2.1 KB
8news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 8148.3 MB161.1 KB74.1 MB222.6 MB 66%5.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 15 00:00:01 - 00:59:59 1059 3.8% 0.295.6 MB 3.8% 1.58
Nov 15 01:00:00 - 01:59:59 898 3.2% 0.255.7 MB 3.9% 1.63
Nov 15 02:00:00 - 02:59:59 750 2.7% 0.212.5 MB 1.7% 0.71
Nov 15 03:00:00 - 03:59:59 595 2.1% 0.174.4 MB 3.0% 1.25
Nov 15 04:00:00 - 04:59:59 531 1.9% 0.151.8 MB 1.2% 0.51
Nov 15 05:00:00 - 05:59:59 650 2.3% 0.184.4 MB 3.0% 1.26
Nov 15 06:00:00 - 06:59:59 627 2.2% 0.174.0 MB 2.7% 1.13
Nov 15 07:00:00 - 07:59:59 599 2.1% 0.174.5 MB 3.0% 1.28
Nov 15 08:00:00 - 08:59:59 888 3.2% 0.2523.0 MB 15.5% 6.54
Nov 15 09:00:00 - 09:59:59 1038 3.7% 0.294.3 MB 2.9% 1.22
Nov 15 10:00:00 - 10:59:59 1007 3.6% 0.286.1 MB 4.1% 1.72
Nov 15 11:00:00 - 11:59:59 1232 4.4% 0.347.8 MB 5.2% 2.21
Nov 15 12:00:00 - 12:59:59 1355 4.8% 0.384.2 MB 2.9% 1.20
Nov 15 13:00:00 - 13:59:59 1352 4.8% 0.388.6 MB 5.8% 2.45
Nov 15 14:00:00 - 14:59:59 1239 4.4% 0.343.6 MB 2.4% 1.03
Nov 15 15:00:00 - 15:59:59 1569 5.6% 0.447.1 MB 4.8% 2.01
Nov 15 16:00:00 - 16:59:59 1581 5.6% 0.446.0 MB 4.1% 1.72
Nov 15 17:00:00 - 17:59:59 1679 6.0% 0.474.5 MB 3.0% 1.27
Nov 15 18:00:00 - 18:59:59 1843 6.6% 0.514.8 MB 3.3% 1.37
Nov 15 19:00:00 - 19:59:59 1660 5.9% 0.464.8 MB 3.3% 1.37
Nov 15 20:00:00 - 20:59:59 1645 5.9% 0.467.4 MB 5.0% 2.10
Nov 15 21:00:00 - 21:59:59 1613 5.7% 0.4515.1 MB 10.2% 4.29
Nov 15 22:00:00 - 22:59:59 1380 4.9% 0.384.4 MB 3.0% 1.25
Nov 15 23:00:00 - 23:59:59 1278 4.6% 0.353.4 MB 2.3% 0.98
Nov 16 00:00:00 - 00:00:02 3 0.0% 1.509.6 KB 0.0% 4.82
TOTAL: 24:00:01 28071 100.0% 0.32148.0 MB 100.0% 1.75
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7310 1623 0 1 0 0 0 0 5686
2linuxd-out.news.weretis.net 3213 1133 0 2 0 0 0 0 2078
3feeder.eternal-september.org 1926 157 0 0 0 0 0 0 1769
4news-out.mixmin.net 852 12 0 0 0 0 0 0 840
5news.killfile.org 538 5 0 3 0 0 0 0 530
6ceres.etla.org 4 0 0 0 0 0 0 0 4
TOTAL: 6 13843 2930 0 6 0 0 0 010907

Unwanted newsgroups [Top 20]:

NewsgroupCount
pld.cvs.commit 419
fa.linux.kernel 197
ut.test 184
alt.politics 155
lada.talk 123
mailing.freebsd.ports-bugs 92
mpc.lists.freebsd.ports.bugs 92
alt.windows7.general 62
it-alt.sport.calcio.juventus 57
mailing.freebsd.svn-ports-all 41
mailing.openbsd.ports-changes 39
mozilla.general 38
mailing.freebsd.svn-ports-head 38
24hoursupport.helpdesk 37
mozilla.support.seamonkey 35
fa.freebsd.current 29
mailing.freebsd.current 29
fa.openbsd.source-changes 26
alt.politics.scorched-earth 26
lada.auto 26
TOTAL: 329 2930

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6774
EMP (phn path) 2428
EMP (phl) 1019
PFM bot misc 113
Too many newsgroups 105
EMP (phn nph) 95
User-issued cancel 62
Binary Image: misplaced jpg 24
Binary: non-binary distribution 18
Binary: misplaced par2 17
Binary: misplaced sfv 16
Too many newsgroups (meow) 16
Binary Payload 14
Binary: misplaced nzb 14
Binary: misplaced PAR2 9
Binary: misplaced pdf 6
HTML post 2
Binary Image: misplaced gif 1
MI5 Filter 1
TOTAL: 19 10734

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1etla.org 33299 651 27284 33 0 342 1%23:55:52
2news.killfile.org 30732 561 10244 17243 2 85 1%24:00:40
3news.netfront.net 51504 437 27499 101 1 417 0%23:59:56
4neva.ru 26732 10 24159 9 0 15 0%24:01:40
5news.stack.nl 28487 9 27297 13 0 153 0%23:56:26
6weretis.net 17708 2 17056 0 0 42 0%23:56:26
7eternal-september 24138 1 22870 0 0 2 0%23:57:21
8news.infinity.loc 0 0 0 0 0 28017 0%23:54:24
9news.mixmin.net 0 0 0 0 0 0 0%00:20:00
TOTAL: 9 212600 1671 156409 17399 3 29073 0%192:02:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org64.0 MB1.7 MB65.8 MB0.8 KB/s98.4 KB23:55:52
2news.netfront.net22.8 MB3.9 MB26.7 MB0.3 KB/s50.8 KB23:59:56
3news.killfile.org2.1 MB99.5 MB101.7 MB1.2 KB/s5.8 KB24:00:40
4neva.ru155.1 KB162.4 KB317.5 KB0.0 KB/s16.7 KB24:01:40
5news.stack.nl82.5 KB24.4 KB107.0 KB0.0 KB/s4.9 KB23:56:26
6weretis.net33.5 KB0.0 KB33.5 KB0.0 KB/s16.7 KB23:56:26
7eternal-september2.1 KB0.0 KB2.1 KB0.0 KB/s2.1 KB23:57:21
8news.infinity.loc0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:24
9news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:20:00
TOTAL: 989.3 MB105.3 MB194.6 MB0.3 KB/s10.4 KB192:02:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
195.232.225.180 3 149222.4 KB 7 1 000:52:30
295.237.168.232 3 83182.8 KB 14 0 001:47:17
TOTAL: 2 6 232405.1 KB 21 1 002:41:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 3 232405.1 KB 21 1 001:47:17
TOTAL: 1 3 232405.1 KB 21 1 001:47:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
95.237.168.232 0.260 0.012 0.00001:47:17
95.232.225.180 3.644 0.236 0.00000:52:30
116.17.222.228 0.044 0.008 0.00000:00:09
121.30.136.135 0.052 0.000 0.00000:00:04
60.244.13.47 0.052 0.000 0.00000:00:03
119.178.39.55 0.044 0.008 0.00000:00:03
177.102.67.44 0.052 0.000 0.00000:00:03
175.42.60.226 0.052 0.000 0.00000:00:02
223.252.23.130 0.044 0.004 0.00000:00:02
n219077200060.netvigator.com 0.052 0.000 0.00000:00:02
115.212.155.129 0.052 0.000 0.00000:00:02
vc89.vc.panix.com 0.052 0.000 0.00000:00:02
78.189.21.180 0.052 0.004 0.00000:00:01
222.223.28.54 0.048 0.004 0.00000:00:01
220-129-17-144.dynamic.hinet.net 0.052 0.000 0.00000:00:01
175.44.42.117 0.048 0.004 0.00000:00:01
111.53.148.71 0.060 0.000 0.00000:00:01
111.6.253.190 0.052 0.000 0.00000:00:01
181.118.146.10 0.048 0.004 0.00000:00:01
218.11.40.16 0.048 0.008 0.00000:00:01
TOTAL: 60 6.832 0.416 0.00002:41:10

NNRP no permission clients:

SystemConn
95.232.225.180 70
94.231.77.242 2
221.199.61.138 1
183.59.121.128 1
119.178.39.55 1
119.165.57.107 1
111.192.61.160 1
220-129-17-144.dynamic.hinet.net 1
182.40.164.218 1
60.19.205.40 1
n219077200060.netvigator.com 1
78.189.21.180 1
120.12.58.139 1
60.244.13.47 1
175.44.42.117 1
120.213.136.248 1
117.247.116.15 1
177.102.67.44 1
122.199.106.107 1
115.212.155.129 1
222.223.28.54 1
37-146-220-150.broadband.corbina.ru 1
dynamic-adsl-94-37-203-199.clienti.tiscali.it 1
79.114.93.217 1
36.99.196.214 1
111.73.155.56 1
221.200.217.111 1
static1-208-243.hosting.sbb.rs 1
223.252.23.130 1
125.111.148.212 1
188.243.58.73 1
110.244.49.99 1
vc89.vc.panix.com 1
218.11.40.16 1
113.228.27.122 1
112.243.130.7 1
121.227.217.9 1
111.53.148.71 1
103.4.108.202 1
113.120.92.245 1
175.42.60.226 1
182.33.0.116 1
ppp-238-139.24-151.libero.it 1
1.59.180.170 1
171.93.226.147 1
112.251.150.214 1
120.69.216.240 1
183.212.201.118 1
117.218.164.225 1
123.117.130.227 1
121.30.136.135 1
181.118.146.10 1
182.201.56.116 1
187.150.6.235 1
112.225.45.77 1
39.113.8.38 1
61-227-100-35.dynamic.hinet.net 1
111.6.253.190 1
116.17.222.228 1
TOTAL: 59 129

NNRP client timeouts [Top 20]:

SystemConnPeer
95.237.168.232 3 0
TOTAL: 1 3 0

Newsgroup request counts (by category):

CategoryCountPct
1de 127 54.7%
2it 71 30.6%
3fr 33 14.2%
4news 1 0.4%
TOTAL: 4 232100.0%

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

NewsgroupCount
1de.test 127
2it.test 42
3fr.test 30
4it.comp.os.linux.ubuntu 10
5it.comp.os.linux.sys 9
6it.news.gestione 8
7fr.comp.os.linux.debats 3
8it.news.annunci 1
9it.news.net-abuse 1
10news.admin.hierarchies 1
TOTAL: 10 232