Daily Usenet Report

Aug 5 00:01:02 -- Aug 6 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 5 08:10:24 newsfeed innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
innfeed 23277 56.3%3.1 MB 38.1%
inn 8893 21.5%3.5 MB 43.5%
innd 8418 20.4%1.3 MB 16.8%
cnfsstat 432 1.0%77.8 KB 0.9%
nnrpd 199 0.5%17.1 KB 0.2%
nocem 139 0.3%38.3 KB 0.5%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 41359 100.0%8.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 115830 60.5%
Negative hits 67092 35.1%
Do not exist 8331 4.4%
Cache misses 110 0.1%
TOTAL: 4 191363 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.499 0.0%541 0.000 0.922 26.000
article cleanup00:00:00.083 0.0%8344 0.000 0.010 0.208
article logging00:00:00.480 0.0%8416 0.000 0.057 0.736
article parse00:00:00.198 0.0%12605 0.000 0.016 0.431
article write00:00:02.048 0.0%7081 0.000 0.289 2.863
artlog/artcncl00:00:00.017 0.0%460 0.000 0.037 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.743 0.0%192335 0.000 0.004 0.213
hisgrep/artcncl00:00:00.212 0.0%543 0.000 0.390 10.000
hishave/artcncl00:00:00.010 0.0%522 0.000 0.019 0.172
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:39.087 0.2%190991 0.087 0.833 5.312
history sync00:00:00.072 0.0%400 0.000 0.180 1.000
history write00:02:05.466 0.1%8339 2.889 15.046 112.238
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:40:08.730 98.9%186350 70.560 457.251 1274.979
nntp read00:00:04.318 0.0%193187 0.001 0.022 0.270
overview write00:09:39.574 0.7%7081 0.632 81.849 8493.714
perl filter00:00:28.241 0.0%8339 1.209 3.387 44.421
python filter00:00:01.306 0.0%8339 0.000 0.157 5.113
site send00:00:01.028 0.0%14233 0.000 0.072 0.211
TOTAL: 23:55:50.88123:55:12.112100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%9939 0.000 0.003 0.100
article prepare00:00:00.003 0.0%53080 0.000 0.000 0.003
article read00:00:00.594 0.0%4199 0.000 0.141 0.905
backlog stats00:00:00.402 0.0%271055 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.340 0.0%180210 0.000 0.013 0.044
data write00:00:03.200 0.0%176154 0.010 0.018 0.031
idle23:57:25.937100.0%271055 146.661 318.186 852.130
status file00:00:16.510 0.0%8318 0.983 1.985 106.226
TOTAL: 23:58:03.92023:57:49.011100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:22.253 98.0%10 15.000 2225.300 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%20 0.000 0.000 0.000
TOTAL: 00:00:22.69800:00:22.253 98.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 3 14297 1422 12631 244 9%54:26:09
2outgoing.news.lysator.liu.se 2 6221 1229 4901 91 19%23:59:13
3usenet.blueworldhosting.com 718 8158 1023 6587 548 12%23:52:34
4nntp.comgw.net 1 7614 560 6921 133 7%23:59:58
5news.hispagatos.org 5 7450 519 6892 39 6%24:26:22
6usenet.goja.nl.eu.org 11 7728 459 7182 87 5%25:46:12
7news.corradoroberto.it 3 1165 344 820 1 29%23:28:27
8usenet.network 1 5523 328 5191 4 5%24:00:25
9i2pn.org 1 7155 278 6862 15 3%23:59:54
10194.87.241.33 37 384 262 122 0 68%18:21:13
11endoftheline-out.news.chmurka.net 2 3623 259 3361 3 7%23:59:47
12endofthelinebbs.peers.news.panix.com 24 7507 182 7313 12 2%24:01:01
13newsfeed.bofh.team 1 8150 143 7992 15 1%23:59:55
14news.nntp4.net 2 6131 75 6048 8 1%23:59:42
15newsfeed.xs3.de 9 5880 61 5806 13 1%23:59:32
16news.samoylyk.net 2 6428 55 6370 3 0%23:59:36
17news.bbs.nz 1 6270 6 6264 0 0%23:59:33
18photonic.trudheim.com 2 1661 6 1655 0 0%23:57:10
19glockenspiel.complete.org 2 5598 3 5594 1 0%23:59:57
20news.netfront.net 1 5263 3 5191 69 0%24:49:20
21news.furie.org.uk 1 3863 3 3860 0 0%23:59:58
22eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
23localhost 6 0 0 0 0 0%00:00:00
24news.nk.ca 2 0 0 0 0 0%00:20:15
TOTAL: 24 838 126069 7220 117563 1286 5%531:36:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net4.5 MB3.4 KB491.6 KB5.0 MB 90%3.1 KB
2outgoing.news.lysator.liu.se4.2 MB0.0 KB190.9 KB4.4 MB 95%3.4 KB
3usenet.network3.5 MB8.5 KB5.8 KB3.5 MB 99%10.9 KB
4usenet.blueworldhosting.com2.3 MB0.0 KB1.2 MB3.5 MB 65%2.3 KB
5news.corradoroberto.it2.0 MB3.2 KB0.0 KB2.0 MB 99%5.9 KB
6news.hispagatos.org1.7 MB0.0 KB79.4 KB1.8 MB 95%3.3 KB
7nntp.comgw.net1.6 MB0.0 KB796.0 KB2.4 MB 67%3.6 KB
8usenet.goja.nl.eu.org1.2 MB0.0 KB122.9 KB1.3 MB 90%2.4 KB
9i2pn.org1.1 MB0.0 KB18.5 KB1.1 MB 98%3.9 KB
10endoftheline-out.news.chmurka.net1.1 MB0.0 KB2.2 KB1.1 MB 99%4.2 KB
11194.87.241.33696.9 KB0.0 KB0.0 KB696.9 KB100%2.7 KB
12endofthelinebbs.peers.news.panix.com416.5 KB0.0 KB14.8 KB431.3 KB 96%2.2 KB
13newsfeed.bofh.team353.0 KB0.0 KB35.3 KB388.3 KB 90%2.5 KB
14news.samoylyk.net314.6 KB3.2 KB6.0 KB323.9 KB 97%5.6 KB
15newsfeed.xs3.de233.4 KB0.0 KB50.6 KB283.9 KB 82%3.8 KB
16news.nntp4.net195.9 KB0.0 KB32.9 KB228.8 KB 85%2.8 KB
17glockenspiel.complete.org39.7 KB1.8 KB0.0 KB41.5 KB 95%10.4 KB
18photonic.trudheim.com14.7 KB0.0 KB0.0 KB14.7 KB100%2.4 KB
19news.bbs.nz11.4 KB0.0 KB0.0 KB11.4 KB100%1.9 KB
20news.furie.org.uk7.9 KB0.0 KB0.0 KB7.9 KB100%2.6 KB
21news.netfront.net3.9 KB4.8 KB493.2 KB501.8 KB 0%7.0 KB
22eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
24news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2425.5 MB24.9 KB3.5 MB29.0 MB 87%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 5 00:01:02 - 00:59:59 210 3.0% 0.06684.1 KB 2.6% 0.19
Aug 5 01:00:00 - 01:59:59 315 4.4% 0.09923.2 KB 3.5% 0.26
Aug 5 02:00:00 - 02:59:59 335 4.7% 0.091.2 MB 4.6% 0.34
Aug 5 03:00:00 - 03:59:59 305 4.3% 0.08843.7 KB 3.2% 0.23
Aug 5 04:00:00 - 04:59:59 330 4.7% 0.091.1 MB 4.4% 0.32
Aug 5 05:00:00 - 05:59:59 325 4.6% 0.091.2 MB 4.8% 0.35
Aug 5 06:00:00 - 06:59:59 323 4.6% 0.09905.4 KB 3.5% 0.25
Aug 5 07:00:00 - 07:59:59 305 4.3% 0.081.3 MB 5.2% 0.37
Aug 5 08:00:00 - 08:59:59 408 5.7% 0.111.7 MB 6.5% 0.47
Aug 5 09:00:00 - 09:59:59 391 5.5% 0.111.1 MB 4.4% 0.32
Aug 5 10:00:00 - 10:59:59 402 5.7% 0.111.4 MB 5.6% 0.41
Aug 5 11:00:00 - 11:59:59 386 5.4% 0.111.4 MB 5.3% 0.39
Aug 5 12:00:00 - 12:59:59 361 5.1% 0.101.2 MB 4.7% 0.34
Aug 5 13:00:00 - 13:59:59 361 5.1% 0.101.3 MB 5.2% 0.37
Aug 5 14:00:00 - 14:59:59 436 6.1% 0.121.5 MB 5.8% 0.42
Aug 5 15:00:00 - 15:59:59 368 5.2% 0.101.1 MB 4.4% 0.32
Aug 5 16:00:00 - 16:59:59 262 3.7% 0.071.1 MB 4.5% 0.32
Aug 5 17:00:00 - 17:59:59 242 3.4% 0.071.0 MB 4.0% 0.29
Aug 5 18:00:00 - 18:59:59 194 2.7% 0.05685.5 KB 2.6% 0.19
Aug 5 19:00:00 - 19:59:59 158 2.2% 0.04823.9 KB 3.2% 0.23
Aug 5 20:00:00 - 20:59:59 171 2.4% 0.05704.5 KB 2.7% 0.20
Aug 5 21:00:00 - 21:59:59 176 2.5% 0.05652.6 KB 2.5% 0.18
Aug 5 22:00:00 - 22:59:59 157 2.2% 0.04744.4 KB 2.9% 0.21
Aug 5 23:00:00 - 23:59:59 164 2.3% 0.05908.0 KB 3.5% 0.25
Aug 6 00:00:00 - 00:01:01 11 0.2% 0.18115.4 KB 0.4% 1.89
TOTAL: 23:59:59 7096 100.0% 0.0825.5 MB 100.0% 0.30
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 GB95.8 GB 6.2% 0 0.4739515.78
CYCTXT1TEXT5.0 GB3.6 GB 72.4% 0 0.02 2530.00
TOTAL: 3-3077.0 GB99.5 GB 3.2% 1 0.38-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 567 10 0 0 0 0 0 0 557
2endofthelinebbs-out.news.weretis.net 276 6 0 1 0 0 0 0 269
3nntp.comgw.net 141 0 0 0 0 0 0 0 141
4outgoing.news.lysator.liu.se 91 32 0 0 0 0 0 0 59
5usenet.goja.nl.eu.org 85 2 0 0 0 0 0 0 83
6news.netfront.net 69 0 0 1 0 0 0 0 68
7news.hispagatos.org 23 6 0 0 0 0 0 0 17
8endofthelinebbs.peers.news.panix.com 18 0 0 0 0 0 0 0 18
9newsfeed.bofh.team 16 1 0 0 0 0 0 0 15
10i2pn.org 15 1 0 0 0 0 0 0 14
11newsfeed.xs3.de 14 0 0 0 0 0 0 0 14
12news.nntp4.net 8 0 0 0 0 0 0 0 8
13usenet.network 5 1 0 1 0 0 0 0 3
14endoftheline-out.news.chmurka.net 3 0 0 0 0 0 0 0 3
15news.samoylyk.net 3 0 0 1 0 0 0 0 2
16glockenspiel.complete.org 2 0 0 0 0 0 0 0 2
17news.corradoroberto.it 1 0 0 1 0 0 0 0 0
TOTAL: 17 1337 59 0 5 0 0 0 0 1273

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.russian.z1 59
TOTAL: 1 59

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 556
EMP (phr path) 313
EMP (md5) 180
Too many newsgroups 94
EMP (phn nph) 38
HTML Multipart 9
User-issued cancel 9
Binary: misplaced binary 1
Subject (LSDQvdCw0LrQv) 1
TOTAL: 9 1201

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)6705200520
robot@pasdenom.info (spam3)20033
robot@pasdenom.info (spam2)20022
TOTAL: 37105205525

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 36
usenet.blueworldhosting.com 19
endofthelinebbs.peers.news.panix.com 6
usenet.goja.nl.eu.org 5
nntp.comgw.net 2
newsfeed.xs3.de 1
newsfeed.bofh.team 1
glockenspiel.complete.org 1
usenet.network 1
TOTAL: 9 72
TOTAL: 1 72

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10445 3055 4036 2 0 4 29%23:59:51
2nyheter.lysator.liu.se 6090 1394 4020 453 0 1 22%23:59:10
3photonic.trudheim.com 7645 588 5426 1076 0 0 7%23:59:51
4news.furie.org.uk 4282 489 3025 7 0 0 11%23:59:51
5news.hispagatos.org 7929 376 5992 215 0 0 4%23:59:38
6usenet.network 7465 359 5901 30 0 0 4%23:59:51
7usenet.goja.nl.eu.org 7687 355 6130 176 0 0 4%23:59:51
8news.nk.ca 10335 323 6062 633 0 8 3%23:59:51
9news.nntp4.net 7998 309 6657 37 0 4 3%23:59:51
10news.bbs.nz 12791 306 6280 502 0 60 2%23:59:51
11newsfeed.bofh.team 7973 228 6637 5 0 0 2%23:59:47
12i2pn.org 7716 206 6528 66 0 32 2%23:59:51
13nntp.comgw.net 7596 126 6301 121 0 0 1%23:59:33
14news.tnetconsulting.net 7773 120 6711 260 0 0 1%23:59:51
15news.weretis.net 7352 114 6827 154 0 0 1%23:59:51
16news.quux.org 7481 110 6446 532 0 3 1%23:59:51
17news.corradoroberto.it 891 102 621 2 0 0 11%23:32:05
18newsfeed.xs3.de 8369 65 6787 173 0 0 0%23:59:31
19news.chmurka.net 3634 44 3038 0 0 0 1%23:58:46
20news.samoylyk.net 8903 37 6818 157 0 24 0%23:59:51
21usenet.blueworldhosting.com 5943 2 5769 0 0 0 0%23:59:51
22ddt.demos.su 2724 0 0 0 0 2779 0%23:59:51
23endofthelinebbs.peers.news.panix.com 0 0 0 0 0 7092 0%23:59:51
24feed.opticnetworks.net 0 0 0 0 0 7096 0%23:59:46
TOTAL: 24 159022 8708 116012 4601 0 17103 5%575:25:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net11.6 MB7.0 KB11.6 MB0.1 KB/s3.9 KB23:59:51
2nyheter.lysator.liu.se4.7 MB3.7 MB8.3 MB0.1 KB/s4.6 KB23:59:10
3news.furie.org.uk3.3 MB38.1 KB3.3 MB0.0 KB/s6.9 KB23:59:51
4photonic.trudheim.com3.2 MB3.5 MB6.7 MB0.1 KB/s4.1 KB23:59:51
5newsfeed.bofh.team1.9 MB35.4 KB2.0 MB0.0 KB/s8.6 KB23:59:47
6news.hispagatos.org1.3 MB1.9 MB3.1 MB0.0 KB/s5.4 KB23:59:38
7news.nntp4.net1.3 MB310.5 KB1.6 MB0.0 KB/s4.6 KB23:59:51
8usenet.network1.3 MB64.6 KB1.3 MB0.0 KB/s3.5 KB23:59:51
9news.quux.org1.0 MB2.6 MB3.7 MB0.0 KB/s5.9 KB23:59:51
10usenet.goja.nl.eu.org906.2 KB1.6 MB2.5 MB0.0 KB/s4.8 KB23:59:51
11news.bbs.nz820.0 KB3.1 MB3.9 MB0.0 KB/s5.0 KB23:59:51
12i2pn.org808.4 KB209.1 KB1017.4 KB0.0 KB/s3.7 KB23:59:51
13news.nk.ca678.7 KB3.4 MB4.0 MB0.0 KB/s4.3 KB23:59:51
14nntp.comgw.net572.3 KB1.5 MB2.0 MB0.0 KB/s8.5 KB23:59:33
15news.tnetconsulting.net563.0 KB1.6 MB2.2 MB0.0 KB/s5.8 KB23:59:51
16news.weretis.net521.1 KB1.7 MB2.2 MB0.0 KB/s8.3 KB23:59:51
17news.samoylyk.net428.8 KB825.9 KB1.2 MB0.0 KB/s6.5 KB23:59:51
18newsfeed.xs3.de393.8 KB1.6 MB2.0 MB0.0 KB/s8.5 KB23:59:31
19news.corradoroberto.it378.6 KB5.4 KB384.0 KB0.0 KB/s3.7 KB23:32:05
20news.chmurka.net112.4 KB0.0 KB112.4 KB0.0 KB/s2.6 KB23:58:46
21usenet.blueworldhosting.com3.1 KB0.0 KB3.1 KB0.0 KB/s1.5 KB23:59:51
22ddt.demos.su0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
23endofthelinebbs.peers.news.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:51
24feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
TOTAL: 2435.5 MB27.6 MB63.1 MB0.0 KB/s4.9 KB575:25:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1198.235.24.51 1 00.0 KB 0 0 000:00:00
2205.210.31.135 1 00.0 KB 0 0 000:00:08
3205.210.31.72 1 00.0 KB 0 0 000:00:10
445-33-109-8.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:03
591.238.181.22 1 00.0 KB 0 0 000:00:00
691.238.181.35 1 00.0 KB 0 0 000:00:00
7azpdsgb55.stretchoid.com 1 00.0 KB 0 0 000:00:00
TOTAL: 7 7 00.0 KB 0 0 000:00:22

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 5 00.0 KB 0 0 000:00:19
2*.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:03
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 7 00.0 KB 0 0 000:00:22

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
205.210.31.72 0.004 0.020 0.00000:00:10
205.210.31.135 0.007 0.009 0.00000:00:08
45-33-109-8.ip.linodeusercontent.com 0.003 0.017 0.00000:00:03
198.235.24.51 0.003 0.013 0.00000:00:00
azpdsgb55.stretchoid.com 0.003 0.013 0.00000:00:00
91.238.181.22 0.006 0.011 0.00000:00:00
91.238.181.35 0.000 0.017 0.00000:00:00
TOTAL: 7 0.026 0.100 0.00000:00:22

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

SystemConn
91.238.181.22 1
91.238.181.35 1
azpdsgb55.stretchoid.com 1
TOTAL: 3 3

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

CommandCount
#003 2
MGLNDD_144.172.126.95_119 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
91.238.181.22 1 1
91.238.181.35 1 1
TOTAL: 2 2 5