Daily Usenet report

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

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 18 04:21:03 newsfeed nnrpd[151134]: nms1.man.lodz.pl rejected Expiring process 150984
Sep 18 15:18:14 newsfeed nnrpd[7601]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 374180 96.8%44.5 MB 97.1%
nnrpd 7737 2.0%807.2 KB 1.7%
innd 3254 0.8%404.2 KB 0.9%
innfeed 1327 0.3%141.0 KB 0.3%
controlchan 2 0.0%0.1 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 386501 100.0%45.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 368529 85.7%
Negative hits 50946 11.8%
Cache misses 10697 2.5%
Positive hits 91 0.0%
TOTAL: 4 430263 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.894 0.0%81 0.000 23.383 44.667
article cleanup00:00:01.917 0.0%371504 0.001 0.005 0.011
article logging00:00:06.864 0.0%371581 0.010 0.018 0.068
article parse00:00:09.588 0.0%1267425 0.004 0.008 0.011
article write00:00:23.649 0.0%369446 0.034 0.064 0.411
artlog/artcncl00:00:00.001 0.0%75 0.000 0.013 1.000
data move00:00:03.638 0.0%1654304 0.000 0.002 0.004
hisgrep/artcncl00:00:00.616 0.0%78 0.000 7.897 18.700
hishave/artcncl00:00:00.462 0.0%81 0.000 5.704 14.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:47:31.316 3.3%431455 3.225 6.609 18.171
history sync00:00:00.015 0.0%342 0.000 0.044 0.500
history write00:48:57.751 3.4%369537 5.344 7.950 18.877
hiswrite/artcncl00:00:00.024 0.0%3 8.000 8.000 8.000
idle22:07:19.200 92.8%1260632 20.975 63.174 315.736
nntp read00:00:15.640 0.0%1123059 0.008 0.014 0.022
overview write00:00:00.853 0.0%369446 0.000 0.002 0.005
perl filter00:04:47.565 0.3%369537 0.567 0.778 1.192
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:11.715 0.0%936498 0.007 0.013 0.020
TOTAL: 23:50:37.71223:49:52.708 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.285 0.0%196092 0.000 0.001 0.013
article prepare00:00:00.000 0.0%92 0.000 0.000 0.000
article read00:00:00.001 0.0%23 0.000 0.043 1.000
backlog stats00:00:00.082 0.0%216812 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.650 0.0%203567 0.000 0.008 0.034
data write00:00:00.302 0.0%7738 0.000 0.039 0.235
idle23:44:02.593100.0%216812 179.535 394.086 3134.672
status file00:00:00.324 0.0%361 0.000 0.898 18.000
TOTAL: 23:44:09.68823:44:05.237100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:57.112 47.2%4220 0.000 13.534 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.144 0.1%10345 0.000 0.014 0.500
readart00:00:00.000 0.0%16 0.000 0.000 0.000
TOTAL: 00:02:01.09400:00:57.256 47.3%----

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 101 382592 371849 8685 2058 97%44:32:17
2news.icm.edu.pl 29 61 2 58 1 3%07:01:18
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 132 382654 371852 8743 2059 97%51:33:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.7 GB20.2 MB20.5 MB3.8 GB 98%10.5 KB
2news.icm.edu.pl21.2 KB8.1 KB8.1 KB37.4 KB 56%12.5 KB
3localhost1.5 KB0.0 KB0.0 KB1.5 KB100%1.5 KB
TOTAL: 33.7 GB20.2 MB20.5 MB3.8 GB 98%10.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 18 04:15:01 - 04:59:59 7666 2.1% 2.8478.3 MB 2.1% 29.70
Sep 18 05:00:00 - 05:59:59 12141 3.3% 3.37121.9 MB 3.2% 34.67
Sep 18 06:00:00 - 06:59:59 5899 1.6% 1.6463.3 MB 1.7% 18.02
Sep 18 07:00:00 - 07:59:59 4143 1.1% 1.1543.7 MB 1.1% 12.43
Sep 18 08:00:00 - 08:59:59 6707 1.8% 1.8696.1 MB 2.5% 27.34
Sep 18 09:00:00 - 09:59:59 5408 1.5% 1.5065.6 MB 1.7% 18.65
Sep 18 10:00:00 - 10:59:59 4113 1.1% 1.1447.9 MB 1.3% 13.61
Sep 18 11:00:00 - 11:59:59 10969 2.9% 3.05116.6 MB 3.1% 33.18
Sep 18 12:00:00 - 12:59:59 14588 3.9% 4.05167.9 MB 4.4% 47.75
Sep 18 13:00:00 - 13:59:59 14555 3.9% 4.04156.9 MB 4.1% 44.64
Sep 18 14:00:00 - 14:59:59 15654 4.2% 4.35160.3 MB 4.2% 45.61
Sep 18 15:00:00 - 15:59:59 13820 3.7% 3.84122.5 MB 3.2% 34.85
Sep 18 16:00:00 - 16:59:59 19008 5.1% 5.28166.9 MB 4.4% 47.48
Sep 18 17:00:00 - 17:59:59 16843 4.5% 4.68165.0 MB 4.3% 46.93
Sep 18 18:00:00 - 18:59:59 18889 5.1% 5.25185.7 MB 4.9% 52.83
Sep 18 19:00:00 - 19:59:59 21825 5.9% 6.06206.6 MB 5.4% 58.75
Sep 18 20:00:00 - 20:59:59 22091 5.9% 6.14219.9 MB 5.8% 62.56
Sep 18 21:00:00 - 21:59:59 19621 5.3% 5.45186.6 MB 4.9% 53.07
Sep 18 22:00:00 - 22:59:59 23340 6.3% 6.48217.6 MB 5.7% 61.90
Sep 18 23:00:00 - 23:59:59 21492 5.8% 5.97227.0 MB 6.0% 64.56
Sep 19 00:00:00 - 00:59:59 21405 5.8% 5.95197.4 MB 5.2% 56.15
Sep 19 01:00:00 - 01:59:59 22384 6.0% 6.22246.9 MB 6.5% 70.22
Sep 19 02:00:00 - 02:59:59 20265 5.4% 5.63218.6 MB 5.7% 62.19
Sep 19 03:00:00 - 03:59:59 23067 6.2% 6.41266.2 MB 7.0% 75.71
Sep 19 04:00:00 - 04:15:02 6076 1.6% 6.7462.5 MB 1.6% 70.98
TOTAL: 24:00:01 371969 100.0% 4.313.7 GB 100.0% 45.13
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 2135 77 0 1967 14 0 0 0 77
2news.icm.edu.pl 1 0 0 1 0 0 0 0 0
TOTAL: 2 2136 77 0 1968 14 0 0 0 77

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.sys.raspberry-pi 13
it.tlc.cellulari.android 11
uk.railway 11
it.comp.os.win.windows10 10
comp.mobile.android 10
grisbi.bugsreports 5
fido7.english-tutor 5
alt.comp.software.firefox 2
fr.usenet.documents 2
uk.radio.amateur.moderated 2
comp.sys.mac.vintage 2
grisbi.test 1
alt.comp.software.seamonkey 1
comp.infosystems.gemini 1
eternal-september.test 1
TOTAL: 15 77

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

GroupsCount
christnet.bible 14
TOTAL: 1 14

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 7529 18 6659 5 0 0 0%23:52:17
2nask 0 0 0 0 0 194355 0%23:47:47
3okapi 0 0 0 0 0 671 0%23:47:47
4panorama 0 0 0 0 0 197088 0%23:47:47
5poznan 1 0 1 0 0 0 0%00:30:00
TOTAL: 5 7530 18 6660 5 0 392114 0%95:45:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm52.1 KB24.8 KB76.9 KB0.0 KB/s3.3 KB23:52:17
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:47
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:47
4panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:47
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:30:00
TOTAL: 552.1 KB24.8 KB76.9 KB0.0 KB/s3.3 KB95:45:38
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama17.2 MB
TOTAL: 117.2 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 1623.8 KB 8 0 000:00:08
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 290 1623.8 KB 8 1 000:02:01

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1729 1623.8 KB 8 1 000:00:21
2*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
5unresolved 117 00.0 KB 0 0 000:01:35
TOTAL: 51849 1623.8 KB 8 1 000:02:01

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
206.168.34.49 0.028 0.014 0.00000:00:47
69.10.48.174 0.006 0.008 0.00000:00:13
nms1.man.lodz.pl 4.004 5.904 0.00000:00:12
104.152.52.182 0.006 0.000 0.00000:00:10
198.235.24.109 0.004 0.000 0.00000:00:10
web.man.lodz.pl 0.898 1.191 0.00000:00:08
167.94.138.63 0.011 0.014 0.00000:00:06
167.94.146.48 0.019 0.007 0.00000:00:03
server-0-2.survey.inspici.com 0.000 0.012 0.00000:00:03
80.111.142.213 0.013 0.020 0.00000:00:02
212.51.192.185 0.238 0.479 0.00000:00:00
241.150.216.162.bc.googleusercontent.com 0.000 0.005 0.00000:00:00
104.152.52.199 0.000 0.005 0.00000:00:00
azpdeg20.stretchoid.com 0.006 0.006 0.00000:00:00
45.227.254.19 0.005 0.000 0.00000:00:00
92.118.39.205 0.006 0.006 0.00000:00:00
isvcs01.man.lodz.pl 0.000 0.007 0.00000:00:00
TOTAL: 17 5.244 7.678 0.00000:02:01

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1439
212.51.192.185 95
206.168.34.49 5
80.111.142.213 4
167.94.138.63 3
167.94.146.48 3
69.10.48.174 2
server-0-2.survey.inspici.com 1
241.150.216.162.bc.googleusercontent.com 1
45.227.254.19 1
198.235.24.109 1
104.152.52.182 1
azpdeg20.stretchoid.com 1
104.152.52.199 1
92.118.39.205 1
TOTAL: 15 1559

NNRP unrecognized commands (by host):

SystemConn
241.150.216.162.bc.googleusercontent.com 4
206.168.34.49 2
azpdeg20.stretchoid.com 1
167.94.146.48 1
167.94.138.63 1
TOTAL: 5 9

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 2
GET / HTTP/1.1 2
#026#003#001 1
MGLNDD_212.191.2.21_119 1
Accept-Encoding: gzip 1
Host: 212.191.2.21:119 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 7 9

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.49 1 1
167.94.138.63 1 2
167.94.146.48 1 2
TOTAL: 3 3 5

Newsgroup request counts (by category):

CategoryCountPct
1pl 16100.0%
TOTAL: 1 16100.0%

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

NewsgroupCount
1pl.comp.pecet 16
TOTAL: 1 16