Daily Usenet report for news.niel.me

Dec 15 04:15:01 -- Dec 16 04:15:01

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Dec 15 07:29:39 rpi-studio innfeed[18997]: i2pn.org:0 connect: Network is unreachable
Dec 15 07:29:39 rpi-studio innfeed[18997]: news.tnetconsulting.net:0 connect: Network is unreachable
Dec 15 07:30:42 rpi-studio innfeed[18997]: news.pasdenom.info:0 connect: Network is unreachable
Dec 15 07:31:39 rpi-studio innfeed[18997]: news.tnetconsulting.net:0 connect: Network is unreachable
Dec 15 07:32:19 rpi-studio innfeed[18997]: nntp.terraraq.uk:0 connect: Network is unreachable
Dec 15 07:32:19 rpi-studio innfeed[18997]: news.gegeweb.org:0 connect: Network is unreachable
Dec 15 07:35:39 rpi-studio innfeed[18997]: i2pn.org:0 connect: Network is unreachable
Dec 15 07:49:45 rpi-studio innfeed[18997]: news.nntp4.net:0 connect: Network is unreachable
Dec 15 08:05:07 rpi-studio innfeed[18997]: news.nntp4.net:0 connect: Network is unreachable
Dec 15 08:05:24 rpi-studio innfeed[18997]: nntp.terraraq.uk:0 connect: Network is unreachable
Dec 15 08:09:37 rpi-studio innfeed[18997]: news.pasdenom.info:0 connect: Network is unreachable
Dec 15 08:11:07 rpi-studio innfeed[18997]: news.nntp4.net:0 connect: Network is unreachable
Dec 15 08:11:25 rpi-studio innfeed[18997]: nntp.terraraq.uk:0 connect: Network is unreachable
Dec 15 09:11:22 rpi-studio innfeed[18997]: news.pasdenom.info:0 connect: Network is unreachable
Dec 15 09:17:23 rpi-studio innfeed[18997]: news.pasdenom.info:0 connect: Network is unreachable
Dec 15 09:22:02 rpi-studio innfeed[18997]: news.gegeweb.org:0 connect: Network is unreachable
Dec 15 10:07:39 rpi-studio innfeed[18997]: nntp.terraraq.uk:0 connect: Network is unreachable
Dec 15 17:00:05 rpi-studio pgpverify[6611]: pgpverify: verification failed
Dec 15 17:00:06 rpi-studio pgpverify[6626]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 4939 33.4%841.7 KB 39.2%
innd 4923 33.3%675.2 KB 31.4%
innfeed 2709 18.3%381.9 KB 17.8%
nnrpd 2183 14.8%246.1 KB 11.5%
controlchan 13 0.1%2.3 KB 0.1%
nocem 9 0.1%1.2 KB 0.1%
pgpverify 2 0.0%0.4 KB 0.0%
TOTAL: 7 14778 100.0%2.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22276 65.5%
Negative hits 6895 20.3%
Do not exist 4849 14.2%
Cache misses 14 0.0%
TOTAL: 4 34034 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.067 0.0%25 0.500 2.680 11.333
article cancel00:00:00.006 0.0%31 0.000 0.194 1.000
article cleanup00:00:00.109 0.0%4850 0.000 0.022 0.115
article logging00:00:00.369 0.0%4877 0.000 0.076 0.235
article parse00:00:00.822 0.0%7811 0.000 0.105 0.244
article write00:00:03.765 0.0%4327 0.000 0.870 28.344
artlog/artcncl00:00:00.004 0.0%31 0.000 0.129 1.000
artlog/artcncl/perl00:00:00.002 0.0%25 0.000 0.080 1.000
data move00:00:00.112 0.0%34155 0.000 0.003 0.034
hisgrep/artcncl00:00:00.000 0.0%26 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%25 0.000 0.000 0.000
hisgrep/perl00:00:00.002 0.0%26 0.000 0.077 0.500
hishave/artcncl00:00:00.001 0.0%31 0.000 0.032 1.000
hishave/artcncl/perl00:00:00.000 0.0%25 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.468 0.0%34050 0.000 0.014 0.044
history sync00:00:00.053 0.0%408 0.000 0.130 0.667
history write00:00:01.006 0.0%4850 0.000 0.207 1.364
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle24:00:30.310 99.9%35304 662.558 2448.173 37508.125
nntp read00:00:01.130 0.0%34344 0.000 0.033 0.111
overview write00:00:02.565 0.0%4327 0.077 0.593 7.100
perl filter00:00:22.002 0.0%4850 3.011 4.536 8.139
python filter00:00:00.014 0.0%4850 0.000 0.003 0.077
site send00:00:01.588 0.0%8793 0.014 0.181 0.571
TOTAL: 24:01:17.01524:01:04.395100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.053 0.0%6901 0.000 0.008 0.095
article prepare00:00:00.003 0.0%2508 0.000 0.001 0.036
article read00:00:00.092 0.0%585 0.000 0.157 8.000
backlog stats00:00:00.119 0.0%59801 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.813 0.0%33578 0.000 0.024 0.091
data write00:00:02.257 0.0%30588 0.011 0.074 0.139
idle23:50:38.602 99.9%59801 466.101 1435.404 5760.422
status file00:00:01.562 0.0%560 1.000 2.789 10.333
TOTAL: 23:51:22.61323:50:43.501100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:58.141 22.2%1261 3.000 46.107 1067.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.128 0.0%3033 0.000 0.042 1.667
readart00:00:00.013 0.0%13 1.000 1.000 1.000
TOTAL: 00:04:21.38900:00:58.282 22.3%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 15 3599 1693 1853 53 47%33:21:25
2i2pn.org 17 4287 1128 3063 96 26%37:41:50
3feed-out.gegeweb.org 316 3024 559 2464 1 18%58:03:34
4news.nntp4.net 21 5407 446 4805 156 8%43:20:04
5nntp.terraraq.uk 19 5214 183 4789 242 3%41:37:35
6usenet.pasdenom.info 15 792 26 765 1 3%19:59:34
7gegeweb-out.news.tnetconsulting.net 15 4098 26 4067 5 0%36:07:53
8localhost 28 0 0 0 0 0%00:00:00
TOTAL: 8 446 26421 4061 21806 554 15%270:11:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org4.9 MB0.0 KB173.7 KB5.1 MB 96%3.0 KB
2i2pn.org4.3 MB0.0 KB322.1 KB4.6 MB 93%3.9 KB
3news.nntp4.net2.4 MB0.0 KB823.9 KB3.2 MB 74%5.4 KB
4nntp.terraraq.uk1.7 MB0.0 KB1.0 MB2.8 MB 63%6.6 KB
5feed-out.gegeweb.org1.7 MB0.0 KB0.8 KB1.7 MB 99%3.2 KB
6gegeweb-out.news.tnetconsulting.net460.4 KB0.0 KB34.7 KB495.1 KB 92%16.0 KB
7usenet.pasdenom.info63.7 KB0.0 KB1.2 KB65.0 KB 98%2.4 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 815.6 MB0.0 KB2.3 MB17.9 MB 86%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 15 04:15:01 - 04:59:59 65 1.5% 0.02188.5 KB 1.1% 0.07
Dec 15 05:00:00 - 05:59:59 109 2.5% 0.03500.8 KB 2.8% 0.14
Dec 15 06:00:00 - 06:59:59 106 2.4% 0.03398.4 KB 2.3% 0.11
Dec 15 07:00:00 - 07:59:59 148 3.4% 0.04482.0 KB 2.7% 0.13
Dec 15 08:00:00 - 08:59:59 195 4.5% 0.05692.2 KB 3.9% 0.19
Dec 15 09:00:00 - 09:59:59 148 3.4% 0.04581.8 KB 3.3% 0.16
Dec 15 10:00:00 - 10:59:59 138 3.2% 0.04612.7 KB 3.5% 0.17
Dec 15 11:00:00 - 11:59:59 142 3.3% 0.04545.4 KB 3.1% 0.15
Dec 15 12:00:00 - 12:59:59 138 3.2% 0.04519.9 KB 2.9% 0.14
Dec 15 13:00:00 - 13:59:59 142 3.3% 0.04440.3 KB 2.5% 0.12
Dec 15 14:00:00 - 14:59:59 189 4.4% 0.05532.0 KB 3.0% 0.15
Dec 15 15:00:00 - 15:59:59 219 5.1% 0.06629.4 KB 3.6% 0.17
Dec 15 16:00:00 - 16:59:59 193 4.5% 0.05757.2 KB 4.3% 0.21
Dec 15 17:00:00 - 17:59:59 209 4.8% 0.061016.8 KB 5.8% 0.28
Dec 15 18:00:00 - 18:59:59 252 5.8% 0.07740.0 KB 4.2% 0.21
Dec 15 19:00:00 - 19:59:59 312 7.2% 0.091.1 MB 6.6% 0.32
Dec 15 20:00:00 - 20:59:59 358 8.3% 0.101.6 MB 9.3% 0.46
Dec 15 21:00:00 - 21:59:59 233 5.4% 0.061.6 MB 9.3% 0.45
Dec 15 22:00:00 - 22:59:59 196 4.5% 0.05625.1 KB 3.5% 0.17
Dec 15 23:00:00 - 23:59:59 224 5.2% 0.06913.8 KB 5.2% 0.25
Dec 16 00:00:00 - 00:59:59 175 4.0% 0.05686.2 KB 3.9% 0.19
Dec 16 01:00:00 - 01:59:59 163 3.8% 0.05838.5 KB 4.8% 0.23
Dec 16 02:00:00 - 02:59:59 151 3.5% 0.041.1 MB 6.4% 0.31
Dec 16 03:00:00 - 03:59:59 103 2.4% 0.03286.8 KB 1.6% 0.08
Dec 16 04:00:00 - 04:15:01 24 0.6% 0.0385.2 KB 0.5% 0.09
TOTAL: 24:00:00 4332 100.0% 0.0517.2 MB 100.0% 0.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 223 0 0 0 0 0 0 0 223
2news.nntp4.net 143 0 0 0 0 0 0 0 143
3i2pn.org 96 0 0 0 0 0 0 0 96
4news-out.aioe.org 78 2 0 0 0 0 0 0 76
5gegeweb-out.news.tnetconsulting.net 7 0 0 0 0 0 0 0 7
6feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
7usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
TOTAL: 7 551 2 0 0 0 0 0 0 549

Unwanted newsgroups [Top 20]:

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

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 236
EMP (phn nph) 129
Bad path (news.giganews.com.POSTED) 109
EMP (md5) 40
User-issued spam cancel 7
Cancel of non-existing ID <61b99a00$0$28592$426a34cc@news.free.fr> 1
TOTAL: 6 522

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com6066
TOTAL: 16066

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 25
feed-out.gegeweb.org 1
nntp.terraraq.uk 1
TOTAL: 3 27
TOTAL: 1 27

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 3969 54 3231 416 0 350 1%24:00:00
2news.pasdenom.info 5803 53 3638 16 0 407 0%23:59:37
3i2pn.org 5914 26 3115 38 0 516 0%23:59:36
4news.tnetconsulting.net 7132 23 4305 2 0 593 0%23:59:36
5news.nntp4.net 4260 2 3742 0 0 398 0%23:59:37
6nntp.terraraq.uk 2881 0 2618 0 0 236 0%23:59:36
7news.aioe.org 2551 0 1939 0 0 84 0%23:59:37
TOTAL: 7 32510 158 22588 472 0 2584 0%167:57:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org212.9 KB1.5 MB1.7 MB0.0 KB/s3.7 KB24:00:00
2news.pasdenom.info140.0 KB353.8 KB493.8 KB0.0 KB/s7.2 KB23:59:37
3news.tnetconsulting.net122.5 KB4.1 KB126.6 KB0.0 KB/s5.1 KB23:59:36
4i2pn.org73.3 KB82.2 KB155.6 KB0.0 KB/s2.4 KB23:59:36
5news.nntp4.net5.0 KB0.0 KB5.0 KB0.0 KB/s2.5 KB23:59:37
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:36
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:37
TOTAL: 7553.7 KB1.9 MB2.5 MB0.0 KB/s4.0 KB167:57:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 1 953.0 KB 4 0 000:00:26
TOTAL: 1 1 953.0 KB 4 0 000:04:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 1 953.0 KB 4 0 000:00:26
2*.gegeweb.eu 273 00.0 KB 0 0 000:02:29
3unresolved 10 00.0 KB 0 0 000:01:02
4*.ip.linodeusercontent.com 95 00.0 KB 0 0 000:00:20
5*.ip-145-239-154.eu 6 00.0 KB 0 0 000:00:01
6*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 6 386 953.0 KB 4 0 000:04:20

NNRP auth users [Top 20]:

UserConn
mailman 279
TOTAL: 1 279

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
sys.gegeweb.eu 7.415 8.870 2.80700:02:29
188.165.224.178 0.180 0.195 0.09500:01:01
108b-gniel 0.042 0.042 0.00000:00:26
88-80-186-144.ip.linodeusercontent.com 2.420 1.895 0.00000:00:20
88.165.5.23 0.068 0.048 0.00000:00:01
ns31410049.ip-145-239-154.eu 0.134 0.132 0.00000:00:00
ns31410046.ip-145-239-154.eu 0.070 0.058 0.00000:00:00
94.232.46.80 0.072 0.071 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.025 0.050 0.00000:00:00
TOTAL: 9 10.426 11.361 2.90200:04:20

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 273
88-80-186-144.ip.linodeusercontent.com 95
188.165.224.178 6
ns31410049.ip-145-239-154.eu 4
88.165.5.23 2
ns31410046.ip-145-239-154.eu 2
94.232.46.80 2
scanner-26.ch1.censys-scanner.com 1
TOTAL: 8 385

NNRP unrecognized commands (by host):

SystemConn
ns31410049.ip-145-239-154.eu 2
ns31410046.ip-145-239-154.eu 1
scanner-26.ch1.censys-scanner.com 1
TOTAL: 3 4

NNRP unrecognized commands (by command):

CommandCount
#026#003 3
EHLO www.censys.io 1
TOTAL: 2 4

Newsgroup request counts (by category):

CategoryCountPct
1fr 4 44.4%
2grisbi 4 44.4%
3news 1 11.1%
TOTAL: 3 9100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 4
2grisbi.test 2
3grisbi.bugsreports 2
4news.admin.hierarchies 1
TOTAL: 4 9