Daily Usenet report

Aug 23 04:15:01 -- Aug 24 04:15:01

Unknown entries from news log file:

First 30 / 30 lines (100.0%)

Aug 23 10:44:51 newsfeed nnrpd[864784]: SERVER perl filter not defined
Aug 23 10:44:51 newsfeed nnrpd[864784]: SERVER perl filter not defined
Aug 23 13:50:04 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 281600 duplicate size 0 rejected size 0]
Aug 23 13:50:04 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 281600 duplicate size 0 rejected size 0]
Aug 23 15:30:44 newsfeed nnrpd[899711]: SERVER perl filter not defined
Aug 23 15:30:44 newsfeed nnrpd[899711]: SERVER perl filter not defined
Aug 23 15:55:02 newsfeed nnrpd[902512]: SERVER perl filter not defined
Aug 23 15:55:02 newsfeed nnrpd[902512]: SERVER perl filter not defined
Aug 23 16:03:03 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 281600 duplicate size 0 rejected size 0]
Aug 23 16:03:03 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 1 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 281600 duplicate size 0 rejected size 0]
Aug 23 16:16:05 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 230400 duplicate size 0 rejected size 0]
Aug 23 16:16:05 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 230400 duplicate size 0 rejected size 0]
Aug 23 17:36:32 newsfeed nnrpd[914804]: SERVER perl filter not defined
Aug 23 17:36:32 newsfeed nnrpd[914804]: SERVER perl filter not defined
Aug 23 17:49:05 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 281600 duplicate size 0 rejected size 0]
Aug 23 17:49:05 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 281600 duplicate size 0 rejected size 0]
Aug 23 18:22:39 newsfeed nnrpd[920133]: SERVER perl filter not defined
Aug 23 18:22:39 newsfeed nnrpd[920133]: SERVER perl filter not defined
Aug 23 19:16:55 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 230400 duplicate size 0 rejected size 0]
Aug 23 19:16:55 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 230400 duplicate size 0 rejected size 0]
Aug 23 19:16:57 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 230400 duplicate size 0 rejected size 0]
Aug 23 19:16:57 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 230400 duplicate size 0 rejected size 0]
Aug 23 20:07:45 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 256000 duplicate size 0 rejected size 0]
Aug 23 20:07:45 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:76 checkpoint seconds 0 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 256000 duplicate size 0 rejected size 0]
Aug 23 21:21:16 newsfeed nnrpd[941691]: SERVER perl filter not defined
Aug 23 21:21:16 newsfeed nnrpd[941691]: SERVER perl filter not defined
Aug 23 22:00:01 newsfeed nnrpd[946122]: SERVER perl filter not defined
Aug 23 22:00:01 newsfeed nnrpd[946122]: SERVER perl filter not defined
Aug 24 00:11:19 newsfeed nnrpd[962111]: SERVER perl filter not defined
Aug 24 00:11:19 newsfeed nnrpd[962111]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 326599 89.5%36.3 MB 90.6%
innd 20794 5.7%2.1 MB 5.2%
nnrpd 16148 4.4%1.5 MB 3.8%
innfeed 1290 0.4%159.8 KB 0.4%
controlchan 2 0.0%0.1 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 364835 100.0%40.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 650862 99.8%
Negative hits 876 0.1%
Positive hits 118 0.0%
Cache misses 4 0.0%
TOTAL: 4 651860 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.016 0.0%84 0.000 0.190 3.000
article cleanup00:00:01.608 0.0%656850 0.000 0.002 0.006
article logging00:00:08.036 0.0%656902 0.007 0.012 0.021
article parse00:00:10.288 0.0%2019642 0.002 0.005 0.009
article write00:00:21.056 0.0%656848 0.020 0.032 0.055
artlog/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
data move00:00:01.342 0.0%2714030 0.000 0.000 0.002
hisgrep/artcncl00:00:00.008 0.0%100 0.000 0.080 1.000
hishave/artcncl00:00:00.000 0.0%16 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:23.018 0.0%657830 0.001 0.035 0.391
history sync00:00:00.028 0.0%690 0.000 0.041 1.000
history write00:01:13.440 0.0%656848 0.024 0.112 0.393
idle47:52:12.616 99.7%2356556 21.958 73.129 286.452
nntp read00:00:15.082 0.0%1843610 0.005 0.008 0.014
overview write00:00:00.830 0.0%656848 0.000 0.001 0.004
perl filter00:05:34.024 0.2%656848 0.270 0.509 0.729
python filter00:00:00.116 0.0%656864 0.000 0.000 0.002
site send00:00:07.774 0.0%1324886 0.002 0.006 0.013
TOTAL: 48:01:28.42848:00:29.282100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%11416 0.000 0.002 0.031
article prepare00:00:00.000 0.0%2776 0.000 0.000 0.000
article read00:00:00.004 0.0%694 0.000 0.006 0.167
backlog stats00:00:00.018 0.0%65962 0.000 0.000 0.020
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.268 0.0%30540 0.000 0.009 0.071
data write00:00:00.594 0.0%19354 0.000 0.031 0.200
idle47:41:38.948100.0%65962 735.099 2602.998 16231.270
status file00:00:00.182 0.0%332 0.000 0.548 5.000
TOTAL: 47:41:40.78447:41:40.042100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:47.208 83.8%9068 0.222 18.439 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.226 0.1%30664 0.000 0.007 0.333
readart00:00:00.010 0.0%32 0.000 0.312 0.357
TOTAL: 00:03:19.53200:02:47.444 83.9%----

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 144 646910 646908 0 2 99%69:27:54
2localhost 18 16 16 0 0 100%00:00:00
3news.icm.edu.pl 64 106 2 104 0 1%15:51:14
TOTAL: 3 226 647032 646926 104 2 99%85:19:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl5.2 GB18.6 KB0.0 KB5.2 GB 99%8.4 KB
2localhost27.8 KB0.0 KB0.0 KB27.8 KB100%1.7 KB
3news.icm.edu.pl18.6 KB0.0 KB0.0 KB18.6 KB100%9.3 KB
TOTAL: 35.2 GB18.6 KB0.0 KB5.2 GB 99%8.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 23 04:15:01 - 04:59:59 10446 3.2% 3.8782.3 MB 3.1% 31.23
Aug 23 05:00:00 - 05:59:59 13627 4.2% 3.79139.2 MB 5.2% 39.59
Aug 23 06:00:00 - 06:59:59 13817 4.2% 3.84119.1 MB 4.5% 33.87
Aug 23 07:00:00 - 07:59:59 9970 3.1% 2.7782.7 MB 3.1% 23.52
Aug 23 08:00:00 - 08:59:59 14894 4.6% 4.14126.8 MB 4.8% 36.07
Aug 23 09:00:00 - 09:59:59 8352 2.6% 2.3291.5 MB 3.4% 26.03
Aug 23 10:00:00 - 10:59:59 10529 3.2% 2.9289.8 MB 3.4% 25.55
Aug 23 11:00:00 - 11:59:59 7897 2.4% 2.1981.2 MB 3.0% 23.08
Aug 23 12:00:00 - 12:59:59 7701 2.4% 2.1487.0 MB 3.3% 24.75
Aug 23 13:00:00 - 13:59:59 14291 4.4% 3.97111.0 MB 4.2% 31.58
Aug 23 14:00:00 - 14:59:59 11792 3.6% 3.28116.9 MB 4.4% 33.24
Aug 23 15:00:00 - 15:59:59 12614 3.9% 3.5088.4 MB 3.3% 25.16
Aug 23 16:00:00 - 16:59:59 16429 5.0% 4.5682.2 MB 3.1% 23.39
Aug 23 17:00:00 - 17:59:59 15384 4.7% 4.27100.9 MB 3.8% 28.70
Aug 23 18:00:00 - 18:59:59 12746 3.9% 3.54114.9 MB 4.3% 32.69
Aug 23 19:00:00 - 19:59:59 18671 5.7% 5.19143.1 MB 5.4% 40.70
Aug 23 20:00:00 - 20:59:59 33957 10.4% 9.43218.5 MB 8.2% 62.14
Aug 23 21:00:00 - 21:59:59 13448 4.1% 3.74131.3 MB 4.9% 37.36
Aug 23 22:00:00 - 22:59:59 19926 6.1% 5.54163.8 MB 6.1% 46.58
Aug 23 23:00:00 - 23:59:59 11534 3.5% 3.2089.7 MB 3.4% 25.52
Aug 24 00:00:00 - 00:59:59 13841 4.2% 3.84136.3 MB 5.1% 38.77
Aug 24 01:00:00 - 01:59:59 14398 4.4% 4.00111.6 MB 4.2% 31.75
Aug 24 02:00:00 - 02:59:59 9824 3.0% 2.7377.5 MB 2.9% 22.03
Aug 24 03:00:00 - 03:59:59 7927 2.4% 2.2063.5 MB 2.4% 18.08
Aug 24 04:00:00 - 04:15:01 2549 0.8% 2.8317.9 MB 0.7% 20.37
TOTAL: 24:00:00 326564 100.0% 3.782.6 GB 100.0% 31.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 27 0 0 1 0 0 0 0 26
TOTAL: 1 27 0 0 1 0 0 0 0 26

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 19106 628 9712 66 0 1040 3%47:59:56
2poznan 4 0 2 0 0 0 0%00:40:10
TOTAL: 2 19110 628 9714 66 0 1040 3%48:40:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.9 MB163.4 KB2.0 MB0.0 KB/s3.0 KB47:59:56
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:40:10
TOTAL: 21.9 MB163.4 KB2.0 MB0.0 KB/s3.0 KB48:40:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 44 3252.1 KB 6 0 000:00:49
2isvcs01.man.lodz.pl 16 00.0 KB 0 16 000:00:00
TOTAL: 2 60 3252.1 KB 6 16 000:03:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 630 3252.1 KB 6 0 000:01:32
2*.man.lodz.pl2896 00.0 KB 0 16 000:00:27
3*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
4*.stretchoid.com 4 00.0 KB 0 0 000:00:20
5*.internet-census.org 14 00.0 KB 0 0 000:00:46
6*.172.132.66.censys-scanner.com 6 00.0 KB 0 0 000:00:02
7*.224.132.66.censys-scanner.com 6 00.0 KB 0 0 000:00:07
8*.infrawat.ch 8 00.0 KB 0 0 000:00:01
TOTAL: 83566 3252.1 KB 6 16 000:03:20

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.61.98.95 0.114 0.332 0.00000:00:49
172.16.2.4 1.592 4.220 0.00000:00:34
nms2.man.lodz.pl 8.286 20.166 0.00000:00:26
sh-chi-us-gp1-wk137c.internet-census.org 0.004 0.018 0.00000:00:20
azpdcs8dhr72.stretchoid.com 0.008 0.032 0.00000:00:20
sh-ams-nl-cpp-wk104.internet-census.org 0.006 0.032 0.00000:00:08
236.224.132.66.censys-scanner.com 0.066 0.034 0.00000:00:07
80.111.142.213 0.016 0.068 0.00000:00:05
zl-laxc-us-cpp-wk109.internet-census.org 0.002 0.018 0.00000:00:04
zl-laxd-us-cpp-wk111.internet-census.org 0.004 0.014 0.00000:00:04
sh-chi-us-cpp-wk105.internet-census.org 0.004 0.014 0.00000:00:04
sh-chi-us-cpp-wk106.internet-census.org 0.004 0.016 0.00000:00:04
205.210.31.222 0.004 0.016 0.00000:00:03
133.172.132.66.censys-scanner.com 0.066 0.046 0.00000:00:02
o017.scanner.modat.io 0.004 0.014 0.00000:00:00
isvcs01.man.lodz.pl 0.060 0.138 0.00000:00:00
188-240-59-50.infrawat.ch 0.004 0.016 0.00000:00:00
194-50-235-143.infrawat.ch 0.008 0.010 0.00000:00:00
5-226-140-123.infrawat.ch 0.010 0.008 0.00000:00:00
31-14-254-11.infrawat.ch 0.004 0.016 0.00000:00:00
TOTAL: 20 10.266 25.228 0.00000:03:20

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 2880
172.16.2.4 576
80.111.142.213 8
133.172.132.66.censys-scanner.com 6
236.224.132.66.censys-scanner.com 6
sh-ams-nl-cpp-wk104.internet-census.org 4
azpdcs8dhr72.stretchoid.com 4
188-240-59-50.infrawat.ch 2
sh-chi-us-cpp-wk106.internet-census.org 2
sh-chi-us-cpp-wk105.internet-census.org 2
o017.scanner.modat.io 2
zl-laxd-us-cpp-wk111.internet-census.org 2
205.210.31.222 2
31-14-254-11.infrawat.ch 2
sh-chi-us-gp1-wk137c.internet-census.org 2
194-50-235-143.infrawat.ch 2
zl-laxc-us-cpp-wk109.internet-census.org 2
5-226-140-123.infrawat.ch 2
TOTAL: 18 3506

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

SystemConn
236.224.132.66.censys-scanner.com 2
133.172.132.66.censys-scanner.com 2
azpdcs8dhr72.stretchoid.com 2
TOTAL: 3 6

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

CommandCount
EHLO www.censys.io 4
MGLNDD_212.191.2.21_119 2
TOTAL: 2 6

NNRP client timeouts [Top 20]:

SystemConnPeer
236.224.132.66.censys-scanner.com 2 4
5-226-140-123.infrawat.ch 2 2
133.172.132.66.censys-scanner.com 2 4
188-240-59-50.infrawat.ch 2 2
TOTAL: 4 8 18

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 32100.0%
TOTAL: 1 32100.0%

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

NewsgroupCount
1lodman.info 32
TOTAL: 1 32