Daily Usenet Report

Aug 14 00:01:01 -- Aug 15 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Aug 14 01:08:00 newsfeed nnrpd[1076083]: 47.189.156.68 auth: program exited with status 8
Aug 14 16:01:04 newsfeed pgpverify[1549693]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 8834 29.2%3.6 MB 55.4%
nnrpd 8824 29.1%908.4 KB 13.7%
innd 7911 26.1%1.1 MB 17.3%
innfeed 4172 13.8%801.2 KB 12.1%
cnfsstat 432 1.4%69.6 KB 1.0%
nocem 111 0.4%27.1 KB 0.4%
controlchan 12 0.0%2.8 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 8 30297 100.0%6.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 111438 59.6%
Negative hits 67186 35.9%
Do not exist 8345 4.5%
Cache misses 57 0.0%
TOTAL: 4 187026 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.383 0.0%439 0.000 0.872 10.000
article cleanup00:00:00.122 0.0%8391 0.000 0.015 0.246
article logging00:00:00.459 0.0%8436 0.000 0.054 1.180
article parse00:00:00.212 0.0%13445 0.000 0.016 0.078
article write00:00:02.005 0.0%7360 0.000 0.272 2.048
artlog/artcncl00:00:00.014 0.0%401 0.000 0.035 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.414 0.0%189909 0.000 0.007 0.330
hisgrep/artcncl00:00:00.198 0.0%444 0.000 0.446 8.000
hishave/artcncl00:00:00.002 0.0%401 0.000 0.005 0.036
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:21.384 0.2%187457 0.096 0.754 4.989
history sync00:00:00.095 0.0%398 0.000 0.239 1.250
history write00:02:02.087 0.1%8388 3.242 14.555 100.433
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:47:21.677 99.1%189402 70.936 452.169 1791.522
nntp read00:00:03.888 0.0%190222 0.003 0.020 0.391
overview write00:07:27.416 0.5%7360 0.833 60.790 6174.543
perl filter00:00:31.344 0.0%8388 1.583 3.737 19.300
python filter00:00:01.603 0.0%8388 0.000 0.191 2.728
site send00:00:00.812 0.0%14779 0.000 0.055 0.125
TOTAL: 24:01:02.23623:59:55.115 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:04.484 0.0%4835813 0.000 0.001 0.002
article prepare00:00:00.006 0.0%46004 0.000 0.000 0.005
article read00:00:00.522 0.0%3859 0.000 0.135 0.514
backlog stats00:00:01.976 0.0%2058273 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:12.864 0.0%1237985 0.005 0.010 0.044
data write00:00:12.796 0.0%1233991 0.006 0.010 0.020
idle23:45:33.173 99.7%2058273 28.418 41.556 65.761
status file00:00:01.002 0.0%296 0.750 3.385 157.000
TOTAL: 23:50:09.07123:46:06.823 99.7%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:22:29.890 68.7%8389 14.500 160.912 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.233 0.0%16926 0.000 0.014 0.500
TOTAL: 00:32:43.74700:22:30.123 68.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newgroups-request@fido7.org001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 2 13886 2062 11436 388 14%48:45:27
2outgoing.news.lysator.liu.se 2 6580 1553 4955 72 23%23:59:47
3usenet.blueworldhosting.com 720 8160 779 7138 243 9%23:47:12
4news.hispagatos.org 5 7353 464 6868 21 6%24:26:19
5usenet.network 1 6035 427 5608 0 7%23:59:58
6news.corradoroberto.it 8 1196 418 778 0 34%25:02:08
7usenet.goja.nl.eu.org 11 7413 387 6986 40 5%23:59:54
8nntp.comgw.net 2 7533 375 7057 101 4%23:59:09
9i2pn.org 2 7259 248 7003 8 3%23:59:30
10endoftheline-out.news.chmurka.net 2 3910 230 3676 4 5%23:59:39
11newsfeed.bofh.team 2 8171 229 7936 6 2%23:57:28
12endofthelinebbs.peers.news.panix.com 28 7781 136 7636 9 1%24:40:50
13newsfeed.xs3.de 1 6065 113 5891 61 1%23:59:57
14news.samoylyk.net 9 6475 34 6440 1 0%25:48:29
15glockenspiel.complete.org 2 5996 11 5985 0 0%23:58:56
16news.bbs.nz 1 6779 10 6769 0 0%23:59:39
17news.netfront.net 1 5638 10 5558 70 0%24:26:51
18photonic.trudheim.com 2 1675 6 1669 0 0%23:57:43
19news.furie.org.uk 1 4152 5 4147 0 0%23:59:54
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:07
21localhost 7 0 0 0 0 0%00:00:01
22news.nk.ca 2 0 0 0 0 0%00:20:11
23news.nntp4.net 1 0 0 0 0 0%00:10:00
TOTAL: 23 813 122057 7497 113536 1024 6%485:29:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net6.5 MB5.3 KB690.8 KB7.1 MB 90%3.0 KB
2outgoing.news.lysator.liu.se5.7 MB0.0 KB115.8 KB5.8 MB 98%3.7 KB
3usenet.network4.7 MB0.0 KB0.0 KB4.7 MB100%11.3 KB
4news.corradoroberto.it2.9 MB0.0 KB0.0 KB2.9 MB100%7.2 KB
5usenet.blueworldhosting.com2.2 MB0.0 KB453.5 KB2.6 MB 83%2.7 KB
6news.hispagatos.org1.4 MB5.4 KB30.0 KB1.5 MB 97%3.1 KB
7usenet.goja.nl.eu.org1.3 MB0.0 KB48.1 KB1.4 MB 96%3.3 KB
8nntp.comgw.net1.2 MB0.0 KB236.4 KB1.4 MB 84%3.1 KB
9i2pn.org879.5 KB0.0 KB14.8 KB894.3 KB 98%3.5 KB
10endoftheline-out.news.chmurka.net854.9 KB5.2 KB2.6 KB862.7 KB 99%3.7 KB
11newsfeed.bofh.team686.4 KB0.0 KB18.8 KB705.2 KB 97%3.0 KB
12newsfeed.xs3.de436.1 KB0.0 KB317.6 KB753.8 KB 57%4.3 KB
13endofthelinebbs.peers.news.panix.com396.4 KB0.0 KB15.4 KB411.8 KB 96%2.8 KB
14news.samoylyk.net141.9 KB0.0 KB1.1 KB143.0 KB 99%4.1 KB
15glockenspiel.complete.org86.8 KB0.0 KB0.0 KB86.8 KB100%7.9 KB
16photonic.trudheim.com67.6 KB0.0 KB0.0 KB67.6 KB100%11.3 KB
17news.bbs.nz45.2 KB0.0 KB0.0 KB45.2 KB100%4.5 KB
18news.netfront.net32.9 KB0.0 KB868.5 KB901.4 KB 3%11.3 KB
19news.furie.org.uk30.9 KB0.0 KB0.0 KB30.9 KB100%6.2 KB
20eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2329.5 MB15.9 KB2.7 MB32.3 MB 91%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 14 00:01:01 - 00:59:59 202 2.7% 0.06904.5 KB 2.9% 0.26
Aug 14 01:00:00 - 01:59:59 276 3.8% 0.08953.4 KB 3.1% 0.26
Aug 14 02:00:00 - 02:59:59 323 4.4% 0.09990.9 KB 3.2% 0.28
Aug 14 03:00:00 - 03:59:59 342 4.6% 0.101.2 MB 3.9% 0.34
Aug 14 04:00:00 - 04:59:59 388 5.3% 0.111.2 MB 3.8% 0.33
Aug 14 05:00:00 - 05:59:59 334 4.5% 0.091.4 MB 4.5% 0.38
Aug 14 06:00:00 - 06:59:59 312 4.2% 0.09897.0 KB 2.9% 0.25
Aug 14 07:00:00 - 07:59:59 386 5.2% 0.111.7 MB 5.6% 0.48
Aug 14 08:00:00 - 08:59:59 349 4.7% 0.101.4 MB 4.6% 0.40
Aug 14 09:00:00 - 09:59:59 519 7.1% 0.142.1 MB 6.9% 0.60
Aug 14 10:00:00 - 10:59:59 420 5.7% 0.121.4 MB 4.6% 0.40
Aug 14 11:00:00 - 11:59:59 408 5.5% 0.111.6 MB 5.3% 0.46
Aug 14 12:00:00 - 12:59:59 355 4.8% 0.101.6 MB 5.3% 0.46
Aug 14 13:00:00 - 13:59:59 386 5.2% 0.111.2 MB 4.0% 0.35
Aug 14 14:00:00 - 14:59:59 394 5.4% 0.111.4 MB 4.8% 0.41
Aug 14 15:00:00 - 15:59:59 435 5.9% 0.121.9 MB 6.4% 0.55
Aug 14 16:00:00 - 16:59:59 308 4.2% 0.091.5 MB 4.8% 0.41
Aug 14 17:00:00 - 17:59:59 265 3.6% 0.071.5 MB 5.0% 0.44
Aug 14 18:00:00 - 18:59:59 181 2.5% 0.05611.6 KB 2.0% 0.17
Aug 14 19:00:00 - 19:59:59 193 2.6% 0.051.2 MB 3.8% 0.33
Aug 14 20:00:00 - 20:59:59 173 2.4% 0.051.0 MB 3.3% 0.28
Aug 14 21:00:00 - 21:59:59 113 1.5% 0.03440.7 KB 1.4% 0.12
Aug 14 22:00:00 - 22:59:59 134 1.8% 0.04595.9 KB 1.9% 0.17
Aug 14 23:00:00 - 23:59:59 151 2.1% 0.041.8 MB 5.9% 0.51
Aug 15 00:00:00 - 00:01:01 10 0.1% 0.1658.5 KB 0.2% 0.96
TOTAL: 24:00:00 7357 100.0% 0.0930.4 MB 100.0% 0.36
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
CYCNGS1NGS1536.0 GB48.0 MB 0.0% 1 0.00 0.00
CYCNGS2NGS1536.0 GB96.2 GB 6.3% 0 0.5235947.51
CYCTXT1TEXT5.0 GB3.8 GB 76.2% 0 0.06 1054.97
TOTAL: 3-3077.0 GB100.1 GB 3.3% 1 0.39-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 419 0 0 1 0 0 0 0 418
2usenet.blueworldhosting.com 258 5 0 0 0 0 0 0 253
3nntp.comgw.net 100 0 0 0 0 0 0 0 100
4outgoing.news.lysator.liu.se 74 0 0 0 0 0 0 0 74
5news.netfront.net 71 0 0 0 0 0 0 0 71
6newsfeed.xs3.de 62 0 0 0 0 0 0 0 62
7usenet.goja.nl.eu.org 40 0 0 0 0 0 0 0 40
8news.hispagatos.org 21 0 0 1 0 0 0 0 20
9endofthelinebbs.peers.news.panix.com 11 0 0 0 0 0 0 0 11
10i2pn.org 8 0 0 0 0 0 0 0 8
11newsfeed.bofh.team 6 0 0 0 0 0 0 0 6
12endoftheline-out.news.chmurka.net 4 0 0 1 0 0 0 0 3
13news.samoylyk.net 1 0 0 0 0 0 0 0 1
14usenet.network 1 0 0 0 0 0 0 0 1
TOTAL: 14 1076 5 0 3 0 0 0 0 1068

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test_messages 3
httpswww.cachem.fracceder-newsgroups-gratuitement 1
soc.culture.russia 1
TOTAL: 3 5

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 451
EMP (phr path) 335
Too many newsgroups 84
EMP (phn nph) 68
EMP (md5) 46
EMP (fsl) 21
HTML Multipart 7
User-issued cancel 7
Too many newsgroups (meow) 2
Binary: misplaced binary 1
Subject (LSD_ins_Leitungswasser_sch=C3=BCtten) 1
TOTAL: 11 1023

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)5203960396
robot@pasdenom.info (spam3)40055
robot@pasdenom.info (spam2)20022
TOTAL: 35803967403

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 22
usenet.blueworldhosting.com 15
endofthelinebbs.peers.news.panix.com 2
outgoing.news.lysator.liu.se 2
nntp.comgw.net 2
news.netfront.net 1
newsfeed.xs3.de 1
TOTAL: 7 45
TOTAL: 1 45

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11365 2656 4689 2 0 40 23%23:59:53
2nyheter.lysator.liu.se 5997 1164 4094 541 0 0 19%23:59:53
3photonic.trudheim.com 7780 626 6026 698 0 24 8%23:59:52
4news.furie.org.uk 4693 618 3124 5 0 0 13%23:59:43
5news.hispagatos.org 8140 375 6304 238 0 0 4%23:59:53
6usenet.network 7456 317 6165 21 0 2 4%23:59:12
7usenet.goja.nl.eu.org 7706 253 6475 188 0 0 3%23:59:48
8newsfeed.bofh.team 7955 225 6825 0 0 0 2%23:59:53
9news.bbs.nz 13522 222 6716 410 0 102 1%23:59:42
10news.corradoroberto.it 1033 188 589 0 0 14 18%23:33:06
11news.tnetconsulting.net 8045 178 6948 217 0 2 2%23:59:53
12news.nk.ca 10856 168 6515 590 0 25 1%23:59:53
13i2pn.org 8135 146 6882 53 0 64 1%23:59:50
14news.quux.org 7800 128 6776 408 0 2 1%23:59:26
15news.weretis.net 7608 113 7087 156 0 0 1%23:59:53
16nntp.comgw.net 7714 105 6756 114 0 0 1%23:59:53
17newsfeed.xs3.de 8308 80 7008 152 0 1 0%23:59:53
18news.chmurka.net 3983 47 3307 1 0 0 1%23:59:53
19news.samoylyk.net 8194 39 6350 104 0 1032 0%23:58:30
20usenet.blueworldhosting.com 6721 1 6372 0 0 0 0%23:58:24
21news.nntp4.net4868524 0 0 0 04868366 0%23:59:53
22endofthelinebbs.peers.news.panix.com 0 0 0 0 0 7344 0%23:59:53
23feed.opticnetworks.net 0 0 0 0 0 7357 0%23:59:53
TOTAL: 235021535 7649 115008 3898 04884375 0%551:26:02
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net12.8 MB5.9 KB12.8 MB0.2 KB/s4.9 KB23:59:53
2nyheter.lysator.liu.se6.1 MB4.8 MB10.8 MB0.1 KB/s6.5 KB23:59:53
3news.furie.org.uk5.4 MB189.8 KB5.6 MB0.1 KB/s9.3 KB23:59:43
4photonic.trudheim.com4.3 MB3.6 MB7.9 MB0.1 KB/s6.1 KB23:59:52
5news.hispagatos.org2.6 MB2.2 MB4.8 MB0.1 KB/s8.1 KB23:59:53
6newsfeed.bofh.team2.2 MB0.0 KB2.2 MB0.0 KB/s9.9 KB23:59:53
7usenet.network1.3 MB49.6 KB1.3 MB0.0 KB/s4.0 KB23:59:12
8news.quux.org1.2 MB3.1 MB4.3 MB0.1 KB/s8.2 KB23:59:26
9news.bbs.nz807.9 KB4.1 MB4.9 MB0.1 KB/s7.9 KB23:59:42
10news.tnetconsulting.net798.1 KB1.8 MB2.5 MB0.0 KB/s6.6 KB23:59:53
11nntp.comgw.net768.1 KB1.5 MB2.2 MB0.0 KB/s10.3 KB23:59:53
12news.corradoroberto.it743.5 KB0.0 KB743.5 KB0.0 KB/s4.0 KB23:33:06
13newsfeed.xs3.de718.1 KB1.6 MB2.3 MB0.0 KB/s10.3 KB23:59:53
14usenet.goja.nl.eu.org707.3 KB1.9 MB2.6 MB0.0 KB/s5.9 KB23:59:48
15i2pn.org592.3 KB184.6 KB776.9 KB0.0 KB/s3.9 KB23:59:50
16news.weretis.net517.0 KB2.4 MB3.0 MB0.0 KB/s11.2 KB23:59:53
17news.samoylyk.net457.2 KB542.6 KB999.8 KB0.0 KB/s7.0 KB23:58:30
18news.nk.ca352.4 KB4.1 MB4.4 MB0.1 KB/s6.0 KB23:59:53
19news.chmurka.net154.2 KB1.9 KB156.1 KB0.0 KB/s3.3 KB23:59:53
20usenet.blueworldhosting.com1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:58:24
21endofthelinebbs.peers.news.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
22feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
23news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2342.4 MB31.9 MB74.3 MB0.0 KB/s6.6 KB551:26:02
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.189.156.68 1 00.0 KB 1 0 000:00:00
TOTAL: 1 1 00.0 KB 1 0 000:32:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2759 00.0 KB 0 0 000:31:32
2*.ip.linodeusercontent.com 112 00.0 KB 0 0 000:00:36
3unresolved 6 00.0 KB 1 0 000:00:20
4*.stretchoid.com 2 00.0 KB 0 0 000:00:10
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 52880 00.0 KB 1 0 000:32:42

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.536 36.801 0.00000:31:32
139-144-52-241.ip.linodeusercontent.com 1.748 1.658 0.00000:00:36
205.210.31.158 0.004 0.012 0.00000:00:10
198.235.24.246 0.008 0.008 0.00000:00:10
azpdssb4.stretchoid.com 0.005 0.011 0.00000:00:09
erudite.monitoring.internet-measurement.com 0.000 0.017 0.00000:00:02
88.214.25.61 0.000 0.016 0.00000:00:00
185.242.226.41 0.000 0.016 0.00000:00:00
91.238.181.24 0.004 0.013 0.00000:00:00
azpdsg54.stretchoid.com 0.003 0.014 0.00000:00:00
TOTAL: 10 11.308 38.566 0.00000:32:42

Curious NNRP server explorers [Top 20]:

SystemConn
ddt.demos.su 2759
139-144-52-241.ip.linodeusercontent.com 112
185.242.226.41 1
198.235.24.246 1
205.210.31.158 1
88.214.25.61 1
91.238.181.24 1
azpdsg54.stretchoid.com 1
azpdssb4.stretchoid.com 1
erudite.monitoring.internet-measurement.com 1
TOTAL: 10 2879

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
185.242.226.41 5
88.214.25.61 1
91.238.181.24 1
azpdsg54.stretchoid.com 1
TOTAL: 4 8

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
#003 2
Accept-Encoding: gzip 1
Accept: */* 1
GET / HTTP/1.1 1
Host: 144.172.126.95:119 1
MGLNDD_144.172.126.95_119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 7 8

NNRP client timeouts [Top 20]:

SystemConnPeer
139-144-52-241.ip.linodeusercontent.com 1 1
88.214.25.61 1 1
91.238.181.24 1 1
TOTAL: 3 3 3

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1news.answers 2
TOTAL: 1 2