Daily Usenet report for paganini.linuxd.org

Jun 22 00:00:02 -- Jun 23 00:00:02

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Jun 22 06:17:23 paganini overchan[29991]: input line too long, skipping
Jun 22 06:57:06 paganini overchan[29991]: input line too long, skipping
Jun 22 07:10:39 paganini overchan[29991]: input line too long, skipping
Jun 22 07:16:04 paganini overchan[29991]: input line too long, skipping
Jun 22 07:33:06 paganini overchan[29991]: input line too long, skipping
Jun 22 08:20:21 paganini overchan[29991]: input line too long, skipping
Jun 22 08:30:01 paganini pgpverify[25243]: pgpverify: verification failed
Jun 22 16:58:15 paganini overchan[29991]: input line too long, skipping
Jun 23 00:00:02 paganini overchan[11845]: 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 101409 46.2%12.6 MB 40.7%
nnrpd 78126 35.6%9.0 MB 29.2%
inn 30640 14.0%7.7 MB 25.0%
innd 9104 4.1%1.5 MB 5.0%
nocem 85 0.0%15.1 KB 0.0%
overchan 9 0.0%1.5 KB 0.0%
controlchan 5 0.0%0.6 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 8 219379 100.0%30.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 114982 58.7%
Negative hits 51062 26.1%
Do not exist 29733 15.2%
Cache misses 36 0.0%
TOTAL: 4 195813 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.681 0.0%109 0.000 6.248 60.500
article cleanup00:00:00.193 0.0%29961 0.000 0.006 0.029
article logging00:00:00.372 0.0%30528 0.000 0.012 0.310
article parse00:00:00.614 0.0%41713 0.000 0.015 0.035
article write00:00:52.221 0.1%21965 0.128 2.377 10.548
artlog/artcncl00:00:00.001 0.0%106 0.000 0.009 0.056
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.125 0.0%204333 0.000 0.001 0.003
hisgrep/artcncl00:00:00.001 0.0%109 0.000 0.009 0.040
hishave/artcncl00:00:00.002 0.0%109 0.000 0.018 0.333
hissync/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.858 0.0%197381 0.018 0.050 0.470
history sync00:00:00.022 0.0%403 0.000 0.055 0.667
history write00:00:36.140 0.0%29961 0.022 1.206 9.623
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:28.937 99.7%200333 225.457 430.528 1137.508
nntp read00:00:01.508 0.0%205069 0.002 0.007 0.020
overview write00:00:20.150 0.0%21965 0.015 0.917 3.529
perl filter00:00:52.150 0.1%29961 1.043 1.741 3.922
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.345 0.0%66091 0.000 0.020 0.060
TOTAL: 24:01:09.19324:00:24.320 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.106 0.0%36897 0.000 0.003 0.018
article prepare00:00:00.002 0.0%37756 0.000 0.000 0.003
article read00:00:03.794 0.0%7237 0.000 0.524 11.867
backlog stats00:00:00.261 0.0%349478 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.523 0.0%191725 0.001 0.008 0.020
data write00:00:03.069 0.0%170034 0.008 0.018 0.035
idle23:42:27.358 99.3%349478 152.803 244.214 400.048
status file00:10:11.076 0.7%42364 8.259 14.424 28.611
TOTAL: 23:53:03.47223:52:47.189100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:10:02.951 97.5%78896 37.669 53.272 4725.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:17.173 1.8%205582 0.000 0.375 1.660
readart00:00:00.000 0.0%3 0.000 0.000 0.000
TOTAL: 01:11:52.51601:11:20.124 99.2%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
ba-mod@panix.com000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 3 46608 19182 25818 1608 41%47:44:14
2newsfeed.neva.ru 154 70386 2261 61819 6306 3%74:27:14
3news.fcku.it 1 6664 396 6216 52 5%22:29:43
4nntp.pasdenom.info 3 22261 50 22208 3 0%22:04:45
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 186 145919 21889 116061 7969 15%166:45:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net65.8 MB0.0 KB6.9 MB72.7 MB 90%3.6 KB
2newsfeed.neva.ru5.6 MB0.0 KB23.4 MB29.0 MB 19%3.5 KB
3news.fcku.it1.3 MB0.0 KB301.3 KB1.6 MB 81%3.6 KB
4nntp.pasdenom.info116.3 KB0.0 KB9.1 KB125.5 KB 92%2.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 572.8 MB0.0 KB30.6 MB103.4 MB 70%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 22 00:00:02 - 00:59:59 900 4.1% 0.253.8 MB 5.2% 1.08
Jun 22 01:00:00 - 01:59:59 699 3.2% 0.193.1 MB 4.2% 0.88
Jun 22 02:00:00 - 02:59:59 649 3.0% 0.182.0 MB 2.7% 0.56
Jun 22 03:00:00 - 03:59:59 545 2.5% 0.151.9 MB 2.6% 0.54
Jun 22 04:00:00 - 04:59:59 528 2.4% 0.152.0 MB 2.7% 0.56
Jun 22 05:00:00 - 05:59:59 436 2.0% 0.122.2 MB 3.0% 0.62
Jun 22 06:00:00 - 06:59:59 498 2.3% 0.142.3 MB 3.2% 0.66
Jun 22 07:00:00 - 07:59:59 457 2.1% 0.131.8 MB 2.4% 0.51
Jun 22 08:00:00 - 08:59:59 541 2.5% 0.152.3 MB 3.1% 0.64
Jun 22 09:00:00 - 09:59:59 904 4.1% 0.252.6 MB 3.6% 0.75
Jun 22 10:00:00 - 10:59:59 928 4.2% 0.263.3 MB 4.5% 0.94
Jun 22 11:00:00 - 11:59:59 1006 4.6% 0.282.7 MB 3.7% 0.76
Jun 22 12:00:00 - 12:59:59 1175 5.4% 0.333.0 MB 4.1% 0.86
Jun 22 13:00:00 - 13:59:59 1060 4.8% 0.293.7 MB 5.0% 1.04
Jun 22 14:00:00 - 14:59:59 1135 5.2% 0.323.0 MB 4.1% 0.86
Jun 22 15:00:00 - 15:59:59 1139 5.2% 0.323.7 MB 5.0% 1.05
Jun 22 16:00:00 - 16:59:59 1264 5.8% 0.353.5 MB 4.8% 1.01
Jun 22 17:00:00 - 17:59:59 1251 5.7% 0.353.9 MB 5.3% 1.10
Jun 22 18:00:00 - 18:59:59 1262 5.7% 0.354.4 MB 6.0% 1.25
Jun 22 19:00:00 - 19:59:59 1206 5.5% 0.344.0 MB 5.4% 1.13
Jun 22 20:00:00 - 20:59:59 1079 4.9% 0.303.3 MB 4.5% 0.93
Jun 22 21:00:00 - 21:59:59 1132 5.2% 0.313.2 MB 4.4% 0.92
Jun 22 22:00:00 - 22:59:59 1057 4.8% 0.293.7 MB 5.0% 1.04
Jun 22 23:00:00 - 23:59:59 1076 4.9% 0.304.0 MB 5.4% 1.13
Jun 23 00:00:00 - 00:00:02 24 0.1% 12.0079.1 KB 0.1% 39.56
TOTAL: 24:00:00 21951 100.0% 0.2573.3 MB 100.0% 0.87
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 6374 395 0 0 0 0 0 0 5979
2linuxd-out.news.weretis.net 2159 570 0 0 0 0 0 0 1589
3news.fcku.it 44 7 0 0 0 0 0 0 37
4nntp.pasdenom.info 7 0 0 0 0 0 0 0 7
TOTAL: 4 8584 972 0 0 0 0 0 0 7612

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 125
it-alt.sport.calcio.juventus 104
lada.talk 98
lada.auto 69
mpc.lists.freebsd.ports.bugs 38
it.annunci.immobiliari 36
alt.survival 33
it.annunci.varie 32
alt.windows7.general 31
it.annunci.commerciali 31
mozilla.general 30
spline.eisfair 25
gmane.linux.alsa.devel 24
it.comp.os.win.windows10 17
mozilla.dev.platform 15
mpc.lists.nanog 14
gmane.comp.gis.openstreetmap 13
mozilla.dev.security.policy 11
alt.politics 10
mozilla.support.firefox 9
TOTAL: 104 972

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6059
EMP (phn path) 722
EMP (phl) 119
Too many newsgroups 55
Binary Image: misplaced jpg 28
User-issued cancel 21
EMP (phn nph) 16
Too many newsgroups (meow) 7
Binary Payload 5
Binary: non-binary distribution 4
Binary: misplaced par2 3
HTML post 2
Binary: misplaced r23 1
HTML Multipart without Text/Plain. 1
Binary: misplaced nfo 1
Binary: misplaced sfv 1
TOTAL: 16 7045

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 537
newsfeed.neva.ru 29
news.fcku.it 1
TOTAL: 3 567
TOTAL: 1 567

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 37155 3081 17678 1055 0 632 8%23:57:45
2news.fcku.it 28193 1939 16613 3063 0 239 6%23:59:52
3weretis.net 2816 116 2499 0 0 12 4%23:59:52
4neva.ru 28217 24 19455 199 0 110 0%23:59:52
5eternal-september 24925 23 18924 0 0 22 0%23:59:52
6news.mixmin.net 0 0 0 0 0 0 0%00:10:00
7news.killfile.org 2851 0 0 0 0 24801 0%23:59:52
8vc89.vc.panix.com 2842 0 0 0 0 24792 0%23:59:52
9news.netfront.net 2759 0 0 0 0 24662 0%23:59:51
10etla.org 0 0 0 0 0 21951 0%23:59:52
11news.albasani.net 2861 0 0 0 0 23862 0%23:59:52
12news.stack.nl 2860 0 0 0 0 24690 0%23:59:52
TOTAL: 12 135479 5183 75169 4317 0 145773 3%264:06:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info9.7 MB2.5 MB12.2 MB0.1 KB/s3.0 KB23:57:45
2news.fcku.it5.6 MB10.0 MB15.5 MB0.2 KB/s3.2 KB23:59:52
3weretis.net213.7 KB0.0 KB213.7 KB0.0 KB/s1.8 KB23:59:52
4eternal-september85.9 KB0.0 KB85.9 KB0.0 KB/s3.7 KB23:59:52
5neva.ru72.4 KB1.0 MB1.1 MB0.0 KB/s5.1 KB23:59:52
6news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
7news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
8vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 1215.7 MB13.5 MB29.2 MB0.0 KB/s3.1 KB264:06:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 141 35.0 KB 3 0 001:10:25
TOTAL: 1 141 35.0 KB 3 0 001:11:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 141 35.0 KB 3 0 001:10:25
2*.to.ca.prserv.net 1 00.0 KB 0 0 000:00:00
3*.dyn.295.ca 1 00.0 KB 0 0 000:01:25
TOTAL: 3 143 35.0 KB 3 0 001:11:51

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 15.248 3.640 0.00001:10:25
host-208-72-123-130.dyn.295.ca 0.072 0.016 0.00000:01:25
slip32-102-142-236.to.ca.prserv.net 0.044 0.012 0.00000:00:00
TOTAL: 3 15.364 3.668 0.00001:11:51

Curious NNRP server explorers [Top 20]:

SystemConn
host-208-72-123-130.dyn.295.ca 1
slip32-102-142-236.to.ca.prserv.net 1
TOTAL: 2 2

Newsgroup request counts (by category):

CategoryCountPct
1alt 1 33.3%
2de 1 33.3%
3control 1 33.3%
TOTAL: 3 3100.0%

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

NewsgroupCount
1control.cancel 1
2de.soc.kontakte.misc 1
3alt.test 1
TOTAL: 3 3