Daily Usenet report

Aug 31 04:15:01 -- Sep 1 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Aug 31 07:18:17 newsfeed overchan[893445]: input line too long, skipping
Aug 31 08:02:51 newsfeed overchan[893445]: input line too long, skipping
Aug 31 08:35:44 newsfeed overchan[893445]: input line too long, skipping
Aug 31 08:37:07 newsfeed overchan[893445]: input line too long, skipping
Aug 31 08:37:29 newsfeed overchan[893445]: input line too long, skipping
Aug 31 15:10:40 newsfeed overchan[893445]: input line too long, skipping
Aug 31 15:24:47 newsfeed overchan[893445]: input line too long, skipping
Aug 31 15:36:35 newsfeed overchan[893445]: input line too long, skipping
Aug 31 17:14:50 newsfeed nnrpd[943746]: SERVER perl filter not defined
Aug 31 17:19:56 newsfeed overchan[893445]: input line too long, skipping
Aug 31 19:08:54 newsfeed overchan[893445]: input line too long, skipping
Sep 1 02:04:03 newsfeed pgpverify[967752]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 137582 92.5%15.6 MB 93.2%
nnrpd 7835 5.3%791.3 KB 4.6%
innd 1960 1.3%228.8 KB 1.3%
innfeed 1384 0.9%149.5 KB 0.9%
controlchan 22 0.0%5.3 KB 0.0%
overchan 10 0.0%1.1 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 148794 100.0%16.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 137124 98.0%
Negative hits 2014 1.4%
Positive hits 755 0.5%
Cache misses 29 0.0%
TOTAL: 4 139922 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.632 0.0%54 0.000 11.704 58.000
article cleanup00:00:00.713 0.0%137468 0.000 0.005 0.012
article logging00:00:03.110 0.0%137490 0.010 0.023 0.039
article parse00:00:04.024 0.0%738583 0.003 0.005 0.012
article write00:00:31.378 0.0%137195 0.057 0.229 2.444
artlog/artcncl00:00:00.001 0.0%54 0.000 0.019 0.333
data move00:00:00.876 0.0%1011783 0.000 0.001 0.003
hisgrep/artcncl00:00:00.106 0.0%54 0.000 1.963 13.000
hishave/artcncl00:00:00.095 0.0%54 0.000 1.759 11.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:53.343 0.7%140192 1.975 4.232 36.677
history sync00:00:00.016 0.0%306 0.000 0.052 0.500
history write00:06:33.199 0.5%137442 1.468 2.861 23.989
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:40:22.742 98.6%856164 17.396 99.540 283.364
nntp read00:00:10.225 0.0%731486 0.008 0.014 0.024
overview write00:00:00.390 0.0%137195 0.000 0.003 0.010
perl filter00:02:06.263 0.1%137442 0.674 0.919 1.256
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.729 0.0%286162 0.005 0.013 0.032
TOTAL: 24:00:17.68623:59:50.842100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%11776 0.000 0.003 0.034
article prepare00:00:00.001 0.0%7960 0.000 0.000 0.005
article read00:00:00.054 0.0%1990 0.000 0.027 0.161
backlog stats00:00:00.020 0.0%59063 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.287 0.0%30649 0.000 0.009 0.033
data write00:00:00.731 0.0%18964 0.000 0.039 0.130
idle23:59:45.042100.0%59063 694.418 1462.592 3593.041
status file00:00:00.217 0.0%371 0.000 0.585 26.000
TOTAL: 23:59:47.31923:59:46.382100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:59.876 76.9%4226 0.000 440.103900033.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.159 0.0%10241 0.000 0.016 0.500
readart00:00:00.000 0.0%10 0.000 0.000 0.000
TOTAL: 00:40:17.03600:31:00.035 77.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 92 137293 137155 10 128 99%44:25:06
2news.icm.edu.pl 22 918 33 736 149 3%23:38:19
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 116 138212 137189 746 277 99%68:03:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.8 GB640.6 KB882.3 KB1.8 GB 99%13.6 KB
2news.icm.edu.pl2.0 MB97.3 KB4.5 MB6.6 MB 30%37.1 KB
3localhost1.3 KB0.0 KB0.0 KB1.3 KB100%1.3 KB
TOTAL: 31.8 GB737.9 KB5.4 MB1.8 GB 99%13.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 31 04:15:01 - 04:59:59 3472 2.5% 1.2928.0 MB 1.5% 10.63
Aug 31 05:00:00 - 05:59:59 3182 2.3% 0.8826.0 MB 1.4% 7.41
Aug 31 06:00:00 - 06:59:59 3430 2.5% 0.9536.9 MB 2.0% 10.50
Aug 31 07:00:00 - 07:59:59 4436 3.2% 1.2356.2 MB 3.1% 15.99
Aug 31 08:00:00 - 08:59:59 4349 3.2% 1.2155.4 MB 3.0% 15.77
Aug 31 09:00:00 - 09:59:59 6136 4.5% 1.7090.6 MB 5.0% 25.78
Aug 31 10:00:00 - 10:59:59 6374 4.6% 1.7795.9 MB 5.3% 27.27
Aug 31 11:00:00 - 11:59:59 4306 3.1% 1.2053.9 MB 3.0% 15.34
Aug 31 12:00:00 - 12:59:59 5841 4.3% 1.62116.1 MB 6.4% 33.03
Aug 31 13:00:00 - 13:59:59 7681 5.6% 2.13203.2 MB 11.1% 57.79
Aug 31 14:00:00 - 14:59:59 6116 4.5% 1.7072.9 MB 4.0% 20.72
Aug 31 15:00:00 - 15:59:59 4552 3.3% 1.2645.9 MB 2.5% 13.04
Aug 31 16:00:00 - 16:59:59 4524 3.3% 1.2659.3 MB 3.3% 16.88
Aug 31 17:00:00 - 17:59:59 5797 4.2% 1.6179.7 MB 4.4% 22.67
Aug 31 18:00:00 - 18:59:59 5993 4.4% 1.6693.1 MB 5.1% 26.49
Aug 31 19:00:00 - 19:59:59 5632 4.1% 1.5667.4 MB 3.7% 19.16
Aug 31 20:00:00 - 20:59:59 6874 5.0% 1.9180.5 MB 4.4% 22.90
Aug 31 21:00:00 - 21:59:59 7174 5.2% 1.9977.5 MB 4.3% 22.05
Aug 31 22:00:00 - 22:59:59 7264 5.3% 2.0273.4 MB 4.0% 20.89
Aug 31 23:00:00 - 23:59:59 6582 4.8% 1.8366.0 MB 3.6% 18.78
Sep 1 00:00:00 - 00:59:59 7822 5.7% 2.1783.9 MB 4.6% 23.87
Sep 1 01:00:00 - 01:59:59 7902 5.8% 2.1983.0 MB 4.6% 23.60
Sep 1 02:00:00 - 02:59:59 5215 3.8% 1.4578.0 MB 4.3% 22.18
Sep 1 03:00:00 - 03:59:59 5568 4.1% 1.5585.7 MB 4.7% 24.38
Sep 1 04:00:00 - 04:15:02 1011 0.7% 1.1213.6 MB 0.7% 15.42
TOTAL: 24:00:01 137233 100.0% 1.591.8 GB 100.0% 21.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 150 106 0 20 2 0 0 0 22
2news.icm.edu.pl 145 0 0 6 0 0 0 0 139
TOTAL: 2 295 106 0 26 2 0 0 0 161

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 55
it.tlc.cellulari.android 29
it.comp.os.win.windows10 9
comp.mobile.android 7
comp.sys.raspberry-pi 4
de.comm.software.mailreader 2
TOTAL: 6 106

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

GroupsCount
pl.sci.matematyka 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
Scoring filter (8) 77
Binary in non-binary group 30
Scoring filter (9) 18
EMP (md5) 8
Scoring filter (11) 5
Scoring filter (10) 1
TOTAL: 6 139

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 17058 1868 9664 119 0 11 10%24:05:34
2nask 0 0 0 0 0 7886 0%23:57:45
3okapi 0 0 0 0 0 727 0%23:50:00
4panorama 0 0 0 0 0 11769 0%23:57:45
5poznan 49 0 31 0 0 0 0%04:21:24
TOTAL: 5 17107 1868 9695 119 0 20393 10%100:12:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm5.6 MB293.2 KB5.9 MB0.1 KB/s3.0 KB24:05:34
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:45
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
4panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:45
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s004:21:24
TOTAL: 55.6 MB293.2 KB5.9 MB0.0 KB/s3.0 KB100:12:28
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.6 KB
TOTAL: 1976.6 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 109.7 KB 5 0 000:00:08
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 109.7 KB 5 1 000:40:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1729 109.7 KB 5 1 000:00:27
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.census.shodan.io 1 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5unresolved 149 00.0 KB 0 0 000:39:47
TOTAL: 51881 109.7 KB 5 1 000:40:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
202.107.226.5 0.002 0.002 0.00000:30:00
109.74.204.123 0.212 0.209 0.00000:09:33
nms2.man.lodz.pl 3.635 6.362 0.00000:00:18
192.3.255.113 0.006 0.000 0.00000:00:10
web.man.lodz.pl 0.763 1.398 0.00000:00:08
80.111.142.213 0.007 0.029 0.00000:00:02
stunning.monitoring.internet-measurement.com 0.000 0.006 0.00000:00:01
212.51.192.185 0.249 0.441 0.00000:00:01
scanner-29.ch1.censys-scanner.com 0.005 0.005 0.00000:00:00
192.241.231.7 0.000 0.011 0.00000:00:00
hat.census.shodan.io 0.000 0.005 0.00000:00:00
80.66.88.211 0.000 0.006 0.00000:00:00
isvcs01.man.lodz.pl 0.006 0.006 0.00000:00:00
TOTAL: 13 4.885 8.480 0.00000:40:17

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
109.74.204.123 45
80.111.142.213 4
202.107.226.5 1
hat.census.shodan.io 1
stunning.monitoring.internet-measurement.com 1
192.3.255.113 1
scanner-29.ch1.censys-scanner.com 1
192.241.231.7 1
80.66.88.211 1
TOTAL: 11 1592

NNRP unrecognized commands (by host):

SystemConn
202.107.226.5 1
80.66.88.211 1
scanner-29.ch1.censys-scanner.com 1
192.241.231.7 1
TOTAL: 4 4

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
MGLNDD_212.191.2.21_119 1
GET / HTTP/1.0 1
#003 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
202.107.226.5 1 0
80.66.88.211 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 10100.0%
TOTAL: 1 10100.0%

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

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