Daily Usenet report

Jul 5 04:15:01 -- Jul 6 04:15:01

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.sabbelkanal y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.sabbelkanal y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.test2 y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.test2 y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.test2 y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.test2 y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.test2 y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.test2 y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.sabbel-kanal y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.sabbel-kanal y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.sabbelkanal y lkh%dwalin.uucp (would be created): Empty description
Jul 5 23:35:05 newsfeed controlchan[395535]: skipping newgroup grenzland.sabbelkanal y lkh%dwalin.uucp (would be created): Empty description

Log entries by program:

Program nameLines%LinesSize%Size
inn 464391 91.5%51.2 MB 92.3%
innd 25250 5.0%2.5 MB 4.6%
nnrpd 16518 3.3%1.6 MB 2.8%
innfeed 1182 0.2%154.6 KB 0.3%
controlchan 38 0.0%6.5 KB 0.0%
TOTAL: 5 507379 100.0%55.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 918744 95.3%
Negative hits 34030 3.5%
Cache misses 10906 1.1%
Positive hits 70 0.0%
TOTAL: 4 963750 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.078 0.0%68 0.000 1.147 2.667
article cleanup00:00:05.890 0.0%928092 0.003 0.006 0.012
article logging00:00:22.322 0.0%928106 0.014 0.024 0.040
article parse00:00:58.880 0.0%2912716 0.011 0.020 0.027
article write00:21:19.396 0.7%921190 0.660 1.389 3.972
artlog/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:04.638 0.0%4307568 0.000 0.001 0.002
hisgrep/artcncl00:00:00.074 0.0%78 0.000 0.949 2.667
hishave/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:08:25.638 0.3%967384 0.004 0.523 4.892
history sync00:00:00.018 0.0%748 0.000 0.024 0.500
history write00:09:55.674 0.3%921190 0.037 0.647 4.845
idle46:56:59.042 97.7%3267516 24.647 51.727 107.037
nntp read00:00:50.866 0.0%2697740 0.011 0.019 0.027
overview write00:00:03.338 0.0%921190 0.001 0.004 0.009
perl filter00:20:09.048 0.7%921190 0.857 1.312 1.768
python filter00:00:00.274 0.0%921190 0.000 0.000 0.001
site send00:00:25.782 0.0%1852914 0.010 0.014 0.021
TOTAL: 48:01:50.92047:59:40.958 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%10510 0.000 0.002 0.071
article prepare00:00:00.000 0.0%456 0.000 0.000 0.000
article read00:00:00.006 0.0%114 0.000 0.053 1.000
backlog stats00:00:00.016 0.0%62848 0.000 0.000 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.400 0.0%28770 0.000 0.014 0.067
data write00:00:01.018 0.0%18210 0.000 0.056 0.188
idle47:58:37.640100.0%62848 797.158 2748.180 8493.603
status file00:00:00.148 0.0%308 0.000 0.481 2.000
TOTAL: 47:58:40.13647:58:39.252100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:23:31.592 91.9%13466 0.000 104.826 3856.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.692 0.0%48150 0.000 0.014 0.500
readart00:00:34.888 2.3%4488 0.000 7.774 7.794
TOTAL: 00:25:35.80000:24:07.172 94.2%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 298
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 386

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
lkh%dwalin.uucp18200020
lkh%v36407.1blu.de400004
TOTAL22200024

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 132 932920 921910 4106 6904 98%70:38:04
2localhost 2 0 0 0 0 0%00:00:00
3news.icm.edu.pl 48 64 0 62 2 0%09:29:50
TOTAL: 3 182 932984 921910 4168 6906 98%80:07:54
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl9.5 GB109.0 MB0.0 KB9.6 GB 98%10.8 KB
2localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
3news.icm.edu.pl0.0 KB37.6 KB0.0 KB37.6 KB 0%18.8 KB
TOTAL: 39.5 GB109.0 MB0.0 KB9.6 GB 98%10.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 5 04:15:01 - 04:59:59 9505 2.1% 3.52113.5 MB 2.3% 43.05
Jul 5 05:00:00 - 05:59:59 11135 2.4% 3.09133.5 MB 2.8% 37.99
Jul 5 06:00:00 - 06:59:59 12632 2.7% 3.51175.1 MB 3.6% 49.80
Jul 5 07:00:00 - 07:59:59 11658 2.5% 3.24139.0 MB 2.9% 39.54
Jul 5 08:00:00 - 08:59:59 11103 2.4% 3.08140.2 MB 2.9% 39.88
Jul 5 09:00:00 - 09:59:59 14646 3.2% 4.07149.7 MB 3.1% 42.57
Jul 5 10:00:00 - 10:59:59 14759 3.2% 4.10183.3 MB 3.8% 52.14
Jul 5 11:00:00 - 11:59:59 22068 4.8% 6.13217.0 MB 4.5% 61.72
Jul 5 12:00:00 - 12:59:59 19047 4.1% 5.29201.0 MB 4.1% 57.17
Jul 5 13:00:00 - 13:59:59 18574 4.0% 5.16195.6 MB 4.0% 55.64
Jul 5 14:00:00 - 14:59:59 19675 4.3% 5.47231.7 MB 4.8% 65.90
Jul 5 15:00:00 - 15:59:59 19868 4.3% 5.52239.9 MB 4.9% 68.24
Jul 5 16:00:00 - 16:59:59 18297 4.0% 5.08200.7 MB 4.1% 57.08
Jul 5 17:00:00 - 17:59:59 26830 5.8% 7.45233.9 MB 4.8% 66.53
Jul 5 18:00:00 - 18:59:59 21389 4.6% 5.94216.2 MB 4.5% 61.51
Jul 5 19:00:00 - 19:59:59 25127 5.5% 6.98275.4 MB 5.7% 78.32
Jul 5 20:00:00 - 20:59:59 21166 4.6% 5.88215.3 MB 4.4% 61.25
Jul 5 21:00:00 - 21:59:59 18032 3.9% 5.01177.7 MB 3.7% 50.55
Jul 5 22:00:00 - 22:59:59 25175 5.5% 6.99197.5 MB 4.1% 56.17
Jul 5 23:00:00 - 23:59:59 23332 5.1% 6.48231.2 MB 4.8% 65.76
Jul 6 00:00:00 - 00:59:59 20051 4.4% 5.57196.4 MB 4.0% 55.87
Jul 6 01:00:00 - 01:59:59 25650 5.6% 7.12255.6 MB 5.3% 72.69
Jul 6 02:00:00 - 02:59:59 22036 4.8% 6.12223.6 MB 4.6% 63.61
Jul 6 03:00:00 - 03:59:59 23292 5.1% 6.47243.8 MB 5.0% 69.34
Jul 6 04:00:00 - 04:15:01 5881 1.3% 6.5363.6 MB 1.3% 72.34
TOTAL: 24:00:00 460928 100.0% 5.334.7 GB 100.0% 57.49
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3457 0 0 3450 0 0 0 0 7
2news.icm.edu.pl 1 0 0 1 0 0 0 0 0
TOTAL: 2 3458 0 0 3451 0 0 0 0 7

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 7
TOTAL: 1 7
TOTAL: 1 7

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18266 88 10298 26 0 0 0%47:40:04
2poznan 0 0 0 0 0 0 0%00:20:00
TOTAL: 2 18266 88 10298 26 0 0 0%48:00:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm686.3 KB229.8 KB916.2 KB0.0 KB/s8.0 KB47:40:04
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:20:00
TOTAL: 2686.3 KB229.8 KB916.2 KB0.0 KB/s8.0 KB48:00:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 4 44764.8 MB 6 0 000:21:55
2172.16.2.4 576 1224.8 KB 4 0 000:00:35
TOTAL: 2 580 44884.8 MB 10 0 000:25:35

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 4 44764.8 MB 6 0 000:21:55
2unresolved 792 1224.8 KB 4 0 000:03:03
3*.stretchoid.com 2 00.0 KB 0 0 000:00:00
4*.man.lodz.pl2880 00.0 KB 0 0 000:00:36
5*.bestsrv.de 2 00.0 KB 0 0 000:00:00
TOTAL: 53680 44884.8 MB 10 0 000:25:35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 0.288 0.782 0.00000:21:55
95.163.5.83 0.030 0.044 0.00000:01:46
nms2.man.lodz.pl 13.452 25.712 0.00000:00:36
172.16.2.4 2.916 5.288 0.00000:00:35
167.94.138.190 0.134 0.056 0.00000:00:16
205.210.31.154 0.006 0.008 0.00000:00:07
162.142.125.221 0.098 0.032 0.00000:00:06
80.111.142.213 0.048 0.080 0.00000:00:05
212.51.192.185 0.986 1.676 0.00000:00:02
198.235.24.228 0.012 0.020 0.00000:00:00
v2202406228079275702.bestsrv.de 0.014 0.014 0.00000:00:00
azpdeguta563.stretchoid.com 0.008 0.024 0.00000:00:00
TOTAL: 12 17.992 33.736 0.00000:25:35

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 2880
212.51.192.185 192
80.111.142.213 8
167.94.138.190 6
95.163.5.83 4
198.235.24.228 2
162.142.125.221 2
azpdeguta563.stretchoid.com 2
205.210.31.154 2
v2202406228079275702.bestsrv.de 2
TOTAL: 10 3100

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

SystemConn
v2202406228079275702.bestsrv.de 2
azpdeguta563.stretchoid.com 2
167.94.138.190 2
162.142.125.221 2
TOTAL: 4 8

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

CommandCount
EHLO www.censys.io 4
#003 2
MGLNDD_212.191.2.21_119 2
TOTAL: 3 8

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.190 2 4
TOTAL: 1 2 8

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 4444 99.0%
2lodz 32 0.7%
3pl 12 0.3%
TOTAL: 3 4488100.0%

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

NewsgroupCount
1lodman.info 3980
2lodman.test 464
3lodz.test 32
4pl.comp.os.ms-windows.winnt 12
TOTAL: 4 4488
innreport from INN 2.7.2 (20240212 prerelease) based on initial work (©) 1996-2001 by Fabien Tassin <fta@sofaraway.org> and enhanced by several contributors since then