Daily Usenet report

May 13 04:15:02 -- May 14 04:15:01

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

May 13 04:16:54 newsfeed overchan[13632]: input line too long, skipping
May 13 07:41:35 newsfeed overchan[13632]: input line too long, skipping
May 13 12:30:05 newsfeed overchan[13632]: input line too long, skipping
May 13 12:30:59 newsfeed overchan[13632]: input line too long, skipping
May 13 12:52:10 newsfeed nnrpd[29950]: SERVER perl filter not defined
May 13 17:11:31 newsfeed overchan[13632]: input line too long, skipping
May 13 19:44:59 newsfeed overchan[13632]: input line too long, skipping
May 13 20:16:08 newsfeed overchan[13632]: input line too long, skipping
May 13 22:37:23 newsfeed overchan[13632]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 672659 91.4%73.0 MB 90.4%
innfeed 49912 6.8%5.9 MB 7.3%
innd 8802 1.2%1.4 MB 1.7%
nnrpd 4218 0.6%425.6 KB 0.5%
overchan 10 0.0%1.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 735602 100.0%80.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 668290 99.6%
Negative hits 2811 0.4%
Positive hits 155 0.0%
Cache misses 30 0.0%
TOTAL: 4 671286 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.240 0.0%47 0.000 26.383 192.000
article cleanup00:00:10.400 0.0%672721 0.010 0.015 0.022
article logging00:00:36.293 0.0%673144 0.045 0.054 0.082
article parse00:23:05.441 1.6%48693242 0.015 0.028 0.040
article write00:08:54.537 0.6%672511 0.555 0.795 5.292
artlog/artcncl00:00:00.001 0.0%47 0.000 0.021 0.100
data move00:00:45.646 0.1%53192971 0.001 0.001 0.001
hisgrep/artcncl00:00:00.422 0.0%44 0.000 9.591 164.000
hishave/artcncl00:00:00.003 0.0%47 0.000 0.064 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:20.434 0.4%675668 0.087 0.474 13.860
history sync00:00:00.023 0.0%292 0.000 0.079 0.500
history write00:55:50.922 3.9%672711 0.611 4.981 51.273
hiswrite/artcncl00:00:00.035 0.0%3 0.000 11.667 18.000
idle20:19:44.851 84.7%48407065 1.116 1.512 3.023
nntp read00:37:36.621 2.6%48381283 0.027 0.047 0.066
overview write00:00:04.030 0.0%672511 0.003 0.006 0.010
perl filter01:12:10.379 5.0%672711 4.788 6.437 8.022
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:42.609 0.0%1358069 0.024 0.031 0.039
TOTAL: 24:00:06.24623:45:03.887 99.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.178 0.0%51315 0.000 0.003 0.014
article prepare00:00:00.001 0.0%5924 0.000 0.000 0.025
article read00:00:24.906 0.0%1479 0.000 16.840 1281.375
backlog stats00:00:00.092 0.0%116295 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.189 0.0%56330 0.000 0.021 0.041
data write00:00:02.698 0.0%43369 0.016 0.062 0.103
idle23:49:37.291 99.6%116295 444.834 737.584 1336.253
status file00:04:48.144 0.3%16927 0.692 17.023 1260.085
TOTAL: 23:55:01.60723:54:54.499100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle32:39:49.378100.0%6287 0.000 18703.575600088.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.582 0.0%13176 0.000 0.044 0.500
readart00:00:00.000 0.0%8 0.000 0.000 0.000
TOTAL: 32:40:04.19132:39:49.960100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 72 671916 671725 1 190 99%57:28:22
2news.icm.edu.pl 50 181 29 131 21 16%14:06:22
3localhost 1440 1 1 0 0 100%00:00:00
TOTAL: 3 1562 672098 671755 132 211 99%71:34:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl263.1 GB442.9 KB957.7 KB263.1 GB 99%410.5 KB
2news.icm.edu.pl601.4 KB11.0 KB268.6 KB881.0 KB 68%17.6 KB
3localhost1.3 KB0.0 KB0.0 KB1.3 KB100%1.3 KB
TOTAL: 3263.1 GB453.9 KB1.2 MB263.1 GB 99%410.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 13 04:15:02 - 04:59:59 20021 3.0% 7.429.0 GB 3.4%3499.80
May 13 05:00:00 - 05:59:59 27895 4.2% 7.7511.4 GB 4.3%3326.72
May 13 06:00:00 - 06:59:59 25409 3.8% 7.0612.1 GB 4.6%3513.60
May 13 07:00:00 - 07:59:59 22264 3.3% 6.1810.7 GB 4.1%3130.51
May 13 08:00:00 - 08:59:59 21797 3.2% 6.059.9 GB 3.7%2874.81
May 13 09:00:00 - 09:59:59 22598 3.4% 6.2810.2 GB 3.9%2973.98
May 13 10:00:00 - 10:59:59 25193 3.7% 7.0010.9 GB 4.1%3161.00
May 13 11:00:00 - 11:59:59 29650 4.4% 8.2410.9 GB 4.1%3187.21
May 13 12:00:00 - 12:59:59 26324 3.9% 7.3111.4 GB 4.3%3313.01
May 13 13:00:00 - 13:59:59 25116 3.7% 6.9810.6 GB 4.0%3081.68
May 13 14:00:00 - 14:59:59 28385 4.2% 7.8811.4 GB 4.3%3327.30
May 13 15:00:00 - 15:59:59 25543 3.8% 7.1011.0 GB 4.2%3200.26
May 13 16:00:00 - 16:59:59 30040 4.5% 8.3410.7 GB 4.1%3115.00
May 13 17:00:00 - 17:59:59 31288 4.7% 8.6910.8 GB 4.1%3144.37
May 13 18:00:00 - 18:59:59 25533 3.8% 7.0910.1 GB 3.8%2931.43
May 13 19:00:00 - 19:59:59 32202 4.8% 8.9511.2 GB 4.2%3250.93
May 13 20:00:00 - 20:59:59 31728 4.7% 8.8111.5 GB 4.4%3358.86
May 13 21:00:00 - 21:59:59 31828 4.7% 8.8411.1 GB 4.2%3233.25
May 13 22:00:00 - 22:59:59 32463 4.8% 9.0211.2 GB 4.3%3271.54
May 13 23:00:00 - 23:59:59 26696 4.0% 7.4210.6 GB 4.0%3082.68
May 14 00:00:00 - 00:59:59 33531 5.0% 9.3112.1 GB 4.6%3523.27
May 14 01:00:00 - 01:59:59 33661 5.0% 9.3511.2 GB 4.2%3266.76
May 14 02:00:00 - 02:59:59 30293 4.5% 8.4110.2 GB 3.9%2971.80
May 14 03:00:00 - 03:59:59 25848 3.8% 7.1810.9 GB 4.1%3183.02
May 14 04:00:00 - 04:15:01 6672 1.0% 7.412.8 GB 1.1%3282.66
TOTAL: 23:59:59 671978 100.0% 7.78263.9 GB 100.0%3202.85
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 613 176 0 10 4 0 0 0 423
2news.icm.edu.pl 21 0 0 1 0 0 0 0 20
TOTAL: 2 634 176 0 11 4 0 0 0 443

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 96
comp.mobile.android 45
alt.comp.software.seamonkey 13
it.comp.os.win.windows10 7
alt.comp.software.firefox 5
it.tlc.cellulari.android 5
comp.sys.raspberry-pi 3
it.comp.os.linux.ubuntu 2
TOTAL: 8 176

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 19
Binary in non-binary group 1
TOTAL: 2 20

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 20413 816 11890 38 0 1 3%23:59:54
2panorama 39932 179 11620 87 0 39590 0%24:00:03
3okapi 0 0 0 0 0 633 0%24:05:12
4nask 0 0 0 0 0 8720 0%23:57:26
5poznan 30 0 28 0 0 0 0%02:09:03
TOTAL: 5 60375 995 23538 125 0 48944 1%98:11:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.4 MB129.8 KB2.5 MB0.0 KB/s3.0 KB23:59:54
2panorama589.9 KB355.1 KB945.0 KB0.0 KB/s3.6 KB24:00:03
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:12
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:26
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:09:03
TOTAL: 53.0 MB484.9 KB3.4 MB0.0 KB/s3.1 KB98:11:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 813.4 KB 4 0 000:00:24
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 813.4 KB 4 1 032:40:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 577 813.4 KB 4 1 000:00:28
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.208-100-26.static.steadfastdns.net 2 00.0 KB 0 0 000:00:01
5unresolved 108 00.0 KB 0 0 032:39:32
TOTAL: 5 689 813.4 KB 4 1 032:40:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
46.22.161.234 0.192 0.483 0.00031:39:18
213.195.159.35 0.025 0.020 0.00001:00:00
web.man.lodz.pl 2.009 3.956 0.00000:00:24
192.241.215.63 0.008 0.008 0.00000:00:09
mon.man.lodz.pl 1.656 2.717 0.00000:00:03
80.111.142.213 0.035 0.041 0.00000:00:02
ip230.208-100-26.static.steadfastdns.net 0.007 0.027 0.00000:00:01
212.51.192.185 0.507 0.987 0.00000:00:01
scan-141.security.ipip.net 0.004 0.016 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.004 0.013 0.00000:00:00
isvcs01.man.lodz.pl 0.019 0.014 0.00000:00:00
185.143.221.117 0.006 0.006 0.00000:00:00
TOTAL: 12 4.472 8.288 0.00032:40:03

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
46.22.161.234 4
ip230.208-100-26.static.steadfastdns.net 2
213.195.159.35 2
scanner-21.ch1.censys-scanner.com 1
185.143.221.117 1
scan-141.security.ipip.net 1
192.241.215.63 1
TOTAL: 10 400

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
185.143.221.117 1
TOTAL: 2 5

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 1
#003 1
User-Agent: HTTP Banner Detection (https... 1
GET / HTTP/1.1 1
Connection: close 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
46.22.161.234 4 4
213.195.159.35 2 0
scanner-21.ch1.censys-scanner.com 1 1
185.143.221.117 1 1
TOTAL: 4 8 6

Newsgroup request counts (by category):

CategoryCountPct
1pl 8100.0%
TOTAL: 1 8100.0%

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

NewsgroupCount
1pl.comp.pecet 4
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 8