Daily Usenet report

Sep 18 04:15:02 -- Sep 19 04:15:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Sep 18 06:34:40 newsfeed overchan[1719436]: input line too long, skipping
Sep 18 13:44:09 newsfeed overchan[1719436]: input line too long, skipping
Sep 18 14:32:04 newsfeed overchan[1719436]: input line too long, skipping
Sep 18 14:34:43 newsfeed overchan[1719436]: input line too long, skipping
Sep 18 14:48:02 newsfeed overchan[1719436]: input line too long, skipping
Sep 18 14:50:23 newsfeed overchan[1719436]: input line too long, skipping
Sep 18 22:15:14 newsfeed overchan[1719436]: input line too long, skipping
Sep 18 23:33:55 newsfeed overchan[1719436]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 562911 94.2%62.1 MB 93.5%
innfeed 22917 3.8%2.7 MB 4.1%
innd 8361 1.4%1.3 MB 1.9%
nnrpd 3337 0.6%318.2 KB 0.5%
overchan 9 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 597536 100.0%66.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 559629 99.6%
Negative hits 2140 0.4%
Positive hits 194 0.0%
Cache misses 17 0.0%
TOTAL: 4 561980 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.658 0.0%53 0.000 12.415 47.000
article cleanup00:00:03.816 0.0%562540 0.004 0.007 0.011
article logging00:00:11.951 0.0%562907 0.014 0.021 0.029
article parse00:07:23.309 0.5%108061141 0.003 0.004 0.006
article write00:04:44.883 0.3%562455 0.296 0.506 1.994
artlog/artcncl00:00:00.000 0.0%53 0.000 0.000 0.000
data move00:00:28.722 0.0%112657740 0.000 0.000 0.000
hisgrep/artcncl00:00:00.059 0.0%52 0.000 1.135 16.000
hishave/artcncl00:00:00.002 0.0%53 0.000 0.038 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:39.576 0.2%564847 0.149 0.283 1.341
history sync00:00:00.012 0.0%290 0.000 0.041 0.500
history write00:03:44.799 0.3%562538 0.215 0.400 1.686
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle22:34:16.654 94.0%107948487 0.615 0.753 1.061
nntp read00:22:45.172 1.6%107783966 0.011 0.013 0.015
overview write00:00:01.389 0.0%562455 0.000 0.002 0.005
perl filter00:30:37.053 2.1%562538 2.607 3.266 3.859
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:15.045 0.0%1133897 0.010 0.013 0.016
TOTAL: 24:00:07.75523:47:13.100 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.040 0.0%28768 0.000 0.001 0.013
article prepare00:00:00.001 0.0%5686 0.000 0.000 0.056
article read00:00:13.411 0.0%1441 0.000 9.307 178.143
backlog stats00:00:00.058 0.0%81217 0.000 0.001 0.007
callbacks00:00:00.000 0.0%18 0.000 0.000 0.000
data read00:00:00.407 0.0%37898 0.000 0.011 0.031
data write00:00:00.881 0.0%29475 0.000 0.030 0.075
idle23:55:49.122100.0%81217 663.399 1060.728 2561.119
status file00:00:04.627 0.0%7581 0.355 0.610 7.435
TOTAL: 23:56:10.59323:56:08.547100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:15.792 92.4%2758 0.000 27.481 16223.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.082 0.1%5895 0.000 0.014 0.500
readart00:00:00.000 0.0%36 0.000 0.000 0.000
TOTAL: 00:01:22.00100:01:15.874 92.5%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 95 562486 562404 0 82 99%67:57:41
2news.icm.edu.pl 54 162 2 157 3 1%15:15:26
3localhost 1441 0 0 0 0 0%00:00:00
TOTAL: 3 1590 562648 562406 157 85 99%83:13:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl268.0 GB160.5 KB372.4 KB268.0 GB 99%499.7 KB
2news.icm.edu.pl160.5 KB0.0 KB28.5 KB189.1 KB 84%37.8 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3268.0 GB160.5 KB400.9 KB268.0 GB 99%499.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 18 04:15:02 - 04:59:59 14766 2.6% 5.477.7 GB 2.9%2982.59
Sep 18 05:00:00 - 05:59:59 21598 3.8% 6.0011.3 GB 4.2%3282.16
Sep 18 06:00:00 - 06:59:59 22074 3.9% 6.1311.4 GB 4.3%3330.79
Sep 18 07:00:00 - 07:59:59 22100 3.9% 6.1411.1 GB 4.1%3226.75
Sep 18 08:00:00 - 08:59:59 23984 4.3% 6.6611.4 GB 4.2%3319.70
Sep 18 09:00:00 - 09:59:59 22047 3.9% 6.1210.3 GB 3.8%3011.78
Sep 18 10:00:00 - 10:59:59 23566 4.2% 6.5511.4 GB 4.2%3316.00
Sep 18 11:00:00 - 11:59:59 22988 4.1% 6.3911.1 GB 4.1%3235.29
Sep 18 12:00:00 - 12:59:59 24587 4.4% 6.8311.5 GB 4.3%3341.36
Sep 18 13:00:00 - 13:59:59 22852 4.1% 6.3511.1 GB 4.1%3223.82
Sep 18 14:00:00 - 14:59:59 24040 4.3% 6.6811.4 GB 4.2%3312.01
Sep 18 15:00:00 - 15:59:59 25470 4.5% 7.0812.4 GB 4.6%3601.02
Sep 18 16:00:00 - 16:59:59 22090 3.9% 6.1411.3 GB 4.2%3297.69
Sep 18 17:00:00 - 17:59:59 31695 5.6% 8.8011.5 GB 4.3%3344.94
Sep 18 18:00:00 - 18:59:59 25456 4.5% 7.0710.9 GB 4.1%3172.59
Sep 18 19:00:00 - 19:59:59 23363 4.2% 6.4911.4 GB 4.2%3322.03
Sep 18 20:00:00 - 20:59:59 23186 4.1% 6.4411.9 GB 4.4%3467.87
Sep 18 21:00:00 - 21:59:59 23033 4.1% 6.4011.8 GB 4.4%3436.25
Sep 18 22:00:00 - 22:59:59 19906 3.5% 5.5310.1 GB 3.8%2937.68
Sep 18 23:00:00 - 23:59:59 21152 3.8% 5.8810.5 GB 3.9%3052.26
Sep 19 00:00:00 - 00:59:59 29115 5.2% 8.0911.7 GB 4.4%3420.03
Sep 19 01:00:00 - 01:59:59 22790 4.1% 6.3311.4 GB 4.2%3316.51
Sep 19 02:00:00 - 02:59:59 25980 4.6% 7.2212.0 GB 4.5%3491.23
Sep 19 03:00:00 - 03:59:59 19715 3.5% 5.489.7 GB 3.6%2831.88
Sep 19 04:00:00 - 04:15:02 4852 0.9% 5.382.6 GB 1.0%2984.93
TOTAL: 24:00:00 562405 100.0% 6.51268.7 GB 100.0%3261.45
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 450 80 0 2 0 0 0 0 368
2news.icm.edu.pl 3 0 0 0 0 0 0 0 3
TOTAL: 2 453 80 0 2 0 0 0 0 371

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 60
it.comp.os.win.windows10 7
de.rec.sf.startrek 5
comp.sys.raspberry-pi 4
comp.mobile.ipad 2
alt.comp.software.seamonkey 2
TOTAL: 6 80

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 2
Too many newsgroups 1
TOTAL: 2 3

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 16783 650 8125 177 0 0 3%23:59:57
2panorama 20560 170 7730 136 41 20787 0%23:59:57
3nask 0 0 0 0 0 6343 0%23:57:46
4poznan 2 0 1 0 0 0 0%00:20:05
5okapi 0 0 0 0 0 1102 0%23:57:46
TOTAL: 5 37345 820 15856 313 41 28232 2%96:15:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm6.0 MB39.1 MB45.2 MB0.5 KB/s55.9 KB23:59:57
2panorama529.2 KB810.6 KB1.3 MB0.0 KB/s4.4 KB23:59:57
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:20:05
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 56.6 MB39.9 MB46.5 MB0.1 KB/s42.0 KB96:15:31
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3634.3 KB 17 0 000:00:09
TOTAL: 1 288 3634.3 KB 17 0 000:01:22

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 288 3634.3 KB 17 0 000:00:09
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.icpnet.pl 1 00.0 KB 0 0 000:00:48
4unresolved 104 00.0 KB 0 0 000:00:23
TOTAL: 4 394 3634.3 KB 17 0 000:01:22

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
c136-96.icpnet.pl 0.018 0.006 0.00000:00:48
104.152.52.101 0.003 0.006 0.00000:00:10
192.241.216.102 0.000 0.007 0.00000:00:09
web.man.lodz.pl 0.806 1.732 0.00000:00:09
80.111.142.213 0.011 0.030 0.00000:00:01
212.51.192.185 0.238 0.522 0.00000:00:01
scanner-04.ch1.censys-scanner.com 0.000 0.010 0.00000:00:00
192.241.212.118 0.000 0.012 0.00000:00:00
104.152.52.231 0.000 0.011 0.00000:00:00
TOTAL: 9 1.076 2.336 0.00000:01:22

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
192.241.216.102 1
scanner-04.ch1.censys-scanner.com 1
104.152.52.231 1
192.241.212.118 1
c136-96.icpnet.pl 1
104.152.52.101 1
TOTAL: 8 106

NNRP unrecognized commands (by host):

SystemConn
scanner-04.ch1.censys-scanner.com 1
192.241.212.118 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
MGLNDD_212.191.2.21_119 1
TOTAL: 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 36100.0%
TOTAL: 1 36100.0%

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

NewsgroupCount
1pl.comp.pecet 20
2pl.comp.os.ms-windows.winnt 16
TOTAL: 2 36