Daily Usenet report for news.niel.me

Nov 24 04:15:02 -- Nov 25 04:15:01

Unknown entries from news log file:

First 32 / 32 lines (100.0%)

Nov 24 09:36:27 rpi-studio innfeed[31507]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 24 09:36:32 rpi-studio innfeed[31507]: news.pasdenom.info:0 connect: Network is unreachable
Nov 24 09:36:32 rpi-studio innfeed[31507]: news.nntp4.net:0 connect: Network is unreachable
Nov 24 09:36:32 rpi-studio innfeed[31507]: news.gegeweb.org:0 connect: Network is unreachable
Nov 24 09:36:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 09:38:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 09:42:27 rpi-studio innfeed[31507]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 24 09:42:32 rpi-studio innfeed[31507]: news.pasdenom.info:0 connect: Network is unreachable
Nov 24 09:42:32 rpi-studio innfeed[31507]: news.nntp4.net:0 connect: Network is unreachable
Nov 24 09:42:32 rpi-studio innfeed[31507]: news.gegeweb.org:0 connect: Network is unreachable
Nov 24 09:50:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 10:06:27 rpi-studio innfeed[31507]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 24 10:06:32 rpi-studio innfeed[31507]: news.pasdenom.info:0 connect: Network is unreachable
Nov 24 10:06:32 rpi-studio innfeed[31507]: news.nntp4.net:0 connect: Network is unreachable
Nov 24 10:06:32 rpi-studio innfeed[31507]: news.gegeweb.org:0 connect: Network is unreachable
Nov 24 10:06:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 11:38:27 rpi-studio innfeed[31507]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 24 11:38:32 rpi-studio innfeed[31507]: news.pasdenom.info:0 connect: Network is unreachable
Nov 24 11:38:32 rpi-studio innfeed[31507]: news.nntp4.net:0 connect: Network is unreachable
Nov 24 11:38:32 rpi-studio innfeed[31507]: news.gegeweb.org:0 connect: Network is unreachable
Nov 24 11:38:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 12:38:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 13:38:27 rpi-studio innfeed[31507]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 24 13:38:32 rpi-studio innfeed[31507]: news.pasdenom.info:0 connect: Network is unreachable
Nov 24 13:38:32 rpi-studio innfeed[31507]: news.nntp4.net:0 connect: Network is unreachable
Nov 24 13:38:32 rpi-studio innfeed[31507]: news.gegeweb.org:0 connect: Network is unreachable
Nov 24 14:38:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 24 15:38:27 rpi-studio innfeed[31507]: nntp.terraraq.uk:0 connect: Network is unreachable
Nov 24 15:38:32 rpi-studio innfeed[31507]: news.pasdenom.info:0 connect: Network is unreachable
Nov 24 15:38:32 rpi-studio innfeed[31507]: news.nntp4.net:0 connect: Network is unreachable
Nov 24 15:38:32 rpi-studio innfeed[31507]: news.gegeweb.org:0 connect: Network is unreachable
Nov 24 15:38:37 rpi-studio innfeed[31507]: news.tnetconsulting.net:0 connect: Network is unreachable

Log entries by program:

Program nameLines%LinesSize%Size
inn 4994 43.2%854.7 KB 48.4%
innd 3132 27.1%473.0 KB 26.8%
nnrpd 1784 15.4%194.8 KB 11.0%
innfeed 1652 14.3%240.6 KB 13.6%
nocem 9 0.1%0.9 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 11572 100.0%1.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22032 65.4%
Negative hits 6443 19.1%
Do not exist 4926 14.6%
Cache misses 269 0.8%
TOTAL: 4 33670 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.011 0.0%8 1.000 1.375 2.500
article cancel00:00:00.005 0.0%16 0.000 0.312 1.000
article cleanup00:00:00.103 0.0%4958 0.000 0.021 0.136
article logging00:00:00.363 0.0%4980 0.000 0.073 0.286
article parse00:00:00.880 0.0%8802 0.019 0.100 0.263
article write00:00:06.532 0.0%4417 0.222 1.479 80.577
artlog/artcncl00:00:00.001 0.0%15 0.000 0.067 0.333
artlog/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.089 0.0%32876 0.000 0.003 0.016
hisgrep/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%8 0.000 0.125 0.500
hisgrep/perl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
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:00.440 0.0%33945 0.000 0.013 0.043
history sync00:00:00.042 0.0%378 0.000 0.111 2.333
history write00:00:00.866 0.0%4958 0.000 0.175 0.529
hiswrite/artcncl00:00:00.003 0.0%7 0.000 0.429 1.000
idle24:00:28.070 99.9%33655 643.417 2568.060300491.000
nntp read00:00:01.062 0.0%32920 0.000 0.032 0.063
overview write00:00:03.615 0.0%4417 0.048 0.818 43.154
perl filter00:00:20.674 0.0%4958 1.810 4.170 11.613
python filter00:00:00.012 0.0%4959 0.000 0.002 0.036
site send00:00:01.240 0.0%8844 0.000 0.140 0.446
TOTAL: 24:01:15.74224:01:04.009100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.078 0.0%9715 0.000 0.008 0.167
article prepare00:00:00.002 0.0%1040 0.000 0.002 0.125
article read00:00:00.038 0.0%229 0.000 0.166 4.000
backlog stats00:00:00.121 0.0%54044 0.000 0.002 0.030
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.656 0.0%30781 0.000 0.021 0.074
data write00:00:01.853 0.0%26386 0.000 0.070 0.138
idle23:57:02.601100.0%54044 336.806 1595.415 18791.906
status file00:00:00.836 0.0%256 1.000 3.266 14.833
TOTAL: 23:57:09.74123:57:06.185100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle00:10:39.729 86.5%1066 4.500 600.121 15061.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.087 0.0%2776 0.000 0.031 0.500
readart00:00:00.082 0.0%166 0.399 0.494 3.500
TOTAL: 00:12:19.35900:10:39.898 86.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 2 3303 1644 1634 25 49%18:10:54
2i2pn.org 3 4401 1190 3127 84 27%19:35:43
3nntp.terraraq.uk 3 4238 956 2953 329 22%19:33:17
4feed-out.gegeweb.org 225 3105 206 2898 1 6%19:25:53
5usenet.pasdenom.info 2 3271 120 3148 3 3%19:21:52
6news.nntp4.net 2 2450 96 2286 68 3%14:39:40
7gegeweb-out.news.tnetconsulting.net 2 4117 40 4057 20 0%19:16:58
8localhost 29 1 1 0 0 100%00:00:00
TOTAL: 8 268 24886 4253 20103 530 17%130:04:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org5.2 MB0.0 KB108.2 KB5.3 MB 97%3.2 KB
2i2pn.org4.6 MB0.0 KB288.1 KB4.9 MB 94%3.9 KB
3nntp.terraraq.uk4.1 MB0.0 KB1.1 MB5.2 MB 78%4.2 KB
4news.nntp4.net964.1 KB0.0 KB137.2 KB1.1 MB 87%6.7 KB
5feed-out.gegeweb.org650.8 KB0.0 KB1.2 KB652.0 KB 99%3.1 KB
6gegeweb-out.news.tnetconsulting.net617.6 KB0.0 KB84.4 KB702.0 KB 87%11.7 KB
7usenet.pasdenom.info225.2 KB0.0 KB3.5 KB228.7 KB 98%1.9 KB
8localhost2.4 KB0.0 KB0.0 KB2.4 KB100%2.4 KB
TOTAL: 816.2 MB0.0 KB1.7 MB18.0 MB 90%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 24 04:15:02 - 04:59:59 108 2.5% 0.041.2 MB 0.0% 0.46
Nov 24 05:00:00 - 05:59:59 113 2.6% 0.03711.5 KB 0.0% 0.20
Nov 24 06:00:00 - 06:59:59 142 3.2% 0.04460.7 KB 0.0% 0.13
Nov 24 07:00:00 - 07:59:59 141 3.2% 0.04544.1 KB 0.0% 0.15
Nov 24 08:00:00 - 08:59:59 104 2.4% 0.03331.0 KB 11.6% 0.09
Nov 24 09:00:00 - 09:59:59 60 1.4% 0.02156.1 KB 5.5% 0.04
Nov 24 10:00:00 - 10:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 24 11:00:00 - 11:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 24 12:00:00 - 12:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 24 13:00:00 - 13:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Nov 24 14:00:00 - 14:59:59 683 15.5% 0.192.6 MB 93.0% 0.73
Nov 24 15:00:00 - 15:59:59 363 8.2% 0.101.4 MB 52.0% 0.41
Nov 24 16:00:00 - 16:59:59 230 5.2% 0.06798.1 KB 28.1% 0.22
Nov 24 17:00:00 - 17:59:59 227 5.2% 0.06880.7 KB 31.0% 0.24
Nov 24 18:00:00 - 18:59:59 251 5.7% 0.07935.3 KB 32.9% 0.26
Nov 24 19:00:00 - 19:59:59 270 6.1% 0.07846.1 KB 29.8% 0.24
Nov 24 20:00:00 - 20:59:59 271 6.2% 0.081.3 MB 45.2% 0.36
Nov 24 21:00:00 - 21:59:59 305 6.9% 0.081.1 MB 40.0% 0.32
Nov 24 22:00:00 - 22:59:59 261 5.9% 0.071.0 MB 36.9% 0.29
Nov 24 23:00:00 - 23:59:59 210 4.8% 0.06737.1 KB 25.9% 0.20
Nov 25 00:00:00 - 00:59:59 215 4.9% 0.06901.2 KB 31.7% 0.25
Nov 25 01:00:00 - 01:59:59 142 3.2% 0.041.0 MB 36.3% 0.29
Nov 25 02:00:00 - 02:59:59 151 3.4% 0.041.8 MB 65.1% 0.51
Nov 25 03:00:00 - 03:59:59 126 2.9% 0.04482.1 KB 17.0% 0.13
Nov 25 04:00:00 - 04:15:01 32 0.7% 0.04248.7 KB 8.7% 0.28
TOTAL: 23:59:59 4405 100.0% 0.052.8 MB 100.0% 0.03
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 355 0 0 0 0 0 0 0 355
2i2pn.org 87 0 0 0 0 0 0 0 87
3news.nntp4.net 61 1 0 0 0 0 0 0 60
4news-out.aioe.org 42 1 0 0 0 0 0 0 41
5gegeweb-out.news.tnetconsulting.net 10 0 0 0 0 0 0 0 10
6usenet.pasdenom.info 10 0 0 0 0 0 0 0 10
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 566 2 0 0 0 0 0 0 564

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
sci.med.diseases.allergies 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 189
EMP (phn nph) 135
Bad path (news.giganews.com.POSTED) 118
EMP (md5) 72
User-issued spam cancel 19
Cancel of non-existing ID <d7a664ec-1465-41ef-aa0e-ee90b4a412a9n@googlegroups.com> 1
Cancel of non-existing ID <619e01c3$0$4988$426a74cc@news.free.fr> 1
Cancel of non-existing ID <619e2060$0$4967$426a34cc@news.free.fr> 1
Cancel of non-existing ID <619dfe22$0$28614$426a74cc@news.free.fr> 1
Cancel of non-existing ID <8b3fd3db-749d-47b1-8784-314ada0d450cn@googlegroups.com> 1
Cancel of non-existing ID <e10cc627-5811-40e4-9739-ffe06610a980n@googlegroups.com> 1
Cancel of non-existing ID <619e2a00$0$29495$426a34cc@news.free.fr> 1
Cancel of non-existing ID <dc3cb4f6-08c3-4c7d-ad82-be2601a4bcd3n@googlegroups.com> 1
Cancel of non-existing ID <619d6c17$0$6454$426a74cc@news.free.fr> 1
TOTAL: 14 542

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com6066
TOTAL: 16066

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 13
nntp.terraraq.uk 6
usenet.pasdenom.info 2
news.nntp4.net 1
TOTAL: 4 22
TOTAL: 1 22

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 5347 30 3110 9 0 800 0%23:59:55
2news.gegeweb.org 4163 29 3909 137 0 1063 0%23:59:56
3news.pasdenom.info 4808 27 3637 8 0 913 0%23:59:55
4news.tnetconsulting.net 6453 14 4386 0 0 1214 0%23:59:55
5news.aioe.org 1927 5 1731 0 0 42 0%18:48:56
6news.nntp4.net 4878 2 4211 0 0 1161 0%23:59:55
7nntp.terraraq.uk 2586 1 2354 0 0 128 0%23:59:55
TOTAL: 7 30162 108 23338 154 0 5321 0%162:48:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org116.7 KB575.7 KB692.3 KB0.0 KB/s4.2 KB23:59:56
2news.pasdenom.info105.7 KB399.7 KB505.4 KB0.0 KB/s14.4 KB23:59:55
3i2pn.org93.8 KB20.2 KB114.0 KB0.0 KB/s2.9 KB23:59:55
4news.tnetconsulting.net40.7 KB0.0 KB40.7 KB0.0 KB/s2.9 KB23:59:55
5news.aioe.org9.4 KB0.0 KB9.4 KB0.0 KB/s1.9 KB18:48:56
6news.nntp4.net5.7 KB0.0 KB5.7 KB0.0 KB/s2.8 KB23:59:55
7nntp.terraraq.uk2.7 KB0.0 KB2.7 KB0.0 KB/s2.7 KB23:59:55
TOTAL: 7374.5 KB995.6 KB1.3 MB0.0 KB/s5.2 KB162:48:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 3 2649.7 KB 7 1 000:09:30
TOTAL: 1 3 2649.7 KB 7 1 000:12:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 3 2649.7 KB 7 1 000:09:30
2*.gegeweb.eu 223 00.0 KB 0 0 000:01:39
3*.tkyo.nt.ngn.ppp.ocn.ne.jp 4 00.0 KB 0 0 000:00:09
4*.ip-145-239-154.eu 6 00.0 KB 0 0 000:00:01
5*.ip.linodeusercontent.com 50 00.0 KB 0 0 000:00:26
6unresolved 1 00.0 KB 0 0 000:00:30
TOTAL: 6 287 2649.7 KB 7 1 000:12:18

NNRP auth users [Top 20]:

UserConn
mailman 223
TOTAL: 1 223

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.113 0.205 0.00000:09:30
sys.gegeweb.eu 6.405 6.843 2.30300:01:39
178.17.174.14 0.028 0.028 0.00000:00:30
45-33-65-249.ip.linodeusercontent.com 1.335 1.015 0.00000:00:26
p0734427-vcngn.tkyo.nt.ngn.ppp.ocn.ne.jp 0.084 0.124 0.00000:00:09
ns31410046.ip-145-239-154.eu 0.146 0.077 0.00000:00:00
ns31410048.ip-145-239-154.eu 0.084 0.019 0.00000:00:00
TOTAL: 7 8.195 8.311 2.30300:12:18

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 223
45-33-65-249.ip.linodeusercontent.com 50
p0734427-vcngn.tkyo.nt.ngn.ppp.ocn.ne.jp 4
ns31410046.ip-145-239-154.eu 4
ns31410048.ip-145-239-154.eu 2
178.17.174.14 1
TOTAL: 6 284

NNRP unrecognized commands (by host):

SystemConn
ns31410046.ip-145-239-154.eu 2
ns31410048.ip-145-239-154.eu 1
178.17.174.14 1
TOTAL: 3 4

NNRP unrecognized commands (by command):

CommandCount
#026#003 3
SSH-2.0-PuTTY_Release_0.63 1
TOTAL: 2 4

Newsgroup request counts (by category):

CategoryCountPct
1fr 25 96.2%
2grisbi 1 3.8%
TOTAL: 2 26100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 22
2fr.comp.ordinosaures 2
3grisbi.test 1
4fr.comp.sys.mac 1
TOTAL: 4 26
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me