Daily Usenet report for news.cyber23.de

Dec 1 03:00:03 -- Dec 2 03:00:01

Unknown entries from news log file:

First 50 / 107 lines (46.7%)

Dec 1 03:01:00 news nnrpd[65864]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 03:16:04 news nnrpd[66160]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 03:31:05 news nnrpd[66267]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 03:46:06 news nnrpd[66370]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 04:00:59 news nnrpd[66498]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 04:16:03 news nnrpd[66596]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 04:30:59 news nnrpd[66695]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 04:45:58 news nnrpd[66928]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 05:00:59 news nnrpd[67051]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 05:15:59 news nnrpd[67153]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 05:18:10 news nnrpd[67159]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 05:31:01 news nnrpd[67699]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 05:46:00 news nnrpd[67946]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 06:01:00 news nnrpd[68335]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 06:15:58 news nnrpd[68579]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 06:31:09 news nnrpd[68967]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 06:46:21 news nnrpd[69220]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 07:00:59 news nnrpd[69609]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 07:16:00 news nnrpd[69848]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 07:30:59 news nnrpd[70227]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 07:45:59 news nnrpd[70480]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 08:00:59 news nnrpd[70867]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 08:16:03 news nnrpd[71109]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 08:31:04 news nnrpd[71493]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 08:44:56 news nnrpd[71714]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 08:46:01 news nnrpd[71744]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 09:01:03 news nnrpd[72134]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 09:13:17 news nnrpd[72344]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 09:13:17 news nnrpd[72345]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 09:16:03 news nnrpd[72377]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 09:21:59 news pgpverify[72554]: pgpverify: verification failed
Dec 1 09:31:03 news nnrpd[72769]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 09:46:02 news nnrpd[73019]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 10:01:06 news nnrpd[73415]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 10:16:01 news nnrpd[73665]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 10:31:00 news nnrpd[74075]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 10:46:01 news nnrpd[74337]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 10:55:48 news nnrpd[74541]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 11:01:08 news nnrpd[74724]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 11:16:02 news nnrpd[74949]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 11:31:00 news nnrpd[75315]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 11:46:04 news nnrpd[75547]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 12:01:13 news nnrpd[75919]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 12:15:58 news nnrpd[76147]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 12:31:01 news nnrpd[76517]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 12:46:05 news nnrpd[76749]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 13:01:03 news nnrpd[77122]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 13:16:00 news nnrpd[77349]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 13:30:14 news nnrpd[77715]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory
Dec 1 13:31:03 news nnrpd[77716]: open of /usr/local/news/etc/inn-secrets.conf failed: No such file or directory

Log entries by program:

Program nameLines%LinesSize%Size
inn 33691 60.2%4.4 MB 59.4%
innd 11512 20.6%1.8 MB 24.4%
nnrpd 8254 14.7%931.9 KB 12.3%
innfeed 1936 3.5%240.8 KB 3.2%
batcher 576 1.0%51.1 KB 0.7%
controlchan 13 0.0%2.5 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 55983 100.0%7.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 31133 45.4%
Negative hits 25387 37.0%
Positive hits 11992 17.5%
Cache misses 20 0.0%
TOTAL: 4 68532 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.000 0.0%74 0.000 0.000 0.000
article cleanup00:00:00.540 0.0%33386 0.000 0.016 0.500
article logging00:00:02.414 0.0%33689 0.000 0.072 1.000
article parse00:00:12.615 0.0%611732 0.000 0.021 2.714
article write00:11:56.011 0.8%31136 0.000 22.996 233.000
data move00:00:01.992 0.0%710935 0.000 0.003 0.160
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:54.025 0.2%68543 0.000 2.539 29.500
history sync00:00:30.721 0.0%1538 0.000 19.975 415.000
history write00:03:54.111 0.3%31136 0.000 7.519 83.500
idle23:34:09.200 98.3%629563 4.607 134.775 60071.000
nntp read00:00:34.991 0.0%626827 0.000 0.056 6.350
overview write00:03:44.443 0.3%31136 0.000 7.208 215.500
perl filter00:00:03.790 0.0%31136 0.000 0.122 3.571
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:06.469 0.0%73527 0.000 0.088 9.000
TOTAL: 23:59:20.10523:58:11.322 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.183 0.0%78151 0.000 0.002 0.250
article prepare00:00:00.061 0.0%257856 0.000 0.000 0.028
article read00:07:24.168 0.5%64435 0.000 6.893 123.000
backlog stats00:00:03.397 0.0%2795987 0.000 0.001 0.083
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.057 0.0%88434 0.000 0.046 7.000
data write00:21:58.914 1.5%2758348 0.000 0.478 4.333
idle23:28:57.470 97.9%2795987 5.657 30.235 30013.500
status file00:00:00.560 0.0%178 0.000 3.146 45.000
TOTAL: 23:59:11.59923:58:28.810100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:45:24.171 98.4%16027 0.892 394.595600016.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:05.579 0.1%32023 0.000 0.174 16.605
readart00:00:00.245 0.0%56 0.000 4.375 26.000
TOTAL: 01:47:09.71601:45:29.995 98.4%----

Control commands to INND:

CommandNumber
flush 292
flushlogs 2
go 2
logmode 2
lowmark 1
mode 136
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 443

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1localhost 281 20632 19886 746 0 96%04:26:13
2cyber23-out.news.weretis.net 5 22549 11279 9015 2255 50%48:14:06
3v6news.dyn.cyber23.de 4 0 0 0 0 0%00:10:01
TOTAL: 3 290 43181 31165 9761 2255 72%52:50:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1localhost7.3 GB0.0 KB0.0 KB7.3 GB100%386.5 KB
2cyber23-out.news.weretis.net47.4 MB10.9 MB10.9 MB69.1 MB 68%5.2 KB
3v6news.dyn.cyber23.de0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 37.4 GB10.9 MB10.9 MB7.4 GB 99%232.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 1 03:00:03 - 03:59:59 200 0.6% 0.06841.9 KB 0.0% 0.23
Dec 1 04:00:00 - 04:59:59 203 0.7% 0.062.0 MB 0.0% 0.58
Dec 1 05:00:00 - 05:59:59 235 0.8% 0.07864.5 KB 0.0% 0.24
Dec 1 06:00:00 - 06:59:59 290 0.9% 0.081.0 MB 0.0% 0.29
Dec 1 07:00:00 - 07:59:59 333 1.1% 0.091.2 MB 0.0% 0.34
Dec 1 08:00:00 - 08:59:59 348 1.1% 0.101.4 MB 0.0% 0.39
Dec 1 09:00:00 - 09:59:59 504 1.6% 0.143.1 MB 0.0% 0.88
Dec 1 10:00:00 - 10:59:59 1562 5.0% 0.43379.2 MB 5.0% 107.86
Dec 1 11:00:00 - 11:59:59 6521 20.9% 1.812.2 GB 29.9% 640.63
Dec 1 12:00:00 - 12:59:59 5691 18.3% 1.581.9 GB 25.3% 542.65
Dec 1 13:00:00 - 13:59:59 5946 19.1% 1.652.0 GB 26.7% 573.06
Dec 1 14:00:00 - 14:59:59 3080 9.9% 0.86953.1 MB 12.6% 271.09
Dec 1 15:00:00 - 15:59:59 563 1.8% 0.161.9 MB 0.0% 0.54
Dec 1 16:00:00 - 16:59:59 632 2.0% 0.181.9 MB 0.0% 0.53
Dec 1 17:00:00 - 17:59:59 617 2.0% 0.173.2 MB 0.0% 0.91
Dec 1 18:00:00 - 18:59:59 696 2.2% 0.192.4 MB 0.0% 0.68
Dec 1 19:00:00 - 19:59:59 567 1.8% 0.162.4 MB 0.0% 0.68
Dec 1 20:00:00 - 20:59:59 543 1.7% 0.152.4 MB 0.0% 0.67
Dec 1 21:00:00 - 21:59:59 501 1.6% 0.141.8 MB 0.0% 0.51
Dec 1 22:00:00 - 22:59:59 565 1.8% 0.161.7 MB 0.0% 0.48
Dec 1 23:00:00 - 23:59:59 550 1.8% 0.152.8 MB 0.0% 0.78
Dec 2 00:00:00 - 00:59:59 413 1.3% 0.111.8 MB 0.0% 0.52
Dec 2 01:00:00 - 01:59:59 328 1.1% 0.091.4 MB 0.0% 0.40
Dec 2 02:00:00 - 03:00:01 249 0.8% 0.07779.4 KB 0.0% 0.22
TOTAL: 23:59:58 31137 100.0% 0.367.4 GB 100.0% 89.38
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1cyber23-out.news.weretis.net 2554 18 0 2251 0 0 0 0 285
TOTAL: 1 2554 18 0 2251 0 0 0 0 285

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.politics.republican 10
alt.info-science 6
fr.misc.domotique 1
adobe.illustrator.windows 1
TOTAL: 4 18

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1v6news.dyn.cyber23.de 64506 64370 0 54 0 13728 99%23:59:34
2weretis.net 4 0 0 4 0 0 0%00:50:30
TOTAL: 2 64510 64370 0 58 0 13728 99%24:50:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1v6news.dyn.cyber23.de17.6 GB1.6 MB17.6 GB213.6 KB/s286.3 KB23:59:34
2weretis.net0.0 KB125.5 KB125.5 KB0.0 KB/s31.4 KB00:50:30
TOTAL: 217.6 GB1.7 MB17.6 GB206.3 KB/s286.3 KB24:50:04
Outgoing feeds (innfeed) by Volume

UUCP batches created:

ServerOfferedArticlesSizeElapsed
news.quux.org 288 1125645.5 MB00:02:58
TOTAL: 1 288 1125645.5 MB00:02:58

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a02:908:2d17:4680:a1fc:964c:be70:d154 3 551.2 MB 3 0 001:32:14
2p200300f1c723a100494a7667adb37a36.dip0.t-ipconnect.de 15 14.2 KB 1 0 000:01:58
3neuromail.unhb.de 4 00.0 KB 0 4 000:00:02
TOTAL: 3 22 561.2 MB 4 4 001:47:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 3 551.2 MB 3 0 001:32:14
2*.dip0.t-ipconnect.de 96 14.2 KB 1 0 000:14:24
3*.unhb.de 4 00.0 KB 0 4 000:00:02
4*.internet-census.org 1 00.0 KB 0 0 000:00:06
5unresolved 2 00.0 KB 0 0 000:00:21
TOTAL: 5 106 561.2 MB 4 4 001:47:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a02:908:2d17:4680:a1fc:964c:be70:d154 0.234 0.196 0.00001:32:14
p200300f1c70817007be092a3b7fc4c6a.dip0.t-ipconnect.de 11.287 8.954 0.00000:12:05
p200300f1c723a100494a7667adb37a36.dip0.t-ipconnect.de 1.740 1.184 0.00000:01:58
p200300f1c705fa00c9579c57550d8908.dip0.t-ipconnect.de 0.497 0.361 0.00000:00:16
183.136.225.42 0.143 0.034 0.00000:00:11
192.241.192.21 0.045 0.036 0.00000:00:09
zl-lax-us-gp1-wk126.internet-census.org 0.113 0.201 0.00000:00:06
p5081a35e.dip0.t-ipconnect.de 0.181 0.105 0.00000:00:03
neuromail.unhb.de 0.425 0.126 0.00000:00:02
TOTAL: 9 14.665 11.197 0.00001:47:09

Curious NNRP server explorers [Top 20]:

SystemConn
p200300f1c70817007be092a3b7fc4c6a.dip0.t-ipconnect.de 77
p200300f1c705fa00c9579c57550d8908.dip0.t-ipconnect.de 3
zl-lax-us-gp1-wk126.internet-census.org 1
p5081a35e.dip0.t-ipconnect.de 1
183.136.225.42 1
192.241.192.21 1
TOTAL: 6 84

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

SystemConn
183.136.225.42 1
TOTAL: 1 1

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

CommandCount
^V^C^A^B 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
2a02:908:2d17:4680:a1fc:964c:be70:d154 3 0
183.136.225.42 1 1
TOTAL: 2 4 1

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1junk 54 96.4%
2alt 1 1.8%
3unhb 1 1.8%
TOTAL: 3 56100.0%

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

NewsgroupCount
1junk 54
2alt.folklore.computers 1
3unhb.discuss 1
TOTAL: 3 56