Daily Usenet report

Sep 24 04:15:02 -- Sep 25 04:15:01

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Sep 24 09:11:10 newsfeed nnrpd[151813]: SERVER perl filter not defined
Sep 24 09:11:10 newsfeed nnrpd[151813]: SERVER perl filter not defined
Sep 24 12:49:39 newsfeed nnrpd[177839]: SERVER perl filter not defined
Sep 24 12:49:39 newsfeed nnrpd[177839]: SERVER perl filter not defined
Sep 24 12:49:46 newsfeed nnrpd[177858]: SERVER perl filter not defined
Sep 24 12:49:46 newsfeed nnrpd[177858]: SERVER perl filter not defined
Sep 24 13:04:21 newsfeed nnrpd[179574]: SERVER perl filter not defined
Sep 24 13:04:21 newsfeed nnrpd[179574]: SERVER perl filter not defined
Sep 24 13:04:43 newsfeed nnrpd[179712]: SERVER perl filter not defined
Sep 24 13:04:43 newsfeed nnrpd[179712]: SERVER perl filter not defined
Sep 24 13:05:04 newsfeed nnrpd[179765]: SERVER perl filter not defined
Sep 24 13:05:04 newsfeed nnrpd[179765]: SERVER perl filter not defined
Sep 24 13:06:10 newsfeed nnrpd[179788]: SERVER perl filter not defined
Sep 24 13:06:10 newsfeed nnrpd[179788]: SERVER perl filter not defined
Sep 24 15:24:54 newsfeed nnrpd[196747]: SERVER perl filter not defined
Sep 24 15:24:54 newsfeed nnrpd[196747]: SERVER perl filter not defined
Sep 24 19:31:13 newsfeed nnrpd[226640]: SERVER perl filter not defined
Sep 24 19:31:13 newsfeed nnrpd[226640]: SERVER perl filter not defined
Sep 24 19:31:31 newsfeed nnrpd[226643]: SERVER perl filter not defined
Sep 24 19:31:31 newsfeed nnrpd[226643]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 199940 82.0%22.1 MB 84.3%
innd 26664 10.9%2.5 MB 9.5%
nnrpd 15834 6.5%1.5 MB 5.6%
innfeed 1276 0.5%145.4 KB 0.5%
overchan 2 0.0%0.1 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 6 243718 100.0%26.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 399506 99.8%
Negative hits 800 0.2%
Positive hits 142 0.0%
Cache misses 6 0.0%
TOTAL: 4 400454 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.012 0.0%272 0.000 0.044 1.000
article cleanup00:00:01.184 0.0%399838 0.000 0.003 0.007
article logging00:00:05.544 0.0%399952 0.006 0.014 0.026
article parse00:00:08.172 0.0%1462482 0.003 0.006 0.011
article write00:00:15.194 0.0%399828 0.022 0.038 0.069
artlog/artcncl00:00:00.000 0.0%20 0.000 0.000 0.000
data move00:00:01.144 0.0%2206502 0.000 0.001 0.002
hisgrep/artcncl00:00:00.002 0.0%292 0.000 0.007 0.043
hishave/artcncl00:00:00.000 0.0%20 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.544 0.0%400852 0.000 0.004 0.012
history sync00:00:00.028 0.0%748 0.000 0.037 0.667
history write00:00:25.234 0.0%399832 0.030 0.063 0.206
idle47:55:55.524 99.8%1782742 51.092 96.792 557.758
nntp read00:00:13.122 0.0%1419678 0.006 0.009 0.016
overview write00:00:00.598 0.0%399828 0.000 0.001 0.007
perl filter00:03:41.040 0.1%399832 0.402 0.553 0.739
python filter00:00:00.100 0.0%399852 0.000 0.000 0.003
site send00:00:05.714 0.0%821608 0.003 0.007 0.013
TOTAL: 48:01:32.16848:00:54.156100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.036 0.0%21946 0.000 0.002 0.031
article prepare00:00:00.000 0.0%1888 0.000 0.000 0.000
article read00:00:00.012 0.0%472 0.000 0.025 1.000
backlog stats00:00:00.014 0.0%119786 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.436 0.0%60404 0.000 0.007 0.031
data write00:00:01.198 0.0%37704 0.000 0.032 0.083
idle47:58:54.454100.0%119786 489.216 1442.025 3752.338
status file00:00:00.186 0.0%334 0.000 0.557 4.000
TOTAL: 47:58:57.31247:58:56.336100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:19.230 76.3%8872 1.000 8.930 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.312 0.3%29838 0.000 0.010 0.333
TOTAL: 00:01:43.78800:01:19.542 76.6%----

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 122 399464 399460 2 2 99%68:20:32
2localhost 22 20 20 0 0 100%00:00:00
3news.icm.edu.pl 58 132 6 118 8 4%12:18:24
TOTAL: 3 202 399616 399486 120 10 99%80:38:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl4.4 GB28.5 KB0.0 KB4.4 GB 99%11.6 KB
2news.icm.edu.pl255.6 KB56.6 KB46.2 KB358.4 KB 71%25.6 KB
3localhost31.8 KB0.0 KB0.0 KB31.8 KB100%1.6 KB
TOTAL: 34.4 GB85.1 KB46.2 KB4.4 GB 99%11.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 24 04:15:02 - 04:59:59 6181 3.1% 2.2963.6 MB 2.8% 24.14
Sep 24 05:00:00 - 05:59:59 8216 4.1% 2.2894.9 MB 4.2% 27.00
Sep 24 06:00:00 - 06:59:59 8678 4.3% 2.4193.0 MB 4.1% 26.44
Sep 24 07:00:00 - 07:59:59 8963 4.5% 2.49106.0 MB 4.7% 30.14
Sep 24 08:00:00 - 08:59:59 8250 4.1% 2.2997.1 MB 4.3% 27.61
Sep 24 09:00:00 - 09:59:59 8380 4.2% 2.33104.6 MB 4.6% 29.75
Sep 24 10:00:00 - 10:59:59 8260 4.1% 2.2999.5 MB 4.4% 28.31
Sep 24 11:00:00 - 11:59:59 10086 5.0% 2.80123.7 MB 5.5% 35.18
Sep 24 12:00:00 - 12:59:59 7453 3.7% 2.0784.7 MB 3.7% 24.10
Sep 24 13:00:00 - 13:59:59 9103 4.6% 2.53116.1 MB 5.1% 33.01
Sep 24 14:00:00 - 14:59:59 7292 3.6% 2.0383.9 MB 3.7% 23.86
Sep 24 15:00:00 - 15:59:59 11525 5.8% 3.20141.0 MB 6.2% 40.11
Sep 24 16:00:00 - 16:59:59 8334 4.2% 2.3192.5 MB 4.1% 26.31
Sep 24 17:00:00 - 17:59:59 8320 4.2% 2.3196.5 MB 4.3% 27.43
Sep 24 18:00:00 - 18:59:59 9836 4.9% 2.73109.6 MB 4.8% 31.17
Sep 24 19:00:00 - 19:59:59 9594 4.8% 2.6796.1 MB 4.2% 27.35
Sep 24 20:00:00 - 20:59:59 8351 4.2% 2.3295.0 MB 4.2% 27.01
Sep 24 21:00:00 - 21:59:59 7968 4.0% 2.2191.3 MB 4.0% 25.97
Sep 24 22:00:00 - 22:59:59 8744 4.4% 2.4385.5 MB 3.8% 24.32
Sep 24 23:00:00 - 23:59:59 8319 4.2% 2.3195.5 MB 4.2% 27.18
Sep 25 00:00:00 - 00:59:59 5810 2.9% 1.6165.4 MB 2.9% 18.60
Sep 25 01:00:00 - 01:59:59 5877 2.9% 1.6363.3 MB 2.8% 18.01
Sep 25 02:00:00 - 02:59:59 6542 3.3% 1.8269.7 MB 3.1% 19.82
Sep 25 03:00:00 - 03:59:59 6754 3.4% 1.8870.8 MB 3.1% 20.15
Sep 25 04:00:00 - 04:15:01 3032 1.5% 3.3723.1 MB 1.0% 26.31
TOTAL: 23:59:59 199868 100.0% 2.312.2 GB 100.0% 26.81
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 58 0 0 1 0 0 0 0 57
2news.icm.edu.pl 4 0 0 2 0 0 0 0 2
TOTAL: 2 62 0 0 3 0 0 0 0 59

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 40240 468 21470 4 0 0 1%47:59:46
2poznan 6 0 6 0 0 0 0%01:20:00
TOTAL: 2 40246 468 21476 4 0 0 1%49:19:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm776.4 KB10.9 KB787.4 KB0.0 KB/s1.7 KB47:59:46
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:20:00
TOTAL: 2776.4 KB10.9 KB787.4 KB0.0 KB/s1.7 KB49:19:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1167.94.146.63 6 00.0 KB 0 0 000:00:06
2nms2.man.lodz.pl2064 00.0 KB 0 0 000:00:15
3pleasant.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
4nms1.man.lodz.pl 814 00.0 KB 0 0 000:00:06
5198.235.24.33 2 00.0 KB 0 0 000:00:07
6isvcs01.man.lodz.pl 20 00.0 KB 0 20 000:00:01
7ns31410048.ip-145-239-154.eu 4 00.0 KB 0 0 000:00:00
8147.185.132.109 2 00.0 KB 0 0 000:00:00
9azpdsga05mgt.stretchoid.com 4 00.0 KB 0 0 000:00:20
10172.16.2.4 576 00.0 KB 0 0 000:00:32
11147.185.132.255 2 00.0 KB 0 0 000:00:03
1280.111.142.213 8 00.0 KB 0 0 000:00:05
TOTAL: 123504 00.0 KB 0 20 000:01:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl2898 00.0 KB 0 20 000:00:23
2*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
3*.ip-145-239-154.eu 4 00.0 KB 0 0 000:00:00
4unresolved 596 00.0 KB 0 0 000:00:56
5*.stretchoid.com 4 00.0 KB 0 0 000:00:20
TOTAL: 53504 00.0 KB 0 20 000:01:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.16.2.4 1.312 2.642 0.00000:00:32
azpdsga05mgt.stretchoid.com 0.008 0.018 0.00000:00:20
nms2.man.lodz.pl 4.262 9.014 0.00000:00:15
198.235.24.33 0.002 0.010 0.00000:00:07
167.94.146.63 0.078 0.024 0.00000:00:06
nms1.man.lodz.pl 1.666 3.528 0.00000:00:06
80.111.142.213 0.014 0.044 0.00000:00:05
pleasant.monitoring.internet-measurement.com 0.008 0.008 0.00000:00:03
147.185.132.255 0.004 0.010 0.00000:00:03
isvcs01.man.lodz.pl 0.070 0.096 0.00000:00:01
ns31410048.ip-145-239-154.eu 0.066 0.024 0.00000:00:00
147.185.132.109 0.004 0.010 0.00000:00:00
TOTAL: 12 7.494 15.428 0.00000:01:45

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

SystemConn
azpdsga05mgt.stretchoid.com 2
167.94.146.63 2
ns31410048.ip-145-239-154.eu 2
TOTAL: 3 6

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

CommandCount
MGLNDD_212.191.2.21_119 2
#026#003 2
EHLO www.censys.io 2
TOTAL: 3 6

NNRP client timeouts [Top 20]:

SystemConnPeer
ns31410048.ip-145-239-154.eu 4 4
167.94.146.63 2 4
TOTAL: 2 6 14