Daily Usenet report

Oct 24 02:30:00 -- Oct 25 02:30:00

Unknown entries from news log file:

First 50 / 16975 lines (0.3%)

Oct 24 16:12:01 spool1 nnrpd[14214]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:01 spool1 nnrpd[14214]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:01 spool1 nnrpd[14214]: SM: one or more storage methods failed initialization
Oct 24 16:12:01 spool1 nnrpd[14214]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:01 spool1 nnrpd[14214]: time 62 nntpwrite 0(1)
Oct 24 16:12:02 spool1 nnrpd[14516]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:02 spool1 nnrpd[14516]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:02 spool1 nnrpd[14516]: SM: one or more storage methods failed initialization
Oct 24 16:12:02 spool1 nnrpd[14516]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:02 spool1 nnrpd[14516]: time 61 nntpwrite 0(1)
Oct 24 16:12:03 spool1 nnrpd[14967]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:03 spool1 nnrpd[14967]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:03 spool1 nnrpd[14967]: SM: one or more storage methods failed initialization
Oct 24 16:12:03 spool1 nnrpd[14967]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:03 spool1 nnrpd[14967]: time 61 nntpwrite 0(1)
Oct 24 16:12:09 spool1 nnrpd[15005]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:09 spool1 nnrpd[15005]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:09 spool1 nnrpd[15005]: SM: one or more storage methods failed initialization
Oct 24 16:12:09 spool1 nnrpd[15005]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:09 spool1 nnrpd[15005]: time 61 nntpwrite 0(1)
Oct 24 16:12:11 spool1 nnrpd[15638]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:11 spool1 nnrpd[15638]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:11 spool1 nnrpd[15638]: SM: one or more storage methods failed initialization
Oct 24 16:12:11 spool1 nnrpd[15638]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:11 spool1 nnrpd[15638]: time 59 nntpwrite 0(1)
Oct 24 16:12:12 spool1 nnrpd[15645]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:12 spool1 nnrpd[15645]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:12 spool1 nnrpd[15645]: SM: one or more storage methods failed initialization
Oct 24 16:12:12 spool1 nnrpd[15645]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:12 spool1 nnrpd[15645]: time 60 nntpwrite 0(1)
Oct 24 16:12:18 spool1 nnrpd[16465]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:18 spool1 nnrpd[16465]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:18 spool1 nnrpd[16465]: SM: one or more storage methods failed initialization
Oct 24 16:12:18 spool1 nnrpd[16465]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:18 spool1 nnrpd[16465]: time 61 nntpwrite 0(1)
Oct 24 16:12:20 spool1 nnrpd[17207]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:20 spool1 nnrpd[17207]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:20 spool1 nnrpd[17207]: SM: one or more storage methods failed initialization
Oct 24 16:12:20 spool1 nnrpd[17207]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:20 spool1 nnrpd[17207]: time 62 nntpwrite 1(1)
Oct 24 16:12:21 spool1 nnrpd[17876]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:21 spool1 nnrpd[17876]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:21 spool1 nnrpd[17876]: SM: one or more storage methods failed initialization
Oct 24 16:12:21 spool1 nnrpd[17876]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:21 spool1 nnrpd[17876]: time 59 nntpwrite 0(1)
Oct 24 16:12:27 spool1 nnrpd[18485]: CNFS: file '/usr/local/news/spool/docs1': No such file or directory, ignoring 'DOCS1' cycbuff
Oct 24 16:12:27 spool1 nnrpd[18485]: SM: storage method 'cnfs' failed initialization
Oct 24 16:12:27 spool1 nnrpd[18485]: SM: one or more storage methods failed initialization
Oct 24 16:12:27 spool1 nnrpd[18485]: can't initialize storage method, one or more storage methods failed initialization
Oct 24 16:12:27 spool1 nnrpd[18485]: time 61 nntpwrite 0(1)

Log entries by program:

Program nameLines%LinesSize%Size
inn 112329 58.3%11.1 MB 60.7%
nnrpd 76410 39.7%6.8 MB 37.1%
innd 3647 1.9%408.9 KB 2.2%
innfeed 191 0.1%18.2 KB 0.1%
controlchan 3 0.0%0.2 KB 0.0%
nocem 2 0.0%0.1 KB 0.0%
TOTAL: 6 192582 100.0%18.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 110675 65.1%
Negative hits 59257 34.9%
Positive hits 12 0.0%
Cache misses 0 0.0%
TOTAL: 4 169944 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.375 0.0%78 0.000 4.808 35.000
article cleanup00:00:00.962 0.0%110771 0.000 0.009 0.065
article logging00:00:01.515 0.0%111135 0.000 0.014 0.056
article parse00:00:47.802 0.1%4325767 0.000 0.011 0.049
article write01:20:18.449 5.6%110524 1.909 43.596 246.544
artlog/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:04.967 0.0%4569141 0.000 0.001 0.012
hisgrep/artcncl00:00:00.095 0.0%91 0.000 1.044 7.000
hishave/artcncl00:00:00.000 0.0%13 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:38.425 0.0%170028 0.095 0.226 3.173
history sync00:00:01.394 0.0%345 0.000 4.041 14.500
history write00:03:13.303 0.2%110771 0.471 1.745 10.993
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:03:28.991 92.5%4264752 0.749 18.620 12509.854
nntp read00:01:54.542 0.1%4314850 0.000 0.027 0.060
overview write00:01:30.627 0.1%110524 0.157 0.820 6.556
perl filter00:00:08.631 0.0%110686 0.000 0.078 0.208
python filter00:18:14.484 1.3%169489 0.412 6.458 35.959
site send00:00:03.530 0.0%110591 0.000 0.032 0.125
TOTAL: 23:51:04.19423:50:28.092100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.000 0.0%0 0.000 0.000 0.000
article prepare00:00:00.000 0.0%0 0.000 0.000 0.000
article read00:00:00.000 0.0%0 0.000 0.000 0.000
backlog stats00:00:00.003 0.0%3714 0.000 0.001 0.038
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.000 0.0%6 0.000 0.000 0.000
data write00:00:00.001 0.0%6 0.000 0.167 0.500
idle23:46:42.571100.0%371417843.118 23048.619 24224.154
status file00:00:00.001 0.0%12 0.000 0.083 0.500
TOTAL: 23:46:42.61623:46:42.576100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.692 0.0%2299 0.000 0.736 34.000
idle00:00:00.000 0.0%0 0.000 0.000 0.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:25:03.341 1.7%11846217 0.000 0.127 552.933
readart00:00:01.090 0.0%2299 0.000 0.474 44.500
TOTAL: 25:00:49.40200:25:06.123 1.7%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 1
logmode 2
mode 149
name 2
pause 1
paused 1
reload 2
renumber 1
xexec 2
TOTAL: 11 168

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1localhost 589 58718 58670 0 48 99%02:05:10
2feed1.usenet.blueworldhosting.com 13 53384 53185 0 199 99%25:14:26
TOTAL: 2 602 112102 111855 0 247 99%27:19:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed1.usenet.blueworldhosting.com20.9 GB0.0 KB1.6 MB20.9 GB 99%410.3 KB
2localhost154.1 MB0.0 KB2.1 MB156.2 MB 98%2.7 KB
TOTAL: 221.0 GB0.0 KB3.7 MB21.0 GB 99%196.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 24 02:30:00 - 02:59:59 429 0.4% 0.2491.0 MB 0.4% 51.78
Oct 24 03:00:00 - 03:59:59 606 0.5% 0.172.1 MB 0.0% 0.59
Oct 24 04:00:00 - 04:59:59 778 0.7% 0.222.7 MB 0.0% 0.77
Oct 24 05:00:00 - 05:59:59 695 0.6% 0.192.3 MB 0.0% 0.66
Oct 24 06:00:00 - 06:59:59 763 0.7% 0.2129.5 MB 0.1% 8.39
Oct 24 07:00:00 - 07:59:59 740 0.7% 0.218.0 MB 0.0% 2.28
Oct 24 08:00:00 - 08:59:59 693 0.6% 0.192.5 MB 0.0% 0.71
Oct 24 09:00:00 - 09:59:59 873 0.8% 0.246.5 MB 0.0% 1.86
Oct 24 10:00:00 - 10:59:59 837 0.7% 0.2310.4 MB 0.0% 2.95
Oct 24 11:00:00 - 11:59:59 3253 2.9% 0.901.1 GB 5.1% 311.02
Oct 24 12:00:00 - 12:59:59 691 0.6% 0.1930.1 MB 0.1% 8.57
Oct 24 13:00:00 - 13:59:59 7494 6.7% 2.082.9 GB 13.8% 843.17
Oct 24 14:00:00 - 14:59:59 7664 6.9% 2.133.0 GB 14.2% 868.47
Oct 24 15:00:00 - 15:59:59 723 0.6% 0.202.5 MB 0.0% 0.70
Oct 24 16:00:00 - 16:59:59 25497 22.8% 7.08502.8 MB 2.3% 143.03
Oct 24 17:00:00 - 17:59:59 39146 35.0% 10.872.6 GB 12.5% 765.40
Oct 24 18:00:00 - 18:59:59 7501 6.7% 2.084.4 GB 20.9%1281.10
Oct 24 19:00:00 - 19:59:59 5212 4.7% 1.453.1 GB 14.6% 895.05
Oct 24 20:00:00 - 20:59:59 1952 1.7% 0.541.0 GB 4.9% 299.68
Oct 24 21:00:00 - 21:59:59 261 0.2% 0.071.6 MB 0.0% 0.47
Oct 24 22:00:00 - 22:59:59 1456 1.3% 0.40878.0 MB 4.1% 249.74
Oct 24 23:00:00 - 23:59:59 716 0.6% 0.20281.1 MB 1.3% 79.95
Oct 25 00:00:00 - 00:59:59 2272 2.0% 0.63654.4 MB 3.0% 186.14
Oct 25 01:00:00 - 01:59:59 1229 1.1% 0.34529.1 MB 2.5% 150.50
Oct 25 02:00:00 - 02:30:00 226 0.2% 0.13576.4 KB 0.0% 0.32
TOTAL: 24:00:00 111707 100.0% 1.2921.0 GB 100.0% 255.30
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1feed1.usenet.blueworldhosting.com 552 161 0 0 0 0 0 0 391
2localhost 58 0 0 0 0 0 0 0 58
TOTAL: 2 610 161 0 0 0 0 0 0 449

Unwanted newsgroups [Top 20]:

NewsgroupCount
finet.binaries.keskustelu 25
alt.binaries.pictures.nude.celebrities.fake 15
alt.binaries.pictures.scenic 11
alt.binaries.pictures.purebeauty 11
alt.binaries.3d.poser 10
alt.binaries.test.yenc 7
alt.binaries.boneless 5
alt.binaries.pictures.teen-starlets 5
alt.binaries.howard-stern 5
alt.binaries.mp3.audiobooks 5
alt.binaries.pictures.wallpaper 4
alt.binaries.pictures.young.celebrities 4
alt.binaries.sounds.lossless 4
comp.windows.garnet 3
alt.binaries.sounds.lossless.1960s 3
alt.binaries.drwho 2
alt.binaries.dc 2
alt.binaries.multimedia.videos.music 2
alt.binaries.sounds.mp3.soul-rhythm-and-blues 2
alt.binaries.nospam.female.bodyhair 2
TOTAL: 53 161

INND Python filter [Top 20]:

ReasonCount
Binary (uuEnc) 27
Bad From (hclaudioblanco@gmail.com) 16
EMP Body Reject 15
Binary (base64) 14
Bad From (FBInCIAnNSATerroristSlayer@yahoo.com) 5
Bad Subject (Cocaine for sale) 2
Bad Subject (LA_PARLAMENTARE_ASSASSINA) 2
Bad Subject (Buy Weed Online) 1
Bad Subject (Buy Adderall) 1
Crosspost Low Limit Exceeded 1
Bad Subject (Buy Cocaine) 1
TOTAL: 11 85

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad Message-ID's offered
localhost 1
TOTAL: 1 1
Including strange strings
feed1.usenet.blueworldhosting.com 354
localhost 10
TOTAL: 2 364
TOTAL: 2 365

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1feed1.usenet.blueworldhosting.com 0 0 0 0 0 0 0%00:24:20
TOTAL: 1 0 0 0 0 0 0 0%00:24:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1feed1.usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s000:24:20
TOTAL: 10.0 KB0.0 KB0.0 KB0.0 KB/s000:24:20
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1023-084-030-207.res.spectrum.com 102 6015.3 MB 0 0 001:02:04
2beautiful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
3jovial.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
4handsome.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
5independent.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
6toma-03.stehlik.co.uk 814 00.0 KB 0 0 020:14:49
7pretty.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
8phenomenal.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
9exciting.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
10skilful.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
11glorious.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:06
12optimistic.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
13distinguished.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:00
14209.160.113.187 28 00.0 KB 02239 003:43:42
TOTAL: 14 955 6015.3 MB 02239 025:00:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 102 6015.3 MB 0 0 001:02:04
2*.monitoring.internet-measurement.com 11 00.0 KB 0 0 000:00:07
3*.stehlik.co.uk 814 00.0 KB 0 0 020:14:49
4unresolved 28 00.0 KB 02239 003:43:42
TOTAL: 4 955 6015.3 MB 02239 025:00:44

NNRP auth users [Top 20]:

UserConn
0.062 system 0.000 idle 0.000 elapsed 0.062 350
0.061 system 0.000 idle 0.000 elapsed 0.061 180
0.054 system 0.008 idle 0.000 elapsed 0.061 178
0.063 system 0.000 idle 0.000 elapsed 0.063 173
0.054 system 0.008 idle 0.000 elapsed 0.062 160
0.062 system 0.000 idle 0.000 elapsed 0.061 134
jesse 130
0.055 system 0.008 idle 0.000 elapsed 0.062 115
0.055 system 0.008 idle 0.000 elapsed 0.063 112
0.064 system 0.000 idle 0.000 elapsed 0.064 99
0.065 system 0.000 idle 0.000 elapsed 0.065 81
0.047 system 0.016 idle 0.000 elapsed 0.062 68
0.046 system 0.015 idle 0.000 elapsed 0.061 64
0.063 system 0.000 idle 0.000 elapsed 0.062 62
0.056 system 0.008 idle 0.000 elapsed 0.064 61
0.066 system 0.000 idle 0.000 elapsed 0.066 58
0.057 system 0.008 idle 0.000 elapsed 0.065 42
0.053 system 0.009 idle 0.000 elapsed 0.061 34
0.047 system 0.016 idle 0.000 elapsed 0.063 31
0.067 system 0.000 idle 0.000 elapsed 0.067 30
TOTAL: 283 3135

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
toma-03.stehlik.co.uk 162.071 53.989 0.00020:14:49
209.160.113.187 55.740 49.034 0.12803:43:42
023-084-030-207.res.spectrum.com 8.560 1.963 0.65501:02:04
glorious.monitoring.internet-measurement.com 0.080 0.007 0.00000:00:06
jovial.monitoring.internet-measurement.com 0.061 0.020 0.00000:00:00
skilful.monitoring.internet-measurement.com 0.076 0.000 0.00000:00:00
phenomenal.monitoring.internet-measurement.com 0.071 0.008 0.00000:00:00
TOTAL: 7 226.659 105.021 0.78325:00:44

NNRP client timeouts [Top 20]:

SystemConnPeer
023-084-030-207.res.spectrum.com 102 102
TOTAL: 1 102 103
innreport from INN 2.7.0 based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then