Daily Usenet report for news.niel.me

Feb 6 04:15:01 -- Feb 7 04:15:01

Unknown entries from news log file:

First 37 / 37 lines (100.0%)

Feb 6 08:23:36 rpi-studio innd: SERVER changed -c 0
Feb 6 08:28:56 rpi-studio controlchan[6168]: Control article too old (Sun, 15 Nov 2020 20:31:58 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:29:08 rpi-studio controlchan[6168]: Control article too old (Mon, 16 Nov 2020 12:27:50 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:30:38 rpi-studio controlchan[6168]: Control article too old (Fri, 20 Nov 2020 13:29:01 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:30:49 rpi-studio controlchan[6168]: Control article too old (Fri, 20 Nov 2020 21:20:53 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:33:08 rpi-studio controlchan[6168]: Control article too old (Thu, 26 Nov 2020 19:47:36 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:34:31 rpi-studio controlchan[6168]: Control article too old (Tue, 1 Dec 2020 00:04:01 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:34:33 rpi-studio controlchan[6168]: Control article too old (Tue, 1 Dec 2020 01:52:02 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:36:06 rpi-studio controlchan[6168]: Control article too old (Sat, 5 Dec 2020 08:42:07 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:40:16 rpi-studio controlchan[6168]: Control article too old (Tue, 15 Dec 2020 16:00:02 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:42:39 rpi-studio controlchan[6168]: Control article too old (Tue, 22 Dec 2020 07:30:02 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:42:39 rpi-studio controlchan[6168]: Control article too old (Tue, 22 Dec 2020 08:15:15 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:43:54 rpi-studio controlchan[6168]: Control article too old (Fri, 25 Dec 2020 21:38:55 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:46:26 rpi-studio controlchan[6168]: Control article too old (Fri, 1 Jan 2021 00:04:01 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:46:28 rpi-studio controlchan[6168]: Control article too old (Fri, 1 Jan 2021 01:52:02 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:46:59 rpi-studio controlchan[6168]: Control article too old (Sat, 2 Jan 2021 05:39:24 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:48:50 rpi-studio controlchan[6168]: Control article too old (Wed, 6 Jan 2021 11:36:18 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:51:01 rpi-studio controlchan[6168]: Control article too old (Mon, 11 Jan 2021 12:18:37 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:51:10 rpi-studio controlchan[6168]: Control article too old (Mon, 11 Jan 2021 19:08:18 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:51:17 rpi-studio controlchan[6168]: Control article too old (Tue, 12 Jan 2021 00:31:22 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:51:17 rpi-studio controlchan[6168]: Control article too old (Tue, 12 Jan 2021 00:31:26 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:44 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 10:45:59 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:44 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 10:53:40 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:44 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:00:23 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:45 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:03:00 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:45 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:05:36 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:45 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:08:00 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:45 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:17:58 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:45 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:30:39 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:45 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:30:40 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:45 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 11:34:19 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:52:49 rpi-studio controlchan[6168]: Control article too old (Wed, 13 Jan 2021 15:46:19 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:53:31 rpi-studio controlchan[6168]: Control article too old (Fri, 15 Jan 2021 16:00:01 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:54:17 rpi-studio controlchan[6168]: Control article too old (Sun, 17 Jan 2021 08:51:08 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:56:20 rpi-studio controlchan[6168]: Control article too old (Thu, 21 Jan 2021 19:05:39 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:57:55 rpi-studio controlchan[6168]: Control article too old (Wed, 27 Jan 2021 06:50:01 -0000 (UTC)), artcutoff set to 10 days
Feb 6 08:58:52 rpi-studio controlchan[6168]: Unknown "block" control by robomod@news.nic.it

Log entries by program:

Program nameLines%LinesSize%Size
inn 478730 98.4%44.8 MB 97.7%
innd 3963 0.8%620.5 KB 1.3%
nocem 1820 0.4%243.3 KB 0.5%
nnrpd 1524 0.3%142.9 KB 0.3%
innfeed 629 0.1%76.8 KB 0.2%
controlchan 57 0.0%8.9 KB 0.0%
rnews 1 0.0%0.1 KB 0.0%
TOTAL: 7 486724 100.0%45.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 394320 98.4%
Positive hits 3680 0.9%
Negative hits 2581 0.6%
Cache misses 15 0.0%
TOTAL: 4 400596 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.046 0.0%8 0.000 5.750 18.000
article cancel00:00:00.388 0.0%4213 0.000 0.092 0.500
article cleanup00:00:03.933 0.0%390922 0.000 0.010 0.125
article logging00:00:15.804 0.0%394524 0.000 0.040 0.333
article parse00:00:44.789 0.1%796178 0.000 0.056 0.267
article write00:04:07.531 0.3%390345 0.000 0.634 3.644
artlog/artcncl00:00:00.108 0.0%3598 0.000 0.030 0.333
artlog/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 0.500
data move00:00:02.458 0.0%493613 0.000 0.005 0.056
hisgrep/artcncl00:00:00.011 0.0%656 0.000 0.017 0.500
hisgrep/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl00:00:00.050 0.0%4213 0.000 0.012 0.500
hishave/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.056 0.0%396493 0.000 0.010 0.179
history sync00:00:00.048 0.0%400 0.000 0.120 2.333
history write00:00:26.129 0.0%390822 0.000 0.067 0.750
hiswrite/artcncl00:00:00.170 0.0%3557 0.000 0.048 0.500
idle23:32:16.792 99.4%421925 3.072 200.834 75045.625
nntp read00:00:22.752 0.0%421645 0.000 0.054 0.211
overview write00:01:10.683 0.1%390345 0.000 0.181 4.915
perl filter00:00:13.447 0.0%390822 0.000 0.034 6.906
python filter00:00:00.409 0.0%390826 0.000 0.001 0.083
site send00:00:29.121 0.0%393124 0.000 0.074 0.385
TOTAL: 23:41:07.53723:40:18.726 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.012 0.0%1317 0.000 0.009 0.062
article prepare00:00:00.000 0.0%92 0.000 0.000 0.000
article read00:00:00.016 0.0%23 0.000 0.696 6.000
backlog stats00:00:00.030 0.0%12127 0.000 0.002 0.037
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.140 0.0%4782 0.000 0.029 0.333
data write00:00:00.353 0.0%3489 0.000 0.101 0.286
idle23:18:16.200100.0%12127 1392.991 6918.133 23323.407
status file00:00:00.193 0.0%108 0.000 1.787 6.000
TOTAL: 23:18:18.05923:18:16.944100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:38:28.317 82.4%664 83.455 3476.381 43968.733
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.262 0.0%7042 0.000 0.179 2.624
readart00:00:01.630 0.1%4038 0.000 0.404 3.143
TOTAL: 00:46:42.88200:38:31.209 82.5%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
param 1
pause 2
paused 2
perl 1
python 1
reload 18
reserve 2
shutdown 9
TOTAL: 15 198

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001001
news@sfere.anjou.terraraq.org.uk001001
us-control@lists.killfile.org001001
TOTAL003003

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 8 472132 467611 4414 107 99%24:36:45
2news-out.aioe.org 2 1701 976 301 424 57%07:23:57
3localhost 33 4 4 0 0 100%00:00:00
4gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0%00:00:00
TOTAL: 4 44 473837 468591 4715 531 98%32:00:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org1.7 GB474.1 KB476.2 KB1.7 GB 99%3.9 KB
2news-out.aioe.org3.7 MB27.7 KB1.5 MB5.2 MB 69%3.8 KB
3localhost7.5 KB0.0 KB0.0 KB7.5 KB100%1.9 KB
4gegeweb-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 41.7 GB501.8 KB2.0 MB1.7 GB 99%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 6 04:15:01 - 04:59:59 65 0.0% 0.02178.9 KB 0.0% 0.07
Feb 6 05:00:00 - 05:59:59 56 0.0% 0.02161.0 KB 0.0% 0.04
Feb 6 06:00:00 - 06:59:59 57 0.0% 0.02174.3 KB 0.0% 0.05
Feb 6 07:00:00 - 07:59:59 76 0.0% 0.02301.9 KB 0.0% 0.08
Feb 6 08:00:00 - 08:59:59 455626 97.2% 126.561.7 GB 97.2% 491.56
Feb 6 09:00:00 - 09:59:59 9187 2.0% 2.5536.6 MB 2.1% 10.42
Feb 6 10:00:00 - 10:59:59 121 0.0% 0.03425.4 KB 0.0% 0.12
Feb 6 11:00:00 - 11:59:59 231 0.0% 0.061.7 MB 0.1% 0.47
Feb 6 12:00:00 - 12:59:59 133 0.0% 0.04579.9 KB 0.0% 0.16
Feb 6 13:00:00 - 13:59:59 204 0.0% 0.06702.4 KB 0.0% 0.20
Feb 6 14:00:00 - 14:59:59 219 0.0% 0.06784.7 KB 0.0% 0.22
Feb 6 15:00:00 - 15:59:59 209 0.0% 0.06631.0 KB 0.0% 0.18
Feb 6 16:00:00 - 16:59:59 230 0.0% 0.061.0 MB 0.1% 0.29
Feb 6 17:00:00 - 17:59:59 216 0.0% 0.06639.0 KB 0.0% 0.18
Feb 6 18:00:00 - 18:59:59 286 0.1% 0.08969.5 KB 0.1% 0.27
Feb 6 19:00:00 - 19:59:59 262 0.1% 0.07765.2 KB 0.0% 0.21
Feb 6 20:00:00 - 20:59:59 222 0.0% 0.06881.7 KB 0.0% 0.24
Feb 6 21:00:00 - 21:59:59 232 0.0% 0.06804.8 KB 0.0% 0.22
Feb 6 22:00:00 - 22:59:59 187 0.0% 0.05663.1 KB 0.0% 0.18
Feb 6 23:00:00 - 23:59:59 294 0.1% 0.081.0 MB 0.1% 0.29
Feb 7 00:00:00 - 00:59:59 140 0.0% 0.04601.4 KB 0.0% 0.17
Feb 7 01:00:00 - 01:59:59 133 0.0% 0.04474.2 KB 0.0% 0.13
Feb 7 02:00:00 - 02:59:59 68 0.0% 0.02291.2 KB 0.0% 0.08
Feb 7 03:00:00 - 03:59:59 71 0.0% 0.02257.8 KB 0.0% 0.07
Feb 7 04:00:00 - 04:15:01 19 0.0% 0.0249.4 KB 0.0% 0.05
TOTAL: 24:00:00 468544 100.0% 5.421.7 GB 100.0% 21.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feed-out.gegeweb.org 4390 2 0 105 0 0 0 0 4283
2news-out.aioe.org 460 0 0 11 0 0 0 0 449
3gegeweb-out.news.tnetconsulting.net 40 0 0 0 0 0 0 0 40
TOTAL: 3 4890 2 0 116 0 0 0 0 4772

Unwanted newsgroups [Top 20]:

NewsgroupCount
france.rhone-alpes.annecy 1
france.admin.evolutions 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Bad path (postnews.google.com) 439
Bad path (news.giganews.com.POSTED) 38
HTML Multipart 1
TOTAL: 3 478

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com1117013031303
nocem@aioe.org454241843843
news@uni-berlin.de0100
TOTAL: 3157124221462146

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 4283
news-out.aioe.org 11
TOTAL: 2 4294
TOTAL: 1 4294

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.tnetconsulting.net 2175 19 1142 0 0 24 0%07:16:59
2news.gegeweb.org 1071 4 1052 0 0 0 0%09:14:34
3news.aioe.org 298 0 287 0 0 0 0%06:48:29
TOTAL: 3 3544 23 2481 0 0 24 0%23:20:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net80.6 KB0.0 KB80.6 KB0.0 KB/s4.2 KB07:16:59
2news.gegeweb.org7.5 KB0.0 KB7.5 KB0.0 KB/s1.9 KB09:14:34
3news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s006:48:29
TOTAL: 388.0 KB0.0 KB88.0 KB0.0 KB/s3.8 KB23:20:02
Outgoing feeds (innfeed) by Volume

Rnews connections rejected:

ReasonConn
What server? 1
TOTAL: 1 1

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mbp-gniel.niel.me 29 41114.8 KB 20 2 000:33:03
22a03:4980:104:100:566:68fe:fd1a:dd9e 13 16454.3 KB 9 1 1000:08:21
3192.168.1.18 8 1322.3 KB 7 1 000:05:15
TOTAL: 3 50 70591.4 KB 36 4 1000:46:48

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.niel.me 29 41114.8 KB 20 2 000:33:03
2? 14 16454.3 KB 9 1 1000:08:27
TOTAL: 2 43 70591.4 KB 36 4 1000:41:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mbp-gniel.niel.me 1.264 1.611 0.00000:33:03
2a03:4980:104:100:566:68fe:fd1a:dd9e 1.295 0.951 0.00000:08:21
192.168.1.18 0.510 0.947 0.00000:05:15
localhost 0.018 0.009 0.00000:00:06
tncsrv06.tnetconsulting.net 0.222 0.168 0.00000:00:02
TOTAL: 5 3.309 3.686 0.00000:46:48

Curious NNRP server explorers [Top 20]:

SystemConn
localhost 1
TOTAL: 1 1

NNRP no permission clients:

SystemConn
tncsrv06.tnetconsulting.net 7
192.168.1.18 1
TOTAL: 2 8

Newsgroup request counts (by category):

CategoryCountPct
1news 23 32.9%
2grisbi 17 24.3%
3fr 14 20.0%
4local 12 17.1%
5control 3 4.3%
6misc 1 1.4%
TOTAL: 6 70100.0%

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

NewsgroupCount
1local.test 12
2fr.usenet.forums.evolution 10
3news.admin.peering 9
4grisbi.bugsreports 7
5grisbi.admin 6
6news.admin.hierarchies 5
7news.software.readers 4
8news.announce.newgroups 3
9fr.bienvenue 3
10control.cancel 2
11grisbi.info 2
12grisbi.user.french 2
13news.answers 1
14news.admin.announce 1
15control 1
16misc.test 1
17fr.usenet.divers 1
TOTAL: 17 70
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me