Daily Usenet report

Jan 11 00:01:01 -- Jan 12 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 11 00:53:40 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 115593 84.0%27.5 MB 90.3%
innd 17838 13.0%2.2 MB 7.2%
innfeed 4018 2.9%775.5 KB 2.5%
nnrpd 104 0.1%9.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 137554 100.0%30.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 491205 60.8%
Negative hits 261769 32.4%
Do not exist 52142 6.4%
Cache misses 3358 0.4%
TOTAL: 4 808474 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:33.948 0.0%72732 0.142 0.467 2.830
article cleanup00:00:00.951 0.0%52319 0.003 0.018 0.039
article logging00:00:02.705 0.0%52375 0.025 0.052 0.111
article parse00:00:04.669 0.0%238907 0.004 0.020 0.031
article write00:00:45.668 0.1%40042 0.828 1.141 2.241
artlog/artcncl00:00:00.985 0.0%63132 0.004 0.016 0.032
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.774 0.0%1010838 0.000 0.002 0.004
hisgrep/artcncl00:00:08.643 0.0%72685 0.020 0.119 1.197
hishave/artcncl00:00:00.685 0.0%72655 0.000 0.009 0.119
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:31.998 0.0%739594 0.012 0.043 0.144
history sync00:00:00.062 0.0%331 0.000 0.187 1.500
history write00:00:32.176 0.0%52301 0.308 0.615 2.176
hiswrite/artcncl00:00:00.036 0.0%60 0.000 0.600 2.000
idle23:44:23.098 98.9%930891 49.868 91.808 239.338
nntp read00:00:41.804 0.0%950040 0.020 0.044 0.099
overview write00:01:05.172 0.1%40042 0.659 1.628 59.367
perl filter00:06:54.938 0.5%52301 2.759 7.934 17.731
python filter00:00:07.091 0.0%52303 0.079 0.136 0.225
site send00:00:23.802 0.0%81186 0.107 0.293 1.167
TOTAL: 24:00:40.53423:56:20.205 99.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.411 0.0%47058 0.000 0.009 0.067
article prepare00:00:00.068 0.0%496784 0.000 0.000 0.001
article read00:00:14.471 0.0%39833 0.206 0.363 0.590
backlog stats00:00:02.822 0.0%1390319 0.001 0.002 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:29.838 0.0%1030675 0.018 0.029 0.115
data write00:02:29.073 0.2%939202 0.115 0.159 0.237
idle23:47:45.175 99.7%1390319 34.789 61.615 154.711
status file00:00:00.400 0.0%373 0.000 1.072 4.000
TOTAL: 23:51:45.45223:51:02.258 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.497 92.3%9 25.500 1166.333 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.002 0.0%23 0.000 0.087 0.250
TOTAL: 00:00:11.37600:00:10.499 92.3%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 7 62381 14145 46399 1837 22%47:36:53
2usenet.blueworldhosting.com 288 26117 7443 15754 2920 28%23:45:07
3newsfeed.xs3.de 4 31052 5336 25395 321 17%24:03:55
4news.nntp4.net 4 37682 2964 34570 148 7%24:12:30
5news.hispagatos.org 6 18564 2371 16190 3 12%24:26:24
6nntp.comgw.net 2 39016 1476 35969 1571 3%25:03:23
7paganini.bofh.team 4 46838 1399 45034 405 2%24:17:07
8usenet.goja.nl.eu.org 11 36901 1086 35283 532 2%23:47:23
9endofthelinebbs.peers.news.panix.com 34 38376 948 37393 35 2%25:11:55
10usenet.network 2 30147 880 29159 108 2%23:59:54
11endoftheline-out.news.chmurka.net 2 9175 613 8546 16 6%24:09:55
12outgoing.news.lysator.liu.se 1 9807 339 9289 179 3%23:59:55
13glockenspiel.complete.org 4 35642 308 35314 20 0%24:13:42
14194.87.241.33 26 581 279 101 201 48%21:50:16
15i2pn.org 1 10391 173 10217 1 1%23:59:54
16news.samoylyk.net 2 9137 26 9111 0 0%23:59:34
17news.netfront.net 25 4539 23 494 4022 0%23:00:18
18news.bbs.nz 2 20400 15 20385 0 0%25:51:34
19news.furie.org.uk 1 15112 5 15107 0 0%23:59:55
20localhost 28 2 2 0 0 100%00:00:00
21news.nk.ca 2 0 0 0 0 0%00:20:00
22eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
TOTAL: 22 457 481860 39831 429710 12319 8%481:59:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net147.7 MB40.4 KB3.0 MB150.8 MB 97%9.7 KB
2newsfeed.xs3.de58.2 MB16.1 KB3.1 MB61.3 MB 94%11.1 KB
3usenet.blueworldhosting.com53.8 MB0.0 KB9.4 MB63.2 MB 85%6.2 KB
4news.nntp4.net36.5 MB43.9 KB1.5 MB37.9 MB 96%12.5 KB
5news.hispagatos.org11.9 MB28.9 KB0.0 KB12.0 MB 99%5.2 KB
6paganini.bofh.team11.5 MB21.4 KB2.4 MB14.0 MB 82%7.9 KB
7endofthelinebbs.peers.news.panix.com9.9 MB0.0 KB207.9 KB10.1 MB 97%10.5 KB
8nntp.comgw.net7.5 MB16.1 KB8.6 MB16.1 MB 46%5.4 KB
9usenet.goja.nl.eu.org6.1 MB21.5 KB896.5 KB7.0 MB 87%4.4 KB
10usenet.network6.0 MB21.4 KB286.9 KB6.3 MB 95%6.6 KB
11glockenspiel.complete.org3.1 MB16.1 KB120.8 KB3.3 MB 95%10.2 KB
12endoftheline-out.news.chmurka.net3.1 MB0.0 KB113.2 KB3.2 MB 96%5.2 KB
13i2pn.org1.7 MB0.0 KB1.2 KB1.7 MB 99%9.8 KB
14news.netfront.net1.0 MB0.0 KB1.3 GB1.3 GB 0%329.1 KB
15194.87.241.33958.5 KB0.0 KB301.5 KB1.2 MB 76%2.6 KB
16outgoing.news.lysator.liu.se717.1 KB0.0 KB277.0 KB994.2 KB 72%1.9 KB
17news.bbs.nz80.2 KB0.0 KB0.0 KB80.2 KB100%5.3 KB
18news.samoylyk.net60.2 KB0.0 KB0.0 KB60.2 KB100%2.3 KB
19news.furie.org.uk14.7 KB0.0 KB0.0 KB14.7 KB100%2.9 KB
20localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
21news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 22359.7 MB225.8 KB1.3 GB1.6 GB 21%33.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 11 00:01:01 - 00:59:59 1844 4.6% 0.5218.4 MB 5.1% 5.32
Jan 11 01:00:00 - 01:59:59 2422 6.1% 0.6722.7 MB 6.3% 6.47
Jan 11 02:00:00 - 02:59:59 2583 6.5% 0.7223.8 MB 6.6% 6.78
Jan 11 03:00:00 - 03:59:59 2472 6.2% 0.6922.8 MB 6.3% 6.48
Jan 11 04:00:00 - 04:59:59 2376 5.9% 0.6620.0 MB 5.5% 5.70
Jan 11 05:00:00 - 05:59:59 2084 5.2% 0.5818.0 MB 5.0% 5.13
Jan 11 06:00:00 - 06:59:59 1872 4.7% 0.5215.9 MB 4.4% 4.53
Jan 11 07:00:00 - 07:59:59 1830 4.6% 0.5114.8 MB 4.1% 4.22
Jan 11 08:00:00 - 08:59:59 1408 3.5% 0.3910.7 MB 3.0% 3.05
Jan 11 09:00:00 - 09:59:59 1452 3.6% 0.4012.7 MB 3.5% 3.62
Jan 11 10:00:00 - 10:59:59 1630 4.1% 0.4515.5 MB 4.3% 4.41
Jan 11 11:00:00 - 11:59:59 1573 3.9% 0.4414.2 MB 3.9% 4.03
Jan 11 12:00:00 - 12:59:59 1524 3.8% 0.4214.3 MB 3.9% 4.07
Jan 11 13:00:00 - 13:59:59 1397 3.5% 0.3912.0 MB 3.3% 3.41
Jan 11 14:00:00 - 14:59:59 1321 3.3% 0.3712.3 MB 3.4% 3.49
Jan 11 15:00:00 - 15:59:59 1744 4.4% 0.4812.2 MB 3.4% 3.47
Jan 11 16:00:00 - 16:59:59 1203 3.0% 0.3310.7 MB 3.0% 3.04
Jan 11 17:00:00 - 17:59:59 1099 2.7% 0.3110.8 MB 3.0% 3.08
Jan 11 18:00:00 - 18:59:59 1054 2.6% 0.298.5 MB 2.3% 2.41
Jan 11 19:00:00 - 19:59:59 1190 3.0% 0.3310.8 MB 3.0% 3.07
Jan 11 20:00:00 - 20:59:59 1499 3.7% 0.4214.7 MB 4.1% 4.19
Jan 11 21:00:00 - 21:59:59 1328 3.3% 0.3713.4 MB 3.7% 3.80
Jan 11 22:00:00 - 22:59:59 1540 3.8% 0.4316.7 MB 4.6% 4.74
Jan 11 23:00:00 - 23:59:59 1543 3.9% 0.4316.1 MB 4.5% 4.59
Jan 12 00:00:00 - 00:01:02 32 0.1% 0.52271.1 KB 0.1% 4.37
TOTAL: 24:00:01 40020 100.0% 0.46362.4 MB 100.0% 4.30
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 3992 0 0 0 0 0 0 0 3992
2usenet.blueworldhosting.com 2949 1 0 0 0 0 0 0 2948
3endofthelinebbs-out.news.weretis.net 1872 0 0 5 0 0 0 0 1867
4nntp.comgw.net 1544 0 0 1 0 0 0 0 1543
5usenet.goja.nl.eu.org 545 0 0 3 0 0 0 0 542
6paganini.bofh.team 411 0 0 2 0 0 0 0 409
7newsfeed.xs3.de 324 0 0 1 0 0 0 0 323
8194.87.241.33 201 0 0 0 0 0 0 0 201
9outgoing.news.lysator.liu.se 179 0 0 0 0 0 0 0 179
10news.nntp4.net 157 0 0 1 0 0 0 0 156
11usenet.network 106 0 0 2 0 0 0 0 104
12endofthelinebbs.peers.news.panix.com 36 0 0 0 0 0 0 0 36
13glockenspiel.complete.org 13 0 0 1 0 0 0 0 12
14endoftheline-out.news.chmurka.net 8 0 0 0 0 0 0 0 8
15news.hispagatos.org 3 0 0 2 0 0 0 0 1
16i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 16 12341 1 0 18 0 0 0 012322

Unwanted newsgroups [Top 20]:

NewsgroupCount
alive.music.hard-rock.guns-n-roses 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 4783
Binary: misplaced binary 3893
EMP (md5) 2110
Too many newsgroups 424
EMP (phr path) 322
EMP (fsl) 29
Subject (LSDguJzguKXguJrguK3guKXguKr) 14
Subject (lSDguY) 14
Subject (Buy Xanax) 13
Subject (Buy Tramadol) 13
User-issued cancel 12
Subject (lSDguKvguKfguKIg4Lih4Lix4LmI4LiZ4LiE4LiH4LiX4Li) 10
Subject (Buy Percocet) 9
Subject (Buy McKennaii Psilocybin) 8
Subject (lSDwn5OVIOC5gOC4p+C5h+C4muC4leC4o+C4h+C4l) 7
Subject (LSDguYDguKfguYfguJo) 6
Subject (lSDguYDguKfguYfguJrguJXguKPguIcg4Lid4Liy4LiBL) 6
Subject (LSDguY) 6
Subject (lSDguYDguKfguYfguJrguJXguKPguIcg4LmB4LiV4LiBI) 6
HTML Multipart 5
TOTAL: 465 12267

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 26
endofthelinebbs-out.news.weretis.net 21
usenet.goja.nl.eu.org 3
nntp.comgw.net 2
news.hispagatos.org 1
news.nntp4.net 1
endofthelinebbs.peers.news.panix.com 1
TOTAL: 7 55
TOTAL: 1 55

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 39999 39996 0 1 0 0 99%23:59:54
2nyheter.lysator.liu.se 40084 30709 7827 1146 0 0 76%23:59:56
3endofthelinebbs.peers.news.panix.com 41541 9700 30249 59 0 1 23%23:59:55
4usenet.network 49182 9627 28775 197 0 1 19%23:59:52
5news.quux.org 43167 4010 34765 895 0 10 9%23:59:56
6news.hispagatos.org 46747 2846 33449 1394 0 5 6%23:59:53
7news.nntp4.net 43225 1497 34879 303 0 9 3%23:59:56
8news.bbs.nz 67704 1183 35596 3224 0 2634 1%23:59:56
9news.furie.org.uk 17143 929 13278 19 0 0 5%23:59:54
10usenet.goja.nl.eu.org 46605 598 37214 1130 0 16 1%23:59:56
11paganini.bofh.team 48252 567 39448 0 0 8 1%23:59:55
12news.nk.ca 49813 556 34255 5161 0 82 1%23:59:56
13ddt.demos.su 731 294 434 0 0 0 40%22:09:33
14usenet.blueworldhosting.com 33303 290 31666 2 0 0 0%23:59:56
15i2pn.org 56116 261 35827 3495 0 4417 0%23:59:46
16nntp.comgw.net 48652 251 39264 505 0 3 0%23:59:56
17news.chmurka.net 17418 178 14611 21 0 4 1%23:59:56
18news.weretis.net 41070 133 38766 1119 0 28 0%23:59:55
19newsfeed.xs3.de 42738 82 33779 489 0 13 0%23:59:55
20news.tnetconsulting.net 42846 42 38385 1579 0 2 0%23:59:56
21news.samoylyk.net 54960 29 39572 391 0 22 0%23:59:55
TOTAL: 21 871296 103778 602039 21130 0 7255 11%502:07:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net361.5 MB3.4 KB361.5 MB4.3 KB/s9.3 KB23:59:54
2nyheter.lysator.liu.se323.6 MB6.5 MB330.2 MB3.9 KB/s10.6 KB23:59:56
3usenet.network112.0 MB1.4 MB113.4 MB1.3 KB/s11.8 KB23:59:52
4endofthelinebbs.peers.news.panix.com109.1 MB617.1 KB109.7 MB1.3 KB/s11.5 KB23:59:55
5news.quux.org45.5 MB4.1 MB49.5 MB0.6 KB/s10.3 KB23:59:56
6news.hispagatos.org40.0 MB11.1 MB51.1 MB0.6 KB/s12.3 KB23:59:53
7news.nntp4.net16.1 MB919.7 KB17.0 MB0.2 KB/s9.6 KB23:59:56
8news.furie.org.uk11.2 MB265.4 KB11.4 MB0.1 KB/s12.4 KB23:59:54
9news.bbs.nz8.6 MB24.6 MB33.2 MB0.4 KB/s7.7 KB23:59:56
10usenet.goja.nl.eu.org5.4 MB9.6 MB15.0 MB0.2 KB/s8.9 KB23:59:56
11paganini.bofh.team4.3 MB0.0 KB4.3 MB0.1 KB/s7.8 KB23:59:55
12nntp.comgw.net3.2 MB3.3 MB6.5 MB0.1 KB/s8.8 KB23:59:56
13news.nk.ca2.0 MB39.4 MB41.5 MB0.5 KB/s7.4 KB23:59:56
14newsfeed.xs3.de1.7 MB3.1 MB4.9 MB0.1 KB/s8.7 KB23:59:55
15ddt.demos.su1.3 MB0.0 KB1.3 MB0.0 KB/s4.5 KB22:09:33
16news.weretis.net1.3 MB9.8 MB11.1 MB0.1 KB/s9.1 KB23:59:55
17news.chmurka.net966.1 KB1.0 MB2.0 MB0.0 KB/s10.1 KB23:59:56
18i2pn.org904.1 KB32.6 MB33.5 MB0.4 KB/s9.1 KB23:59:46
19news.samoylyk.net736.2 KB2.2 MB3.0 MB0.0 KB/s7.2 KB23:59:55
20usenet.blueworldhosting.com623.9 KB9.5 KB633.4 KB0.0 KB/s2.2 KB23:59:56
21news.tnetconsulting.net121.7 KB14.1 MB14.2 MB0.2 KB/s9.0 KB23:59:56
TOTAL: 211.0 GB164.7 MB1.2 GB0.7 KB/s10.0 KB502:07:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.47.220 1 00.0 KB 7 0 000:00:00
TOTAL: 1 1 00.0 KB 7 0 000:00:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
2unresolved 5 00.0 KB 7 0 000:00:11
TOTAL: 2 6 00.0 KB 7 0 000:00:11

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
104.152.52.87 0.094 0.046 0.00000:00:10
185.170.144.3 0.220 0.118 0.00000:00:00
192.241.196.126 0.121 0.067 0.00000:00:00
165.211.203.35.bc.googleusercontent.com 0.060 0.072 0.00000:00:00
TOTAL: 4 0.495 0.303 0.00000:00:11

Curious NNRP server explorers [Top 20]:

SystemConn
185.170.144.3 2
165.211.203.35.bc.googleusercontent.com 1
104.152.52.87 1
192.241.196.126 1
TOTAL: 4 5

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

SystemConn
165.211.203.35.bc.googleusercontent.com 3
185.170.144.3 2
192.241.196.126 1
TOTAL: 3 6

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

CommandCount
#003 2
Host: 192.138.210.162:119 1
MGLNDD_192.138.210.162_119 1
GET / HTTP/1.1 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
185.170.144.3 2 2
TOTAL: 1 2 2

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 6 46.2%
2alt 3 23.1%
3dfw 2 15.4%
4comp 2 15.4%
TOTAL: 4 13100.0%

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

NewsgroupCount
1news.admin.net-abuse.usenet 4
2comp.sys.acorn.misc 2
3news.admin.peering 2
4alt.mud 2
5alt.music.lyrics 1
6dfw.forsale 1
7dfw.games 1
TOTAL: 7 13