Daily Usenet report for news.niel.me

Nov 29 04:15:01 -- Nov 30 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Nov 29 04:15:35 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 04:18:36 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 04:30:37 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 05:18:37 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 07:18:37 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 09:18:37 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 11:18:37 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 13:18:37 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 15:18:37 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 17:18:38 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 19:18:38 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 21:18:38 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 29 23:18:38 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 30 01:18:39 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 30 03:18:40 rpi-studio innfeed[24027]: nntp.terraraq.uk:0 connect: Network is unreachable

Log entries by program:

Program nameLines%LinesSize%Size
inn 5027 41.7%848.6 KB 46.4%
innd 3517 29.1%496.7 KB 27.2%
nnrpd 1930 16.0%211.7 KB 11.6%
innfeed 1587 13.1%271.5 KB 14.8%
nocem 7 0.1%0.7 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 12069 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22491 63.4%
Negative hits 7167 20.2%
Do not exist 4974 14.0%
Cache misses 851 2.4%
TOTAL: 4 35483 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.019 0.0%11 1.000 1.727 6.000
article cancel00:00:00.001 0.0%16 0.000 0.062 1.000
article cleanup00:00:00.102 0.0%4982 0.000 0.020 0.143
article logging00:00:00.384 0.0%5006 0.000 0.077 0.222
article parse00:00:00.843 0.0%8311 0.000 0.101 0.208
article write00:00:02.882 0.0%4270 0.154 0.675 1.667
artlog/artcncl00:00:00.000 0.0%15 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%11 0.000 0.091 1.000
data move00:00:00.102 0.0%34646 0.000 0.003 0.015
hisgrep/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%11 0.000 0.091 1.000
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.494 0.0%35539 0.000 0.014 0.049
history sync00:00:00.055 0.0%408 0.000 0.135 1.500
history write00:00:01.169 0.0%4982 0.050 0.235 0.536
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle24:00:22.529 99.9%35311 521.711 2447.468 10709.232
nntp read00:00:01.180 0.0%34554 0.000 0.034 0.065
overview write00:00:02.929 0.0%4270 0.000 0.686 47.429
perl filter00:00:23.015 0.0%4982 3.106 4.620 9.071
python filter00:00:00.011 0.0%4982 0.000 0.002 0.067
site send00:00:01.109 0.0%8548 0.000 0.130 0.412
TOTAL: 24:01:09.16424:00:56.826100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.051 0.0%4330 0.000 0.012 0.087
article prepare00:00:00.001 0.0%832 0.000 0.001 0.083
article read00:00:00.042 0.0%195 0.000 0.215 6.000
backlog stats00:00:00.115 0.0%59419 0.000 0.002 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.792 0.0%33072 0.000 0.024 0.050
data write00:00:02.062 0.0%28676 0.013 0.072 0.133
idle23:49:55.078100.0%59419 411.032 1443.900 4657.016
status file00:00:00.437 0.0%183 1.000 2.388 8.000
TOTAL: 23:50:01.67023:49:58.578100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:26.558 37.8%1203 21.500 71.952 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.102 0.0%2849 0.000 0.036 1.000
readart00:00:00.008 0.0%9 0.889 0.889 0.889
TOTAL: 00:03:49.23100:01:26.668 37.8%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 171

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 2 4312 2311 1892 109 53%22:42:07
2i2pn.org 1 4226 821 3314 91 19%22:56:19
3feed-out.gegeweb.org 290 3143 470 2658 15 14%23:56:28
4news.nntp4.net 3 4573 319 4053 201 6%24:35:22
5usenet.pasdenom.info 2 5835 208 5623 4 3%47:53:17
6nntp.terraraq.uk 2 3860 67 3521 272 1%04:59:06
7gegeweb-out.news.tnetconsulting.net 1 4023 16 4004 3 0%23:57:17
8localhost 27 0 0 0 0 0%00:00:00
TOTAL: 8 328 29972 4212 25065 695 14%170:59:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org7.5 MB0.0 KB362.5 KB7.8 MB 95%3.3 KB
2i2pn.org3.2 MB0.0 KB336.0 KB3.6 MB 90%4.0 KB
3news.nntp4.net3.0 MB0.0 KB572.6 KB3.6 MB 84%7.0 KB
4feed-out.gegeweb.org1.4 MB0.0 KB16.4 KB1.4 MB 98%2.9 KB
5gegeweb-out.news.tnetconsulting.net937.2 KB0.0 KB7.2 KB944.4 KB 99%49.7 KB
6usenet.pasdenom.info558.1 KB0.0 KB10.2 KB568.3 KB 98%2.7 KB
7nntp.terraraq.uk305.8 KB0.0 KB846.8 KB1.1 MB 26%3.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 816.9 MB0.0 KB2.1 MB19.0 MB 88%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 29 04:15:01 - 04:59:59 88 2.1% 0.03242.8 KB 1.4% 0.09
Nov 29 05:00:00 - 05:59:59 162 3.8% 0.04481.2 KB 2.8% 0.13
Nov 29 06:00:00 - 06:59:59 137 3.2% 0.04413.2 KB 2.4% 0.11
Nov 29 07:00:00 - 07:59:59 91 2.1% 0.03295.8 KB 1.7% 0.08
Nov 29 08:00:00 - 08:59:59 109 2.6% 0.03312.8 KB 1.8% 0.09
Nov 29 09:00:00 - 09:59:59 130 3.0% 0.04431.7 KB 2.5% 0.12
Nov 29 10:00:00 - 10:59:59 135 3.2% 0.04513.7 KB 3.0% 0.14
Nov 29 11:00:00 - 11:59:59 128 3.0% 0.04396.8 KB 2.3% 0.11
Nov 29 12:00:00 - 12:59:59 112 2.6% 0.03305.1 KB 1.8% 0.08
Nov 29 13:00:00 - 13:59:59 145 3.4% 0.04687.5 KB 4.0% 0.19
Nov 29 14:00:00 - 14:59:59 194 4.5% 0.05597.3 KB 3.5% 0.17
Nov 29 15:00:00 - 15:59:59 172 4.0% 0.051.2 MB 7.4% 0.35
Nov 29 16:00:00 - 16:59:59 188 4.4% 0.05610.4 KB 3.5% 0.17
Nov 29 17:00:00 - 17:59:59 216 5.1% 0.06729.5 KB 4.2% 0.20
Nov 29 18:00:00 - 18:59:59 235 5.5% 0.07945.2 KB 5.5% 0.26
Nov 29 19:00:00 - 19:59:59 285 6.7% 0.081.0 MB 6.0% 0.29
Nov 29 20:00:00 - 20:59:59 269 6.3% 0.071.3 MB 8.0% 0.38
Nov 29 21:00:00 - 21:59:59 307 7.2% 0.091.1 MB 6.7% 0.32
Nov 29 22:00:00 - 22:59:59 335 7.9% 0.091.3 MB 7.9% 0.38
Nov 29 23:00:00 - 23:59:59 280 6.6% 0.081.2 MB 6.9% 0.33
Nov 30 00:00:00 - 00:59:59 143 3.4% 0.04734.5 KB 4.3% 0.20
Nov 30 01:00:00 - 01:59:59 168 3.9% 0.05952.4 KB 5.5% 0.26
Nov 30 02:00:00 - 02:59:59 139 3.3% 0.04972.5 KB 5.6% 0.27
Nov 30 03:00:00 - 03:59:59 74 1.7% 0.02189.9 KB 1.1% 0.05
Nov 30 04:00:00 - 04:15:02 23 0.5% 0.0353.8 KB 0.3% 0.06
TOTAL: 24:00:01 4265 100.0% 0.0516.8 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 299 0 0 0 0 0 0 0 299
2news.nntp4.net 184 1 0 0 0 0 0 0 183
3news-out.aioe.org 133 1 0 0 0 0 0 0 132
4i2pn.org 100 0 0 0 0 0 0 0 100
5feed-out.gegeweb.org 16 0 0 0 0 0 0 0 16
6usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
7gegeweb-out.news.tnetconsulting.net 2 0 0 0 0 0 0 0 2
TOTAL: 7 736 2 0 0 0 0 0 0 734

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
fr.petites-annonces.informatique.materiel 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 364
EMP (phn nph) 135
Bad path (news.giganews.com.POSTED) 118
EMP (md5) 50
User-issued spam cancel 30
EMP (phl) 13
TOTAL: 6 710

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com5055
TOTAL: 15055

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 22
news.nntp4.net 1
feed-out.gegeweb.org 1
TOTAL: 3 24
TOTAL: 1 24

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6554 38 3336 19 0 48 0%23:59:58
2news.tnetconsulting.net 7410 33 4226 3 0 31 0%23:59:58
3news.gegeweb.org 3821 10 3677 81 0 0 0%23:59:58
4news.aioe.org 1597 8 1460 0 0 0 0%23:47:14
5news.pasdenom.info 4887 5 3589 9 0 0 0%23:59:41
6news.nntp4.net 4730 2 3971 0 0 0 0%23:59:36
7nntp.terraraq.uk 0 0 0 0 0 2720 0%23:59:57
TOTAL: 7 28999 96 20259 112 0 2799 0%167:46:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net157.2 KB7.0 KB164.2 KB0.0 KB/s4.6 KB23:59:58
2i2pn.org131.9 KB38.1 KB170.0 KB0.0 KB/s3.0 KB23:59:58
3news.gegeweb.org41.9 KB420.6 KB462.5 KB0.0 KB/s5.1 KB23:59:58
4news.aioe.org22.6 KB0.0 KB22.6 KB0.0 KB/s2.8 KB23:47:14
5news.pasdenom.info12.7 KB483.5 KB496.1 KB0.0 KB/s35.4 KB23:59:41
6news.nntp4.net8.5 KB0.0 KB8.5 KB0.0 KB/s4.3 KB23:59:36
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 7374.8 KB949.1 KB1.3 MB0.0 KB/s6.4 KB167:46:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 1 715.0 KB 6 0 000:00:46
TOTAL: 1 1 715.0 KB 6 0 000:03:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 715.0 KB 6 0 000:00:46
2*.gegeweb.eu 288 00.0 KB 0 0 000:02:13
3*.zbau.f3netze.de 1 00.0 KB 0 0 000:00:00
4*.anonymizing-proxy.digitalcourage.de 1 00.0 KB 0 0 000:00:04
5unresolved 19 00.0 KB 0 0 000:00:35
6*.for-privacy.net 2 00.0 KB 0 0 000:00:07
7*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 7 313 715.0 KB 6 0 000:03:48

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
sys.gegeweb.eu 6.357 7.570 3.08100:02:13
108b-gniel 0.031 0.051 0.00000:00:46
167.172.17.220 0.015 0.029 0.00000:00:10
23.129.64.139 0.081 0.018 0.00000:00:07
23.129.64.215 0.078 0.052 0.00000:00:07
tor-exit-relay-5.anonymizing-proxy.digitalcourage.de 0.061 0.010 0.00000:00:04
tor-exit-60.for-privacy.net 0.029 0.048 0.00000:00:03
185.220.101.156 0.022 0.056 0.00000:00:03
tor-exit-40.for-privacy.net 0.045 0.034 0.00000:00:03
23.129.64.219 0.158 0.082 0.00000:00:02
88.165.5.23 0.148 0.089 0.00000:00:02
185.220.101.171 0.054 0.072 0.00000:00:01
tor-exit-5.zbau.f3netze.de 0.053 0.021 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.038 0.019 0.00000:00:00
91.218.114.111 0.038 0.029 0.00000:00:00
45.153.160.136 0.081 0.031 0.00000:00:00
158.101.219.32 0.035 0.035 0.00000:00:00
TOTAL: 17 7.324 8.246 3.08100:03:48

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
23.129.64.219 4
88.165.5.23 4
185.220.101.171 2
45.153.160.136 2
23.129.64.215 2
tor-exit-5.zbau.f3netze.de 1
tor-exit-40.for-privacy.net 1
158.101.219.32 1
tor-exit-relay-5.anonymizing-proxy.digitalcourage.de 1
tor-exit-60.for-privacy.net 1
scanner-21.ch1.censys-scanner.com 1
23.129.64.139 1
167.172.17.220 1
185.220.101.156 1
91.218.114.111 1
TOTAL: 16 312

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-21.ch1.censys-scanner.com 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 3 42.9%
2comp 2 28.6%
3fr 2 28.6%
TOTAL: 3 7100.0%

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

NewsgroupCount
1grisbi.bugsreports 2
2comp.sys.raspberry-pi 1
3grisbi.test 1
4comp.infosystems.gemini 1
5fr.usenet.divers 1
6fr.usenet.forums.evolution 1
TOTAL: 6 7