Daily Usenet report

Apr 7 04:15:02 -- Apr 8 04:15:04

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Apr 7 04:43:54 newsfeed overchan[28617]: input line too long, skipping
Apr 7 08:27:50 newsfeed nnrpd[31387]: SERVER perl filter not defined
Apr 7 11:33:03 newsfeed overchan[28617]: input line too long, skipping
Apr 7 13:10:44 newsfeed nnrpd[4884]: SERVER perl filter not defined
Apr 7 17:38:38 newsfeed overchan[28617]: input line too long, skipping
Apr 7 20:25:16 newsfeed overchan[28617]: input line too long, skipping
Apr 7 20:34:27 newsfeed overchan[28617]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 567445 90.0%71.1 MB 90.2%
innfeed 48839 7.7%5.8 MB 7.3%
innd 9000 1.4%1.4 MB 1.8%
nnrpd 5141 0.8%548.5 KB 0.7%
overchan 6 0.0%1.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 630432 100.0%78.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 560074 97.6%
Negative hits 13622 2.4%
Positive hits 290 0.1%
Cache misses 34 0.0%
TOTAL: 4 574020 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.151 0.0%139 0.000 37.058 3124.000
article cleanup00:00:07.083 0.0%561845 0.007 0.013 0.019
article logging00:00:26.478 0.0%562483 0.035 0.047 0.071
article parse00:08:30.729 0.6%16139929 0.017 0.032 0.040
article write00:04:09.484 0.3%561611 0.124 0.444 2.339
artlog/artcncl00:00:00.003 0.0%138 0.000 0.022 0.250
data move00:00:20.336 0.0%18855548 0.001 0.001 0.003
hisgrep/artcncl00:00:01.640 0.0%135 0.000 12.148 1182.000
hishave/artcncl00:00:00.267 0.0%139 0.000 1.921 25.571
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:15:06.946 9.4%575675 0.150 14.083 50.022
history sync00:00:00.024 0.0%313 0.000 0.077 0.500
history write02:54:21.820 12.2%561803 7.520 18.622 64.977
hiswrite/artcncl00:00:00.031 0.0%4 0.000 7.750 17.000
idle17:12:30.906 72.2%14385426 0.925 4.307 83.019
nntp read00:13:21.343 0.9%15862812 0.034 0.051 0.058
overview write00:00:03.130 0.0%561611 0.002 0.006 0.012
perl filter00:56:29.941 3.9%561803 1.904 6.034 10.641
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:32.773 0.0%1141140 0.022 0.029 0.039
TOTAL: 23:50:53.91023:46:08.085 99.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.183 0.0%59485 0.000 0.003 0.013
article prepare00:00:00.002 0.0%6352 0.000 0.000 0.015
article read00:01:18.874 0.1%1583 0.000 49.826 468.333
backlog stats00:00:00.115 0.0%129598 0.000 0.001 0.005
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:01.375 0.0%66143 0.008 0.021 0.043
data write00:00:03.353 0.0%48305 0.014 0.069 0.118
idle23:52:15.514 99.9%129598 454.046 663.093 1237.525
status file00:00:20.688 0.0%16663 0.583 1.242 25.181
TOTAL: 23:54:06.96123:54:00.104100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:40:42.671 99.1%3271 0.000 746.766 54584.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.667 0.0%7264 0.000 0.092 2.112
readart00:00:00.661 0.0%56 0.000 11.804 657.000
TOTAL: 00:41:05.93900:40:43.999 99.1%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 192

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 220 566664 566465 1 198 99%111:38:19
2news.icm.edu.pl 44 229 44 149 36 19%14:41:18
3localhost 1443 2 2 0 0 100%00:00:39
TOTAL: 3 1707 566895 566511 150 234 99%126:20:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl121.6 GB905.3 KB1.3 MB121.6 GB 99%225.1 KB
2news.icm.edu.pl1.2 MB181.1 KB856.0 KB2.2 MB 54%28.8 KB
3localhost3.3 KB0.0 KB0.0 KB3.3 KB100%1.6 KB
TOTAL: 3121.6 GB1.1 MB2.2 MB121.6 GB 99%225.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 7 04:15:02 - 04:59:59 7159 1.3% 2.65360.5 MB 0.3% 136.83
Apr 7 05:00:00 - 05:59:59 7938 1.4% 2.21327.4 MB 0.3% 93.14
Apr 7 06:00:00 - 06:59:59 14128 2.5% 3.92530.3 MB 0.4% 150.85
Apr 7 07:00:00 - 07:59:59 27536 4.9% 7.651.4 GB 1.2% 411.79
Apr 7 08:00:00 - 08:59:59 21021 3.7% 5.84977.0 MB 0.8% 277.92
Apr 7 09:00:00 - 09:59:59 27415 4.8% 7.623.4 GB 2.8% 996.65
Apr 7 10:00:00 - 10:59:59 38542 6.8% 10.7111.2 GB 9.2%3256.86
Apr 7 11:00:00 - 11:59:59 23336 4.1% 6.484.2 GB 3.4%1219.14
Apr 7 12:00:00 - 12:59:59 29696 5.2% 8.259.6 GB 7.9%2810.61
Apr 7 13:00:00 - 13:59:59 23565 4.2% 6.558.1 GB 6.6%2347.80
Apr 7 14:00:00 - 14:59:59 25406 4.5% 7.065.7 GB 4.7%1671.18
Apr 7 15:00:00 - 15:59:59 28495 5.0% 7.929.8 GB 8.1%2859.06
Apr 7 16:00:00 - 16:59:59 13520 2.4% 3.762.5 GB 2.1% 730.41
Apr 7 17:00:00 - 17:59:59 15224 2.7% 4.23718.0 MB 0.6% 204.23
Apr 7 18:00:00 - 18:59:59 17101 3.0% 4.75867.0 MB 0.7% 246.63
Apr 7 19:00:00 - 19:59:59 27088 4.8% 7.522.9 GB 2.4% 833.96
Apr 7 20:00:00 - 20:59:59 22023 3.9% 6.128.7 GB 7.2%2545.97
Apr 7 21:00:00 - 21:59:59 29287 5.2% 8.149.7 GB 8.0%2826.35
Apr 7 22:00:00 - 22:59:59 42644 7.5% 11.8512.6 GB 10.3%3667.28
Apr 7 23:00:00 - 23:59:59 28138 5.0% 7.826.9 GB 5.7%2013.13
Apr 8 00:00:00 - 00:59:59 35728 6.3% 9.925.0 GB 4.1%1450.48
Apr 8 01:00:00 - 01:59:59 17739 3.1% 4.933.6 GB 2.9%1044.47
Apr 8 02:00:00 - 02:59:59 21773 3.8% 6.054.7 GB 3.9%1374.89
Apr 8 03:00:00 - 03:59:59 14006 2.5% 3.894.2 GB 3.4%1217.82
Apr 8 04:00:00 - 04:15:04 7924 1.4% 8.773.9 GB 3.2%4470.36
TOTAL: 24:00:02 566432 100.0% 6.56121.8 GB 100.0%1478.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 838 161 0 34 0 0 0 0 643
2news.icm.edu.pl 36 0 0 8 0 0 0 0 28
TOTAL: 2 874 161 0 42 0 0 0 0 671

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 104
it.comp.os.win.windows10 34
it.tlc.cellulari.android 7
comp.sys.raspberry-pi 6
nl.comp.os.linux.techniek 4
comp.mobile.android 3
de.rec.sf.startrek 2
it.comp.os.win.windows7 1
TOTAL: 8 161

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 26
Binary in non-binary group 3
Scoring filter (8) 2
TOTAL: 3 31

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 44393 554 16081 224 4 42720 1%24:00:00
2icm 23566 175 17653 12 0 0 0%24:00:00
3poznan 32 1 25 0 0 0 3%02:51:42
4nask 0 0 0 0 0 11836 0%23:57:52
5okapi 0 0 0 0 0 1219 0%23:57:53
TOTAL: 5 67991 730 33759 236 4 55775 1%98:47:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.7 MB584.8 KB2.3 MB0.0 KB/s12.3 KB24:00:00
2panorama1.6 MB982.1 KB2.6 MB0.0 KB/s3.4 KB24:00:00
3poznan20.6 KB0.0 KB20.6 KB0.0 KB/s20.6 KB02:51:42
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:53
TOTAL: 53.3 MB1.5 MB4.9 MB0.0 KB/s5.1 KB98:47:27
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4653.2 KB 21 0 000:00:18
2pc-tom.man.lodz.pl 10 68.6 KB 3 0 000:03:22
3apn-46-76-13-71.dynamic.gprs.plus.pl 4 23.3 KB 2 0 000:28:44
4user-5-173-188-181.play-internet.pl 2 22.8 KB 1 0 000:08:23
5isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 5 306 5667.9 KB 27 2 000:41:05

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 588 5261.8 KB 24 2 000:03:43
2*.dynamic.gprs.plus.pl 4 23.3 KB 2 0 000:28:44
3*.play-internet.pl 2 22.8 KB 1 0 000:08:23
4*.sfj.corp.censys.io 1 00.0 KB 0 0 000:00:00
5unresolved 102 00.0 KB 0 0 000:00:13
6*.security.ipip.net 2 00.0 KB 0 0 000:00:00
TOTAL: 6 699 5667.9 KB 27 2 000:41:05

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
apn-46-76-13-71.dynamic.gprs.plus.pl 0.032 0.064 0.00000:28:44
user-5-173-188-181.play-internet.pl 0.016 0.020 0.00000:08:23
pc-tom.man.lodz.pl 0.380 0.384 0.00000:03:22
web.man.lodz.pl 1.604 2.320 0.00000:00:18
192.241.238.229 0.008 0.020 0.00000:00:09
mon.man.lodz.pl 1.376 2.000 0.00000:00:02
80.111.142.213 0.016 0.048 0.00000:00:02
212.51.192.185 0.456 0.688 0.00000:00:00
scan-141.security.ipip.net 0.008 0.036 0.00000:00:00
45.13.93.82 0.000 0.004 0.00000:00:00
worker-18.sfj.corp.censys.io 0.004 0.008 0.00000:00:00
isvcs01.man.lodz.pl 0.032 0.024 0.00000:00:00
TOTAL: 12 3.932 5.616 0.00000:41:05

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
scan-141.security.ipip.net 2
45.13.93.82 1
worker-18.sfj.corp.censys.io 1
192.241.238.229 1
TOTAL: 7 393

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 8
45.13.93.82 3
TOTAL: 2 11

NNRP unrecognized commands (by command):

CommandCount
Connection: close 2
Host: 212.191.2.21:119 2
User-Agent: HTTP Banner Detection (https... 2
GET / HTTP/1.1 2
Host: ip.ws.126.net:443 1
CONNECT ip.ws.126.net:443 HTTP/1.1 1
User-Agent: Go-http-client/1.1 1
TOTAL: 7 11

NNRP client timeouts [Top 20]:

SystemConnPeer
worker-18.sfj.corp.censys.io 1 1
scan-141.security.ipip.net 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 46 82.1%
2lodman 10 17.9%
TOTAL: 2 56100.0%

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

NewsgroupCount
1pl.comp.pecet 26
2pl.comp.os.ms-windows.winnt 20
3lodman.info 10
TOTAL: 3 56