Daily Usenet report for news.cyber23.de

Nov 11 03:00:00 -- Nov 12 03:00:00

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Nov 11 16:06:07 news rnews[93854]: usage error
Nov 11 16:12:05 news send-uucp[93899]: no batch file for site news.quux.org
Nov 11 18:30:07 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:30:09 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:30:09 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:30:13 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:30:14 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:30:38 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:30:38 news innd[96024]: filter: Cannot open badhosts: No such file or directory
Nov 11 18:45:07 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:45:08 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:45:10 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:45:10 news innd[96024]: filter: Cannot open badhosts: No such file or directory
Nov 11 18:45:13 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:45:16 news innd[96024]: filter: Cannot open emp.md5: No such file or directory
Nov 11 18:45:16 news innd[96024]: filter: Cannot open badhosts: No such file or directory

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 62595 63.3%6.0 MB 54.6%
innd 20347 20.6%3.2 MB 29.4%
inn 14491 14.6%1.5 MB 14.0%
innfeed 1516 1.5%220.5 KB 2.0%
controlchan 6 0.0%0.4 KB 0.0%
batcher 4 0.0%0.3 KB 0.0%
rnews 1 0.0%0.2 KB 0.0%
send-uucp 1 0.0%0.1 KB 0.0%
TOTAL: 8 98961 100.0%11.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 13711 40.5%
Positive hits 13674 40.4%
Negative hits 6444 19.0%
Cache misses 3 0.0%
TOTAL: 4 33832 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%36 0.000 0.000 0.000
article cleanup00:00:00.207 0.0%14049 0.000 0.015 0.500
article logging00:00:00.314 0.0%14472 0.000 0.022 0.667
article parse00:00:00.524 0.0%31917 0.000 0.016 0.500
article write00:00:13.673 0.0%13638 0.000 1.003 25.333
data move00:00:00.307 0.0%37875 0.000 0.008 0.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.888 0.0%33850 0.000 0.263 34.000
history sync00:00:01.035 0.0%1524 0.000 0.679 53.000
history write00:00:06.828 0.0%13718 0.000 0.498 21.000
idle23:56:36.572 99.9%54814 190.580 1572.528 60035.000
nntp read00:00:07.993 0.0%51284 0.000 0.156 3.111
overview write00:00:08.818 0.0%13638 0.000 0.647 26.571
perl filter00:00:07.512 0.0%13718 0.000 0.548 6.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.780 0.0%13480 0.000 0.280 5.667
TOTAL: 23:58:07.94723:57:36.451100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.005 0.0%4 0.000 1.250 3.000
article prepare00:00:00.000 0.0%16 0.000 0.000 0.000
article read00:00:00.168 0.0%4 0.000 42.000 133.000
backlog stats00:00:00.019 0.0%3824 0.000 0.005 0.500
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.002 0.0%31 0.000 0.065 0.200
data write00:00:00.002 0.0%27 0.000 0.074 0.500
idle23:56:30.023100.0%3824 6149.000 22539.232 30105.000
status file00:00:00.007 0.0%33 0.000 0.212 2.000
TOTAL: 23:56:30.80523:56:30.226100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle118:06:23.047 99.9%138443 18.500 3071.178293314.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:25.448 0.0%394300 0.000 0.065 4.667
readart00:00:00.051 0.0%53 0.962 0.962 0.962
TOTAL: 118:10:45.718118:06:48.546 99.9%----

Control commands to INND:

CommandNumber
flush 17
flushlogs 2
go 2
logmode 2
lowmark 1
mode 152
name 2
newgroup 1
pause 2
paused 2
reload 16
reserve 2
shutdown 3
xexec 2
TOTAL: 14 206

Newsgroups created:

GroupMode
local.testy
TOTAL1

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1cyber23-out.news.weretis.net 12 27395 13661 13323 411 49%48:09:38
2localhost 6 4 4 0 0 100%00:00:01
TOTAL: 2 18 27399 13665 13323 411 49%48:09:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1cyber23-out.news.weretis.net51.0 MB1.6 MB2.0 MB54.6 MB 93%4.0 KB
2localhost3.3 KB0.0 KB0.0 KB3.3 KB100%0.8 KB
TOTAL: 251.0 MB1.6 MB2.0 MB54.6 MB 93%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 11 03:00:00 - 03:59:59 265 1.9% 0.07846.4 KB 1.6% 0.24
Nov 11 04:00:00 - 04:59:59 284 2.1% 0.081.7 MB 3.4% 0.49
Nov 11 05:00:00 - 05:59:59 239 1.8% 0.071.9 MB 3.8% 0.55
Nov 11 06:00:00 - 06:59:59 272 2.0% 0.08867.2 KB 1.7% 0.24
Nov 11 07:00:00 - 07:59:59 345 2.5% 0.101.2 MB 2.3% 0.33
Nov 11 08:00:00 - 08:59:59 509 3.7% 0.141.8 MB 3.4% 0.50
Nov 11 09:00:00 - 09:59:59 499 3.7% 0.141.7 MB 3.3% 0.48
Nov 11 10:00:00 - 10:59:59 562 4.1% 0.162.7 MB 5.3% 0.77
Nov 11 11:00:00 - 11:59:59 569 4.2% 0.162.0 MB 4.0% 0.58
Nov 11 12:00:00 - 12:59:59 737 5.4% 0.202.2 MB 4.3% 0.62
Nov 11 13:00:00 - 13:59:59 597 4.4% 0.172.5 MB 5.0% 0.73
Nov 11 14:00:00 - 14:59:59 681 5.0% 0.193.3 MB 6.4% 0.93
Nov 11 15:00:00 - 15:59:59 720 5.3% 0.203.0 MB 5.9% 0.85
Nov 11 16:00:00 - 16:59:59 750 5.5% 0.212.8 MB 5.4% 0.78
Nov 11 17:00:00 - 17:59:59 915 6.7% 0.252.8 MB 5.5% 0.80
Nov 11 18:00:00 - 18:59:59 765 5.6% 0.213.6 MB 7.2% 1.04
Nov 11 19:00:00 - 19:59:59 799 5.9% 0.222.5 MB 4.9% 0.71
Nov 11 20:00:00 - 20:59:59 866 6.3% 0.242.6 MB 5.2% 0.75
Nov 11 21:00:00 - 21:59:59 758 5.6% 0.212.1 MB 4.1% 0.59
Nov 11 22:00:00 - 22:59:59 770 5.6% 0.212.3 MB 4.5% 0.66
Nov 11 23:00:00 - 23:59:59 638 4.7% 0.182.4 MB 4.7% 0.68
Nov 12 00:00:00 - 00:59:59 468 3.4% 0.131.7 MB 3.4% 0.50
Nov 12 01:00:00 - 01:59:59 368 2.7% 0.101.3 MB 2.6% 0.38
Nov 12 02:00:00 - 02:59:59 280 2.1% 0.081.1 MB 2.2% 0.31
Nov 12 03:00:00 - 03:00:00 1 0.0% 0.002.9 KB 0.0% 0.00
TOTAL: 24:00:00 13657 100.0% 0.1650.9 MB 100.0% 0.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1cyber23-out.news.weretis.net 834 18 0 331 0 0 0 0 485
TOTAL: 1 834 18 0 331 0 0 0 0 485

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.english.usage 8
alt.religion 4
lada.auto 3
alt.pl.mozilla 1
lada.photo 1
mailing.postfix.users 1
TOTAL: 6 18

INND Perl filter [Top 20]:

ReasonCount
User-issued spam cancel 32
EMP (md5) 11
Too many newsgroups 11
HTML Multipart 4
User-issued cancel 3
HTML 1
TOTAL: 6 62

INND misc events:

EventsCount
RCreader 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
cyber23-out.news.weretis.net 423
TOTAL: 1 423
TOTAL: 1 423

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1weretis.net 4 4 0 0 0 0100%01:07:57
TOTAL: 1 4 4 0 0 0 0100%01:07:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1weretis.net3.3 KB0.0 KB3.3 KB0.0 KB/s0.8 KB01:07:57
TOTAL: 13.3 KB0.0 KB3.3 KB0.0 KB/s0.8 KB01:07:57
Outgoing feeds (innfeed) by Volume

UUCP batches created:

ServerOfferedArticlesSizeElapsed
news.quux.org 2 4111.6 MB00:00:00
TOTAL: 1 2 4111.6 MB00:00:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 31 53192.4 KB 14 11 0118:04:42
2*.unhb.de1440 00.0 KB 0 0 000:05:51
TOTAL: 21471 53192.4 KB 14 11 0118:10:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a02:908:2d12:a700:81b8:4b81:f698:1e55 18.061 32.129 0.000104:07:42
2a02:908:2d12:a700:96e8:c5ee:96da:20d 3.415 0.894 0.00013:57:00
neuromail.unhb.de 107.147 25.510 0.00000:05:51
188.166.37.60 0.700 0.090 0.00000:00:00
94.232.43.32 0.140 0.008 0.00000:00:00
TOTAL: 5 129.463 58.631 0.000118:10:35

Curious NNRP server explorers [Top 20]:

SystemConn
neuromail.unhb.de 1440
2a02:908:2d12:a700:96e8:c5ee:96da:20d 31
TOTAL: 2 1471

NNRP no permission clients:

SystemConn
188.166.37.60 9
94.232.43.32 2
TOTAL: 2 11

NNRP client timeouts [Top 20]:

SystemConnPeer
2a02:908:2d12:a700:96e8:c5ee:96da:20d 14 0
2a02:908:2d12:a700:81b8:4b81:f698:1e55 2 0
TOTAL: 2 16 0

Newsgroup request counts (by category):

CategoryCountPct
1de 10 71.4%
2xs4all 3 21.4%
3control 1 7.1%
TOTAL: 3 14100.0%

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

NewsgroupCount
1de.test 6
2xs4all.test 3
3de.talk.tagesgeschehen 2
4de.alt.admin 2
5control.cancel 1
TOTAL: 5 14