Daily Usenet report for paganini.linuxd.org

Jul 9 00:00:02 -- Jul 10 00:00:02

Unknown entries from news log file:

First 26 / 26 lines (100.0%)

Jul 9 01:30:34 paganini overchan[32279]: input line too long, skipping
Jul 9 06:33:48 paganini nnrpd[9267]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 06:33:48 paganini nnrpd[9267]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 06:33:49 paganini nnrpd[9268]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 06:33:49 paganini nnrpd[9268]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 06:33:49 paganini nnrpd[9269]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 06:33:49 paganini nnrpd[9269]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 06:33:50 paganini nnrpd[9270]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 06:33:50 paganini nnrpd[9270]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 06:33:51 paganini nnrpd[9271]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 06:33:51 paganini nnrpd[9271]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 10:59:13 paganini nnrpd[4364]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 10:59:13 paganini nnrpd[4364]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 10:59:13 paganini nnrpd[4365]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 10:59:13 paganini nnrpd[4365]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 10:59:14 paganini nnrpd[4366]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 10:59:14 paganini nnrpd[4366]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 10:59:15 paganini nnrpd[4367]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 10:59:15 paganini nnrpd[4367]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 10:59:15 paganini nnrpd[4368]: unable to get certificate from '/etc/news/cert.pem'
Jul 9 10:59:15 paganini nnrpd[4368]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 9 15:07:27 paganini overchan[32279]: input line too long, skipping
Jul 9 20:29:32 paganini overchan[32279]: input line too long, skipping
Jul 9 20:42:35 paganini overchan[32279]: input line too long, skipping
Jul 9 20:52:41 paganini overchan[32279]: input line too long, skipping
Jul 9 22:59:52 paganini overchan[32279]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 103355 64.3%12.7 MB 54.1%
inn 33312 20.7%7.6 MB 32.3%
innd 13278 8.3%2.0 MB 8.6%
nnrpd 10818 6.7%1.2 MB 5.0%
nocem 77 0.0%13.0 KB 0.1%
overchan 7 0.0%1.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 160848 100.0%23.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 99821 51.4%
Negative hits 61397 31.6%
Do not exist 32761 16.9%
Cache misses 53 0.0%
TOTAL: 4 194032 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.494 0.0%157 0.000 3.146 30.000
article cleanup00:00:00.211 0.0%32937 0.000 0.006 0.024
article logging00:00:00.269 0.0%33198 0.000 0.008 0.026
article parse00:00:00.812 0.0%62511 0.000 0.013 0.030
article write00:00:52.321 0.1%20203 0.119 2.590 28.276
artlog/artcncl00:00:00.001 0.0%152 0.000 0.007 0.067
data move00:00:00.112 0.0%228354 0.000 0.000 0.002
hisgrep/artcncl00:00:00.036 0.0%156 0.000 0.231 1.381
hishave/artcncl00:00:00.002 0.0%157 0.000 0.013 0.111
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.338 0.0%194881 0.017 0.053 0.523
history sync00:00:00.071 0.0%401 0.000 0.177 16.000
history write00:00:49.126 0.1%32937 0.048 1.492 5.608
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:54.567 99.7%214124 210.313 402.639 1124.989
nntp read00:00:01.634 0.0%218101 0.000 0.007 0.015
overview write00:00:21.006 0.0%20203 0.000 1.040 4.700
perl filter00:01:17.507 0.1%32937 1.235 2.353 4.520
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.254 0.0%60843 0.000 0.021 0.059
TOTAL: 24:01:13.00924:00:29.761 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.102 0.0%36058 0.000 0.003 0.017
article prepare00:00:00.000 0.0%12248 0.000 0.000 0.000
article read00:00:01.526 0.0%2611 0.000 0.584 35.833
backlog stats00:00:00.190 0.0%296445 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.204 0.0%154999 0.001 0.008 0.017
data write00:00:02.086 0.0%134780 0.006 0.015 0.029
idle23:43:00.152 99.3%296445 190.022 288.013 476.539
status file00:10:07.101 0.7%43264 8.438 14.032 23.317
TOTAL: 23:53:29.87123:53:12.361100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:10:05.736 99.6%23642 0.000 482.435600125.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.589 0.0%47685 0.000 0.012 0.450
readart00:00:05.219 0.0%10278 0.155 0.508 5.575
TOTAL: 03:10:49.98003:10:11.544 99.7%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 4 51785 17050 29644 5091 32%48:11:54
2newsfeed.neva.ru 141 73264 2088 63935 7241 2%71:33:12
3news.fcku.it 1 8828 1154 7372 302 13%26:25:36
4nntp.pasdenom.info 2 0 0 0 0 0%00:20:01
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 173 133877 20292 100951 12634 15%146:30:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net59.0 MB0.0 KB51.0 MB110.0 MB 53%5.1 KB
2newsfeed.neva.ru6.0 MB0.0 KB27.0 MB33.0 MB 18%3.6 KB
3news.fcku.it3.5 MB0.0 KB6.2 MB9.7 MB 36%6.8 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: 568.4 MB0.0 KB84.3 MB152.7 MB 44%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 9 00:00:02 - 00:59:59 958 4.7% 0.273.6 MB 5.3% 1.03
Jul 9 01:00:00 - 01:59:59 791 3.9% 0.223.1 MB 4.6% 0.89
Jul 9 02:00:00 - 02:59:59 686 3.4% 0.192.7 MB 3.9% 0.76
Jul 9 03:00:00 - 03:59:59 519 2.6% 0.141.7 MB 2.5% 0.49
Jul 9 04:00:00 - 04:59:59 519 2.6% 0.141.8 MB 2.6% 0.50
Jul 9 05:00:00 - 05:59:59 480 2.4% 0.132.2 MB 3.3% 0.63
Jul 9 06:00:00 - 06:59:59 462 2.3% 0.131.7 MB 2.5% 0.48
Jul 9 07:00:00 - 07:59:59 420 2.1% 0.121.5 MB 2.2% 0.42
Jul 9 08:00:00 - 08:59:59 553 2.7% 0.151.5 MB 2.2% 0.44
Jul 9 09:00:00 - 09:59:59 772 3.8% 0.212.1 MB 3.1% 0.60
Jul 9 10:00:00 - 10:59:59 814 4.0% 0.232.3 MB 3.3% 0.64
Jul 9 11:00:00 - 11:59:59 815 4.0% 0.232.2 MB 3.2% 0.62
Jul 9 12:00:00 - 12:59:59 942 4.7% 0.263.1 MB 4.6% 0.89
Jul 9 13:00:00 - 13:59:59 918 4.5% 0.262.9 MB 4.3% 0.83
Jul 9 14:00:00 - 14:59:59 823 4.1% 0.232.6 MB 3.8% 0.74
Jul 9 15:00:00 - 15:59:59 855 4.2% 0.242.5 MB 3.7% 0.72
Jul 9 16:00:00 - 16:59:59 1093 5.4% 0.303.3 MB 4.8% 0.93
Jul 9 17:00:00 - 17:59:59 1170 5.8% 0.334.0 MB 5.8% 1.13
Jul 9 18:00:00 - 18:59:59 1132 5.6% 0.313.1 MB 4.6% 0.89
Jul 9 19:00:00 - 19:59:59 1126 5.6% 0.313.2 MB 4.6% 0.90
Jul 9 20:00:00 - 20:59:59 1207 6.0% 0.347.2 MB 10.6% 2.06
Jul 9 21:00:00 - 21:59:59 1080 5.4% 0.302.8 MB 4.1% 0.80
Jul 9 22:00:00 - 22:59:59 1071 5.3% 0.303.8 MB 5.6% 1.09
Jul 9 23:00:00 - 23:59:59 970 4.8% 0.273.1 MB 4.6% 0.89
Jul 10 00:00:00 - 00:00:02 2 0.0% 1.007.4 KB 0.0% 3.70
TOTAL: 24:00:00 20178 100.0% 0.2368.1 MB 100.0% 0.81
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7314 510 0 0 0 0 0 0 6804
2linuxd-out.news.weretis.net 5334 786 0 0 0 0 0 0 4548
3news.fcku.it 334 0 0 0 0 0 0 0 334
TOTAL: 3 12982 1296 0 0 0 0 0 011686

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 171
mailing.freebsd.pkg-fallout 139
it-alt.sport.calcio.juventus 91
lada.talk 80
mailing.freebsd.ports-bugs 46
mozilla.support.thunderbird 45
fa.freebsd.cvs-all 40
alt.politics.scorched-earth 36
mpc.lists.nanog 31
fa.freebsd.bugs 28
fa.caml 24
it.comp.os.win.windows10 23
alt.survival 22
lada.auto 18
mailing.freebsd.bugs 18
alt.windows7.general 17
fa.openbsd.source-changes 15
ut.test 15
mailing.freebsd.svn-src-all 15
mailing.freebsd.svn-ports-all 14
TOTAL: 153 1296

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5060
EMP (phn path) 4948
EMP (phl) 707
EMP (phn nph) 342
PFM bot misc 224
Too many newsgroups 75
Binary Payload 32
Binary: non-binary distribution 14
User-issued cancel 13
Binary Image: misplaced jpg 2
Too many newsgroups (meow) 2
Angle-bracket bot 1
HTML post 1
Binary: misplaced cmd 1
Binary: misplaced rar 1
User-issued spam cancel 1
TOTAL: 16 11424

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 226
newsfeed.neva.ru 22
news.fcku.it 14
TOTAL: 3 262
TOTAL: 1 262

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 24734 573 17419 1043 0 11 2%23:57:49
2nntp.pasdenom.info 35373 500 18992 484 0 1833 1%23:51:23
3weretis.net 3532 166 3011 1 0 8 4%23:50:32
4neva.ru 26919 134 17640 162 0 18 0%23:50:01
5news.netfront.net 2755 0 0 0 0 22855 0%23:59:21
6news.mixmin.net 0 0 0 0 0 0 0%00:10:00
7news.killfile.org 2847 0 0 0 0 23016 0%23:59:37
8vc89.vc.panix.com 2839 0 0 0 0 23008 0%23:59:37
9etla.org 0 0 0 0 0 20039 0%23:50:01
10eternal-september 0 0 0 0 0 16655 0%23:50:01
11news.albasani.net 2858 0 0 0 0 22370 0%23:59:42
12news.stack.nl 2857 0 0 0 0 22941 0%23:59:52
TOTAL: 12 104714 1373 57062 1690 0 152754 1%263:17:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info2.5 MB1.7 MB4.2 MB0.0 KB/s4.4 KB23:51:23
2news.fcku.it1.8 MB3.3 MB5.0 MB0.1 KB/s3.2 KB23:57:49
3neva.ru938.6 KB524.5 KB1.4 MB0.0 KB/s4.9 KB23:50:01
4weretis.net387.0 KB8.5 KB395.5 KB0.0 KB/s2.4 KB23:50:32
5news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:21
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:37
8vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:37
9etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
10eternal-september0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
11news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 125.5 MB5.5 MB11.0 MB0.0 KB/s3.7 KB263:17:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-04-1177941735.dsl.bell.ca 120 21155.5 KB 16 0 000:39:40
TOTAL: 1 120 21155.5 KB 16 0 003:10:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 120 21155.5 KB 16 0 000:39:40
2*.nielsenmedia.com 14 00.0 KB 0 0 002:00:25
3unresolved 15 00.0 KB 0 0 000:30:17
4*.188.099.pools.vodafone-ip.de 123 00.0 KB 0 0 000:00:25
TOTAL: 4 272 21155.5 KB 16 0 003:10:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.780 0.080 0.00002:00:25
mtrlpq2314w-lp140-04-1177941735.dsl.bell.ca 7.760 1.492 0.00000:39:40
71.98.160.36 0.156 0.008 0.00000:30:10
dslb-188-099-106-132.188.099.pools.vodafone-ip.de 6.540 0.364 0.00000:00:25
192.96.206.162 0.324 0.024 0.00000:00:03
207.244.97.52 0.332 0.032 0.00000:00:02
94.102.49.190 0.052 0.004 0.00000:00:00
TOTAL: 7 15.944 2.004 0.00003:10:49

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-099-106-132.188.099.pools.vodafone-ip.de 123
challenger.nielsenmedia.com 14
192.96.206.162 6
207.244.97.52 6
71.98.160.36 2
94.102.49.190 1
TOTAL: 6 152

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 3 2
71.98.160.36 1 0
TOTAL: 2 4 2

Newsgroup request counts (by category):

CategoryCountPct
1alt 11 52.4%
2rec 4 19.0%
3talk 3 14.3%
4uk 2 9.5%
5misc 1 4.8%
TOTAL: 5 21100.0%

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

NewsgroupCount
1rec.arts.tv 4
2alt.happy.valley 4
3alt.christnet.christianlife 3
4alt.home.repair 2
5talk.politics.misc 2
6alt.atheism 1
7misc.survivalism 1
8uk.sport.cricket 1
9alt.comp.os.windows-10 1
10talk.politics.guns 1
11uk.rec.drugs.cannabis 1
TOTAL: 11 21