Daily Usenet report

Jul 12 04:15:01 -- Jul 13 04:15:01

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Jul 12 18:42:52 newsfeed nnrpd[84068]: SERVER perl filter not defined
Jul 12 18:45:24 newsfeed nnrpd[84326]: SERVER perl filter not defined
Jul 12 19:05:57 newsfeed nnrpd[85211]: SERVER perl filter not defined
Jul 12 19:07:00 newsfeed nnrpd[85221]: SERVER perl filter not defined
Jul 12 20:01:45 newsfeed nnrpd[87543]: SERVER perl filter not defined
Jul 12 20:02:36 newsfeed nnrpd[87549]: SERVER perl filter not defined
Jul 12 20:10:40 newsfeed nnrpd[87967]: SERVER perl filter not defined
Jul 12 22:11:06 newsfeed nnrpd[93194]: SERVER perl filter not defined
Jul 12 22:12:51 newsfeed nnrpd[93218]: SERVER perl filter not defined
Jul 12 22:32:07 newsfeed nnrpd[94071]: SERVER perl filter not defined
Jul 12 22:43:44 newsfeed nnrpd[94659]: SERVER perl filter not defined
Jul 13 00:34:32 newsfeed nnrpd[99653]: SERVER perl filter not defined
Jul 13 01:45:59 newsfeed nnrpd[102813]: SERVER perl filter not defined
Jul 13 02:09:01 newsfeed nnrpd[103730]: SERVER perl filter not defined
Jul 13 02:09:25 newsfeed nnrpd[103733]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 175701 93.9%20.1 MB 94.6%
nnrpd 7763 4.1%777.4 KB 3.6%
innd 2359 1.3%272.4 KB 1.3%
innfeed 1278 0.7%124.8 KB 0.6%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 187103 100.0%21.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 174494 99.2%
Negative hits 1328 0.8%
Positive hits 100 0.1%
Cache misses 13 0.0%
TOTAL: 4 175935 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.586 0.0%32 0.000 18.312 52.000
article cleanup00:00:00.969 0.0%175784 0.000 0.006 0.015
article logging00:00:03.585 0.0%175896 0.010 0.020 0.035
article parse00:00:05.146 0.0%591238 0.005 0.009 0.013
article write00:00:16.491 0.0%175629 0.037 0.094 0.525
artlog/artcncl00:00:00.000 0.0%31 0.000 0.000 0.000
data move00:00:00.620 0.0%771074 0.000 0.001 0.002
hisgrep/artcncl00:00:00.244 0.0%32 0.000 7.625 32.500
hishave/artcncl00:00:00.129 0.0%32 0.000 4.031 14.429
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:28:28.433 2.0%177187 6.489 9.642 20.815
history sync00:00:00.013 0.0%368 0.000 0.035 0.667
history write00:28:12.691 2.0%175775 6.609 9.630 21.109
idle23:00:20.290 95.8%589018 30.429 140.607 385.860
nntp read00:00:08.406 0.0%515510 0.010 0.016 0.025
overview write00:00:00.457 0.0%175629 0.000 0.003 0.008
perl filter00:02:41.083 0.2%175775 0.609 0.916 1.369
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:05.399 0.0%391063 0.005 0.014 0.021
TOTAL: 24:00:51.26224:00:24.542100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.068 0.0%39791 0.000 0.002 0.014
article prepare00:00:00.000 0.0%32 0.000 0.000 0.000
article read00:00:00.002 0.0%8 0.000 0.250 1.000
backlog stats00:00:00.029 0.0%60691 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.451 0.0%47362 0.000 0.010 0.036
data write00:00:00.325 0.0%7743 0.000 0.042 0.235
idle23:59:05.126100.0%60691 442.462 1422.701 4208.853
status file00:00:00.320 0.0%331 0.000 0.967 17.000
TOTAL: 23:59:07.34123:59:06.321100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:07:36.366 99.6%4305 0.000 942.245144428.071
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.163 0.0%10300 0.000 0.016 0.500
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 01:07:53.41101:07:36.529 99.6%----

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 79 175421 175272 0 149 99%38:03:01
2localhost 16 15 15 0 0 100%00:00:01
3news.icm.edu.pl 40 89 9 74 6 10%09:29:23
TOTAL: 3 135 175525 175296 74 155 99%47:32:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.8 GB76.1 KB427.6 KB1.8 GB 99%10.6 KB
2news.icm.edu.pl102.1 KB28.8 KB93.5 KB224.3 KB 45%15.0 KB
3localhost21.0 KB0.0 KB0.0 KB21.0 KB100%1.4 KB
TOTAL: 31.8 GB104.9 KB521.0 KB1.8 GB 99%10.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 12 04:15:01 - 04:59:59 7085 4.0% 2.6350.4 MB 2.8% 19.13
Jul 12 05:00:00 - 05:59:59 5966 3.4% 1.6652.0 MB 2.9% 14.81
Jul 12 06:00:00 - 06:59:59 4402 2.5% 1.2248.0 MB 2.6% 13.65
Jul 12 07:00:00 - 07:59:59 4263 2.4% 1.1853.8 MB 3.0% 15.31
Jul 12 08:00:00 - 08:59:59 7483 4.3% 2.0887.8 MB 4.8% 24.97
Jul 12 09:00:00 - 09:59:59 7236 4.1% 2.0182.6 MB 4.5% 23.51
Jul 12 10:00:00 - 10:59:59 7567 4.3% 2.1080.6 MB 4.4% 22.93
Jul 12 11:00:00 - 11:59:59 7413 4.2% 2.06103.3 MB 5.7% 29.39
Jul 12 12:00:00 - 12:59:59 8678 4.9% 2.4193.1 MB 5.1% 26.49
Jul 12 13:00:00 - 13:59:59 6359 3.6% 1.7762.9 MB 3.5% 17.89
Jul 12 14:00:00 - 14:59:59 7497 4.3% 2.0889.3 MB 4.9% 25.41
Jul 12 15:00:00 - 15:59:59 7405 4.2% 2.0695.8 MB 5.3% 27.25
Jul 12 16:00:00 - 16:59:59 6221 3.5% 1.7365.8 MB 3.6% 18.70
Jul 12 17:00:00 - 17:59:59 4514 2.6% 1.2554.4 MB 3.0% 15.49
Jul 12 18:00:00 - 18:59:59 6226 3.5% 1.7370.5 MB 3.9% 20.06
Jul 12 19:00:00 - 19:59:59 10358 5.9% 2.8894.5 MB 5.2% 26.88
Jul 12 20:00:00 - 20:59:59 9611 5.5% 2.6788.9 MB 4.9% 25.28
Jul 12 21:00:00 - 21:59:59 11863 6.8% 3.30153.6 MB 8.4% 43.69
Jul 12 22:00:00 - 22:59:59 8624 4.9% 2.4074.8 MB 4.1% 21.29
Jul 12 23:00:00 - 23:59:59 10962 6.2% 3.0492.6 MB 5.1% 26.34
Jul 13 00:00:00 - 00:59:59 8061 4.6% 2.2472.4 MB 4.0% 20.61
Jul 13 01:00:00 - 01:59:59 7987 4.6% 2.2256.7 MB 3.1% 16.14
Jul 13 02:00:00 - 02:59:59 4294 2.4% 1.1935.8 MB 2.0% 10.18
Jul 13 03:00:00 - 03:59:59 4591 2.6% 1.2849.3 MB 2.7% 14.01
Jul 13 04:00:00 - 04:15:01 737 0.4% 0.828.9 MB 0.5% 10.15
TOTAL: 24:00:00 175403 100.0% 2.031.8 GB 100.0% 21.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 261 141 0 6 2 0 0 0 112
2news.icm.edu.pl 6 0 0 3 0 0 0 0 3
TOTAL: 2 267 141 0 9 2 0 0 0 115

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 85
comp.mobile.android 16
alt.comp.software.firefox 15
eternal-september.test 5
eternal-september.support 3
it.tlc.cellulari.android 3
rocksolid.nodes.help 3
alt.comp.software.seamonkey 2
nl.comp.os.linux.techniek 2
comp.sys.raspberry-pi 2
it.comp.os.win.windows10 1
fr.rec.loisirs-creatifs 1
rocksolid.test.test 1
fido7.r50.crisis 1
grisbi.test 1
TOTAL: 15 141

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

GroupsCount
christnet.bible 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 3
TOTAL: 1 3

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 7504 4 6669 4 0 0 0%23:50:01
2okapi 0 0 0 0 0 814 0%23:50:00
3panorama 0 0 0 0 0 39691 0%23:50:00
4poznan 11 0 9 0 0 0 0%01:30:14
5nask 0 0 0 0 0 36948 0%23:50:00
TOTAL: 5 7515 4 6678 4 0 77453 0%96:50:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm16.6 KB109.4 KB126.0 KB0.0 KB/s15.8 KB23:50:01
2okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:30:14
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
TOTAL: 516.6 KB109.4 KB126.0 KB0.0 KB/s15.8 KB96:50:15
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama3.3 MB
TOTAL: 13.3 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 65.5 KB 3 0 000:00:09
2isvcs01.man.lodz.pl 15 00.0 KB 0 15 000:00:00
TOTAL: 2 304 65.5 KB 3 15 001:07:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1743 65.5 KB 3 15 001:07:47
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4unresolved 100 00.0 KB 0 0 000:00:03
5*.ip.linodeusercontent.com 2 00.0 KB 0 0 000:00:00
TOTAL: 51847 65.5 KB 3 15 001:07:53

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-tom.man.lodz.pl 0.000 0.021 0.00001:07:24
nms1.man.lodz.pl 4.636 6.467 0.00000:00:13
web.man.lodz.pl 0.886 1.305 0.00000:00:09
80.111.142.213 0.022 0.013 0.00000:00:02
blissful.monitoring.internet-measurement.com 0.008 0.003 0.00000:00:02
212.51.192.185 0.338 0.388 0.00000:00:00
isvcs01.man.lodz.pl 0.087 0.107 0.00000:00:00
azpdeg46.stretchoid.com 0.004 0.008 0.00000:00:00
172-232-203-210.ip.linodeusercontent.com 0.005 0.005 0.00000:00:00
172-232-203-8.ip.linodeusercontent.com 0.005 0.000 0.00000:00:00
? 0.008 0.004 0.00000:00:00
TOTAL: 11 5.999 8.321 0.00001:07:53

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1437
212.51.192.185 96
80.111.142.213 4
pc-tom.man.lodz.pl 2
172-232-203-8.ip.linodeusercontent.com 1
blissful.monitoring.internet-measurement.com 1
azpdeg46.stretchoid.com 1
172-232-203-210.ip.linodeusercontent.com 1
TOTAL: 8 1543

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 2
TOTAL: 1 2

NNRP unrecognized commands (by host):

SystemConn
azpdeg46.stretchoid.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-tom.man.lodz.pl 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 6
TOTAL: 1 6