Daily Usenet report

May 22 04:15:01 -- May 23 04:15:01

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

May 22 08:10:16 newsfeed nnrpd[1011415]: SERVER perl filter not defined
May 22 08:10:16 newsfeed nnrpd[1011415]: SERVER perl filter not defined
May 22 08:14:25 newsfeed nnrpd[1011701]: SERVER perl filter not defined
May 22 08:14:25 newsfeed nnrpd[1011701]: SERVER perl filter not defined
May 22 08:21:10 newsfeed nnrpd[1012533]: SERVER perl filter not defined
May 22 08:21:10 newsfeed nnrpd[1012533]: SERVER perl filter not defined
May 22 08:22:48 newsfeed nnrpd[1012803]: SERVER perl filter not defined
May 22 08:22:48 newsfeed nnrpd[1012803]: SERVER perl filter not defined
May 22 10:55:35 newsfeed nnrpd[1031057]: SERVER perl filter not defined
May 22 10:55:35 newsfeed nnrpd[1031057]: SERVER perl filter not defined
May 22 15:18:31 newsfeed nnrpd[1063318]: SERVER perl filter not defined
May 22 15:18:31 newsfeed nnrpd[1063318]: SERVER perl filter not defined
May 22 15:19:29 newsfeed nnrpd[1063326]: SERVER perl filter not defined
May 22 15:19:29 newsfeed nnrpd[1063326]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 181658 82.0%20.0 MB 84.1%
innd 22132 10.0%2.1 MB 8.7%
nnrpd 16494 7.4%1.5 MB 6.5%
innfeed 1236 0.6%154.9 KB 0.6%
controlchan 2 0.0%0.1 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 6 221524 100.0%23.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 362038 99.7%
Negative hits 930 0.3%
Positive hits 98 0.0%
Cache misses 60 0.0%
TOTAL: 4 363126 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.212 0.0%184 0.000 1.152 8.000
article cleanup00:00:01.676 0.0%363284 0.000 0.005 0.011
article logging00:00:06.974 0.0%363314 0.009 0.019 0.029
article parse00:00:15.244 0.0%1171352 0.007 0.013 0.019
article write00:01:29.088 0.1%363278 0.171 0.245 0.701
artlog/artcncl00:00:00.000 0.0%76 0.000 0.000 0.000
data move00:00:01.300 0.0%1764362 0.000 0.001 0.002
hisgrep/artcncl00:00:00.044 0.0%260 0.000 0.169 0.500
hishave/artcncl00:00:00.000 0.0%76 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:31.682 0.0%364296 0.013 0.087 0.412
history sync00:00:00.012 0.0%638 0.000 0.019 0.500
history write00:00:42.018 0.0%363284 0.041 0.116 0.316
idle47:51:05.282 99.7%1408880 59.179 122.271 486.800
nntp read00:00:16.314 0.0%1117172 0.007 0.015 0.024
overview write00:00:00.944 0.0%363278 0.000 0.003 0.009
perl filter00:05:30.122 0.2%363284 0.599 0.909 1.159
python filter00:00:00.084 0.0%363298 0.000 0.000 0.002
site send00:00:07.812 0.0%741386 0.004 0.011 0.018
TOTAL: 48:00:55.04248:00:08.808100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%14850 0.000 0.001 0.040
article prepare00:00:00.002 0.0%2336 0.000 0.001 0.009
article read00:00:00.004 0.0%584 0.000 0.007 0.034
backlog stats00:00:00.012 0.0%84560 0.000 0.000 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.308 0.0%40464 0.000 0.008 0.036
data write00:00:01.128 0.0%25832 0.000 0.044 0.154
idle47:59:26.802100.0%84560 263.459 2043.127 8711.565
status file00:00:00.108 0.0%324 0.000 0.333 1.000
TOTAL: 47:59:29.18047:59:28.380100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:32:56.174 99.3%25998 0.000 214.485 9780.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.260 0.0%98026 0.000 0.023 0.500
readart00:00:03.256 0.1%16952 0.172 0.192 0.192
TOTAL: 01:33:35.95401:33:01.690 99.4%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 298
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 386

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 80 363262 363260 2 0 99%70:43:26
2localhost 16 14 14 0 0 100%00:00:00
3news.icm.edu.pl 52 88 2 80 6 2%11:34:58
TOTAL: 3 148 363364 363276 82 6 99%82:18:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.7 GB0.0 KB0.0 KB3.7 GB100%10.8 KB
2news.icm.edu.pl534.4 KB0.0 KB655.1 KB1.2 MB 44%148.7 KB
3localhost26.5 KB0.0 KB0.0 KB26.5 KB100%1.9 KB
TOTAL: 33.7 GB0.0 KB655.1 KB3.7 GB 99%10.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 22 04:15:01 - 04:59:59 2792 1.5% 1.0324.5 MB 1.3% 9.30
May 22 05:00:00 - 05:59:59 5530 3.0% 1.5463.2 MB 3.3% 17.97
May 22 06:00:00 - 06:59:59 4422 2.4% 1.2347.4 MB 2.5% 13.48
May 22 07:00:00 - 07:59:59 6848 3.8% 1.9069.9 MB 3.6% 19.88
May 22 08:00:00 - 08:59:59 8172 4.5% 2.2788.3 MB 4.6% 25.12
May 22 09:00:00 - 09:59:59 8168 4.5% 2.2789.9 MB 4.7% 25.57
May 22 10:00:00 - 10:59:59 8468 4.7% 2.3585.9 MB 4.5% 24.43
May 22 11:00:00 - 11:59:59 7181 4.0% 1.9986.4 MB 4.5% 24.56
May 22 12:00:00 - 12:59:59 6052 3.3% 1.6860.1 MB 3.1% 17.09
May 22 13:00:00 - 13:59:59 7602 4.2% 2.1174.9 MB 3.9% 21.29
May 22 14:00:00 - 14:59:59 8298 4.6% 2.3192.9 MB 4.8% 26.42
May 22 15:00:00 - 15:59:59 9778 5.4% 2.72110.3 MB 5.8% 31.37
May 22 16:00:00 - 16:59:59 6904 3.8% 1.9262.8 MB 3.3% 17.87
May 22 17:00:00 - 17:59:59 15005 8.3% 4.17120.2 MB 6.3% 34.18
May 22 18:00:00 - 18:59:59 9878 5.4% 2.7491.7 MB 4.8% 26.07
May 22 19:00:00 - 19:59:59 8528 4.7% 2.37106.6 MB 5.6% 30.32
May 22 20:00:00 - 20:59:59 7573 4.2% 2.1073.3 MB 3.8% 20.84
May 22 21:00:00 - 21:59:59 7444 4.1% 2.0797.8 MB 5.1% 27.82
May 22 22:00:00 - 22:59:59 5983 3.3% 1.6669.9 MB 3.6% 19.88
May 22 23:00:00 - 23:59:59 7118 3.9% 1.9879.3 MB 4.1% 22.57
May 23 00:00:00 - 00:59:59 8640 4.8% 2.40100.6 MB 5.2% 28.61
May 23 01:00:00 - 01:59:59 6105 3.4% 1.7069.2 MB 3.6% 19.70
May 23 02:00:00 - 02:59:59 6027 3.3% 1.6756.3 MB 2.9% 16.03
May 23 03:00:00 - 03:59:59 7390 4.1% 2.0579.5 MB 4.1% 22.62
May 23 04:00:00 - 04:15:01 1696 0.9% 1.8816.6 MB 0.9% 18.82
TOTAL: 24:00:00 181602 100.0% 2.101.9 GB 100.0% 22.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 15 0 0 0 0 0 0 0 15
2news.icm.edu.pl 3 0 0 0 0 0 0 0 3
TOTAL: 2 18 0 0 0 0 0 0 0 18

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 26518 532 14240 52 0 24 2%47:59:56
2poznan 2 0 2 0 0 0 0%00:40:02
TOTAL: 2 26520 532 14242 52 0 24 2%48:39:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.5 MB750.4 KB2.2 MB0.0 KB/s3.9 KB47:59:56
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:40:02
TOTAL: 21.5 MB750.4 KB2.2 MB0.0 KB/s3.9 KB48:39:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 8 1695218.5 MB 4 0 001:31:37
2isvcs01.man.lodz.pl 14 00.0 KB 0 14 000:00:00
TOTAL: 2 22 1695218.5 MB 4 14 001:33:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 8 1695218.5 MB 4 0 001:31:37
2*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
3*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:00
4unresolved 790 00.0 KB 0 0 000:01:05
5*.man.lodz.pl2854 00.0 KB 0 14 000:00:29
6*.stretchoid.com 4 00.0 KB 0 0 000:00:20
TOTAL: 63660 1695218.5 MB 4 14 001:33:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 0.938 2.288 0.00001:31:37
172.16.2.4 1.788 3.696 0.00000:00:34
nms2.man.lodz.pl 6.348 11.942 0.00000:00:20
azpdws67vkw4.stretchoid.com 0.006 0.010 0.00000:00:19
nms1.man.lodz.pl 2.526 4.854 0.00000:00:08
167.94.145.110 0.088 0.026 0.00000:00:08
205.210.31.35 0.004 0.010 0.00000:00:08
80.111.142.213 0.038 0.032 0.00000:00:06
147.185.132.120 0.008 0.006 0.00000:00:05
breezy.monitoring.internet-measurement.com 0.006 0.006 0.00000:00:03
212.51.192.185 0.616 1.126 0.00000:00:02
182.138.158.223 0.010 0.004 0.00000:00:01
isvcs01.man.lodz.pl 0.088 0.106 0.00000:00:00
azpdwgfjx0xd.stretchoid.com 0.014 0.020 0.00000:00:00
129.211.203.35.bc.googleusercontent.com 0.008 0.010 0.00000:00:00
80.94.95.168 0.004 0.014 0.00000:00:00
TOTAL: 16 12.490 24.150 0.00001:33:36

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 2018
nms1.man.lodz.pl 822
172.16.2.4 576
212.51.192.185 192
80.111.142.213 8
167.94.145.110 6
80.94.95.168 2
breezy.monitoring.internet-measurement.com 2
azpdws67vkw4.stretchoid.com 2
147.185.132.120 2
azpdwgfjx0xd.stretchoid.com 2
129.211.203.35.bc.googleusercontent.com 2
205.210.31.35 2
182.138.158.223 2
TOTAL: 14 3638

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
129.211.203.35.bc.googleusercontent.com 8
167.94.145.110 2
80.94.95.168 2
azpdwgfjx0xd.stretchoid.com 2
TOTAL: 4 14

NNRP unrecognized commands (by command) [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.145.110 2 4
80.94.95.168 2 2
TOTAL: 2 4 10

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 16952100.0%
TOTAL: 1 16952100.0%

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

NewsgroupCount
1lodman.info 16952
TOTAL: 1 16952