Daily Usenet report

Apr 18 04:15:01 -- Apr 19 04:15:01

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Apr 18 09:56:45 newsfeed nnrpd[666640]: SERVER perl filter not defined
Apr 18 09:56:45 newsfeed nnrpd[666640]: SERVER perl filter not defined
Apr 18 09:57:55 newsfeed nnrpd[667043]: SERVER perl filter not defined
Apr 18 09:57:55 newsfeed nnrpd[667043]: SERVER perl filter not defined
Apr 18 10:30:01 newsfeed pgpverify[670731]: pgpverify: verification failed
Apr 18 10:30:01 newsfeed pgpverify[670731]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670740]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670740]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670749]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670749]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670758]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670758]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670767]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670767]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670776]: pgpverify: verification failed
Apr 18 10:30:02 newsfeed pgpverify[670776]: pgpverify: verification failed
Apr 18 20:43:30 newsfeed nnrpd[745464]: SERVER perl filter not defined
Apr 18 20:43:30 newsfeed nnrpd[745464]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 431760 91.5%45.7 MB 92.0%
innd 22638 4.8%2.3 MB 4.7%
nnrpd 16044 3.4%1.5 MB 3.1%
innfeed 1262 0.3%144.6 KB 0.3%
controlchan 14 0.0%1.4 KB 0.0%
pgpverify 12 0.0%1.2 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 471732 100.0%49.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 858714 99.9%
Negative hits 712 0.1%
Positive hits 108 0.0%
Cache misses 8 0.0%
TOTAL: 4 859542 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.020 0.0%52 0.000 0.385 5.000
article cleanup00:00:02.094 0.0%864204 0.000 0.002 0.006
article logging00:00:10.358 0.0%864280 0.007 0.012 0.022
article parse00:00:07.348 0.0%1732326 0.002 0.004 0.008
article write00:00:45.648 0.0%864184 0.015 0.053 3.855
artlog/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
data move00:00:01.164 0.0%1887602 0.000 0.001 0.004
hisgrep/artcncl00:00:00.006 0.0%66 0.000 0.091 2.000
hishave/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.860 0.0%865020 0.001 0.003 0.016
history sync00:00:00.022 0.0%618 0.000 0.036 0.500
history write00:01:11.474 0.0%864196 0.021 0.083 3.507
idle47:47:16.410 99.5%2249700 48.524 76.471 162.289
nntp read00:00:13.048 0.0%1503678 0.004 0.009 0.016
overview write00:00:01.234 0.0%864184 0.000 0.001 0.004
perl filter00:05:17.872 0.2%864196 0.278 0.368 0.673
python filter00:00:00.172 0.0%864202 0.000 0.000 0.001
site send00:00:10.838 0.0%1741472 0.004 0.006 0.010
TOTAL: 48:00:44.28647:55:20.568 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.032 0.0%13060 0.000 0.002 0.062
article prepare00:00:00.000 0.0%568 0.000 0.000 0.000
article read00:00:00.002 0.0%142 0.000 0.014 1.000
backlog stats00:00:00.020 0.0%79690 0.000 0.000 0.013
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.258 0.0%37170 0.000 0.007 0.048
data write00:00:00.772 0.0%23948 0.000 0.032 0.136
idle47:57:19.862100.0%79690 959.767 2166.393 8338.972
status file00:00:00.186 0.0%328 0.000 0.567 4.000
TOTAL: 47:57:21.95847:57:21.132100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:42.934 74.2%8966 0.000 18.172 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.204 0.1%30290 0.000 0.007 0.500
readart00:00:00.000 0.0%16 0.000 0.000 0.000
TOTAL: 00:03:39.45400:02:43.138 74.3%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de0001200
TOTAL0001200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 110 863318 863298 2 18 99%62:23:42
2news.icm.edu.pl 74 106 10 96 0 9%13:58:36
3localhost 8 6 6 0 0 100%00:00:00
TOTAL: 3 192 863430 863314 98 18 99%76:22:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.2 GB48.6 KB39.3 KB3.2 GB 99%3.8 KB
2news.icm.edu.pl293.1 KB0.0 KB0.0 KB293.1 KB100%29.3 KB
3localhost9.6 KB0.0 KB0.0 KB9.6 KB100%1.6 KB
TOTAL: 33.2 GB48.6 KB39.3 KB3.2 GB 99%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 18 04:15:01 - 04:59:59 12748 3.0% 4.7237.8 MB 2.3% 14.34
Apr 18 05:00:00 - 05:59:59 15541 3.6% 4.3255.5 MB 3.4% 15.78
Apr 18 06:00:00 - 06:59:59 16991 3.9% 4.7256.8 MB 3.5% 16.17
Apr 18 07:00:00 - 07:59:59 16008 3.7% 4.4567.1 MB 4.2% 19.08
Apr 18 08:00:00 - 08:59:59 17885 4.1% 4.9778.6 MB 4.9% 22.36
Apr 18 09:00:00 - 09:59:59 18583 4.3% 5.1670.8 MB 4.4% 20.15
Apr 18 10:00:00 - 10:59:59 16710 3.9% 4.6477.4 MB 4.8% 22.00
Apr 18 11:00:00 - 11:59:59 14645 3.4% 4.0763.4 MB 3.9% 18.04
Apr 18 12:00:00 - 12:59:59 16256 3.8% 4.5271.9 MB 4.5% 20.46
Apr 18 13:00:00 - 13:59:59 17910 4.1% 4.9786.0 MB 5.3% 24.47
Apr 18 14:00:00 - 14:59:59 19202 4.4% 5.3364.6 MB 4.0% 18.38
Apr 18 15:00:00 - 15:59:59 22114 5.1% 6.1470.9 MB 4.4% 20.17
Apr 18 16:00:00 - 16:59:59 21710 5.0% 6.0375.3 MB 4.7% 21.42
Apr 18 17:00:00 - 17:59:59 19295 4.5% 5.3665.0 MB 4.0% 18.50
Apr 18 18:00:00 - 18:59:59 18730 4.3% 5.2069.8 MB 4.3% 19.85
Apr 18 19:00:00 - 19:59:59 20155 4.7% 5.6090.7 MB 5.6% 25.80
Apr 18 20:00:00 - 20:59:59 18134 4.2% 5.0469.5 MB 4.3% 19.77
Apr 18 21:00:00 - 21:59:59 19686 4.6% 5.4772.2 MB 4.5% 20.54
Apr 18 22:00:00 - 22:59:59 15331 3.6% 4.2654.4 MB 3.4% 15.47
Apr 18 23:00:00 - 23:59:59 21266 4.9% 5.9163.1 MB 3.9% 17.96
Apr 19 00:00:00 - 00:59:59 23456 5.4% 6.5266.4 MB 4.1% 18.89
Apr 19 01:00:00 - 01:59:59 18565 4.3% 5.1666.6 MB 4.1% 18.94
Apr 19 02:00:00 - 02:59:59 16445 3.8% 4.5754.6 MB 3.4% 15.54
Apr 19 03:00:00 - 03:59:59 11321 2.6% 3.1456.1 MB 3.5% 15.96
Apr 19 04:00:00 - 04:15:01 3019 0.7% 3.3511.1 MB 0.7% 12.66
TOTAL: 24:00:00 431706 100.0% 5.001.6 GB 100.0% 19.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 47 0 0 3 0 0 0 0 44
TOTAL: 1 47 0 0 3 0 0 0 0 44

INND Perl filter [Top 20]:

ReasonCount
EMP (fsl) 12
TOTAL: 1 12

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 24258 136 12910 6 0 0 0%47:59:56
2poznan 12 0 8 0 0 0 0%01:20:26
TOTAL: 2 24270 136 12918 6 0 0 0%49:20:22
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm458.6 KB8.3 KB466.9 KB0.0 KB/s3.3 KB47:59:56
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:20:26
TOTAL: 2458.6 KB8.3 KB466.9 KB0.0 KB/s3.3 KB49:20:22
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 48 89.4 KB 2 0 000:00:50
2172.16.2.4 576 813.4 KB 2 0 000:00:33
3isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 3 630 1622.8 KB 4 6 000:03:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 636 1622.8 KB 4 0 000:01:31
2*.172.132.66.censys-scanner.com 2 00.0 KB 0 0 000:00:07
3*.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
5*.internet-census.org 14 00.0 KB 0 0 000:00:47
6*.stretchoid.com 4 00.0 KB 0 0 000:00:20
7*.man.lodz.pl2886 00.0 KB 0 6 000:00:49
TOTAL: 73546 1622.8 KB 4 6 000:03:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
66.61.98.95 0.134 0.222 0.00000:00:50
nms1.man.lodz.pl 6.650 14.854 0.00000:00:49
172.16.2.4 1.374 3.138 0.00000:00:33
zl-dala-us-gp1-wk120b.internet-census.org 0.006 0.008 0.00000:00:21
azpdesxyt5ly.stretchoid.com 0.010 0.020 0.00000:00:20
sh-chi-us-cpp-wk105.internet-census.org 0.008 0.018 0.00000:00:08
187.172.132.66.censys-scanner.com 0.064 0.014 0.00000:00:07
80.111.142.213 0.044 0.044 0.00000:00:06
zl-laxd-us-cpp-wk110.internet-census.org 0.004 0.010 0.00000:00:04
zl-laxc-us-cpp-wk109.internet-census.org 0.006 0.006 0.00000:00:04
sh-ams-nl-cpp-wk101.internet-census.org 0.000 0.014 0.00000:00:04
sh-ams-nl-cpp-wk104.internet-census.org 0.002 0.012 0.00000:00:04
stable.monitoring.internet-measurement.com 0.006 0.008 0.00000:00:03
205.210.31.248 0.004 0.010 0.00000:00:00
136.149.216.162.bc.googleusercontent.com 0.002 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.022 0.034 0.00000:00:00
195.140.214.25 0.006 0.006 0.00000:00:00
TOTAL: 17 8.342 18.430 0.00000:03:40

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
80.111.142.213 8
azpdesxyt5ly.stretchoid.com 4
sh-chi-us-cpp-wk105.internet-census.org 4
187.172.132.66.censys-scanner.com 2
zl-laxc-us-cpp-wk109.internet-census.org 2
195.140.214.25 2
stable.monitoring.internet-measurement.com 2
205.210.31.248 2
sh-ams-nl-cpp-wk104.internet-census.org 2
zl-laxd-us-cpp-wk110.internet-census.org 2
136.149.216.162.bc.googleusercontent.com 2
zl-dala-us-gp1-wk120b.internet-census.org 2
sh-ams-nl-cpp-wk101.internet-census.org 2
TOTAL: 14 2916

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

SystemConn
136.149.216.162.bc.googleusercontent.com 8
azpdesxyt5ly.stretchoid.com 2
187.172.132.66.censys-scanner.com 2
TOTAL: 3 12

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

CommandCount
GET / HTTP/1.1 2
MGLNDD_212.191.2.21_119 2
Host: 212.191.2.21:119 2
EHLO www.censys.io 2
Accept-Encoding: gzip 2
User-Agent: Hello from Palo Alto Network... 2
TOTAL: 6 12

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 8 50.0%
2pl 8 50.0%
TOTAL: 2 16100.0%

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

NewsgroupCount
1lodman.info 8
2pl.comp.os.ms-windows.winnt 8
TOTAL: 2 16