Daily Usenet report

Jan 14 04:15:01 -- Jan 15 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jan 14 11:51:04 newsfeed nnrpd[1539447]: SERVER perl filter not defined
Jan 14 11:51:04 newsfeed nnrpd[1539447]: SERVER perl filter not defined
Jan 14 15:37:32 newsfeed nnrpd[1566578]: SERVER perl filter not defined
Jan 14 15:37:32 newsfeed nnrpd[1566578]: SERVER perl filter not defined
Jan 14 15:41:16 newsfeed nnrpd[1567061]: SERVER perl filter not defined
Jan 14 15:41:16 newsfeed nnrpd[1567061]: SERVER perl filter not defined
Jan 14 22:00:25 newsfeed pgpverify[1612265]: pgpverify: verification failed
Jan 14 22:00:25 newsfeed pgpverify[1612265]: pgpverify: verification failed
Jan 15 01:40:49 newsfeed nnrpd[1638446]: nms2.man.lodz.pl load 19.75 > 16
Jan 15 01:40:49 newsfeed nnrpd[1638444]: nms2.man.lodz.pl load 19.75 > 16
Jan 15 01:40:49 newsfeed nnrpd[1638446]: nms2.man.lodz.pl load 19.75 > 16
Jan 15 01:40:49 newsfeed nnrpd[1638444]: nms2.man.lodz.pl load 19.75 > 16
Jan 15 01:41:00 newsfeed nnrpd[1638562]: nms2.man.lodz.pl load 16.95 > 16
Jan 15 01:41:00 newsfeed nnrpd[1638562]: nms2.man.lodz.pl load 16.95 > 16

Log entries by program:

Program nameLines%LinesSize%Size
inn 188495 82.7%20.5 MB 84.5%
innd 22220 9.7%2.1 MB 8.7%
nnrpd 15920 7.0%1.5 MB 6.1%
innfeed 1362 0.6%156.9 KB 0.6%
controlchan 24 0.0%5.5 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
TOTAL: 7 228025 100.0%24.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 375834 99.7%
Negative hits 1204 0.3%
Positive hits 112 0.0%
Cache misses 2 0.0%
TOTAL: 4 377152 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.016 0.0%86 0.000 0.186 0.636
article cleanup00:00:00.940 0.0%377038 0.000 0.002 0.008
article logging00:00:04.662 0.0%377162 0.005 0.012 0.021
article parse00:00:06.982 0.0%1302762 0.002 0.005 0.009
article write00:00:15.992 0.0%377010 0.015 0.042 1.725
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:01.130 0.0%1883000 0.000 0.001 0.002
hisgrep/artcncl00:00:00.008 0.0%90 0.000 0.089 0.333
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.202 0.0%378328 0.000 0.032 0.566
history sync00:00:00.032 0.0%758 0.000 0.042 1.000
history write00:00:27.998 0.0%377010 0.027 0.074 0.345
idle47:49:32.568 99.6%1591270 38.268 108.198 277.887
nntp read00:00:10.398 0.0%1252632 0.006 0.008 0.013
overview write00:00:00.598 0.0%377010 0.000 0.002 0.006
perl filter00:04:01.286 0.1%377010 0.383 0.640 15.002
python filter00:00:00.052 0.0%377016 0.000 0.000 0.001
site send00:00:05.228 0.0%771892 0.002 0.007 0.011
TOTAL: 48:01:48.01847:55:00.092 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.036 0.0%17830 0.000 0.002 0.029
article prepare00:00:00.000 0.0%1112 0.000 0.000 0.000
article read00:00:00.008 0.0%278 0.000 0.029 1.000
backlog stats00:00:00.012 0.0%96222 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.348 0.0%48344 0.000 0.007 0.033
data write00:00:00.726 0.0%29710 0.000 0.024 0.082
idle47:59:25.146100.0%96222 935.508 1795.485 4018.573
status file00:00:30.158 0.0%364 0.000 82.852 7492.000
TOTAL: 47:59:57.15847:59:56.434100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:13:51.864 93.5%8896 1.000 93.510 21359.625
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.282 0.0%30266 0.000 0.009 0.333
readart00:00:00.006 0.0%32 0.000 0.188 0.300
TOTAL: 00:14:50.00200:13:52.152 93.5%----

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
newgroups-request@fido7.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 106 377062 377042 0 20 99%76:32:40
2news.icm.edu.pl 64 112 20 84 8 17%13:12:02
3localhost 8 6 6 0 0 100%00:00:00
TOTAL: 3 178 377180 377068 84 28 99%89:44:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.7 GB388.9 KB0.0 KB3.7 GB 99%10.4 KB
2news.icm.edu.pl388.6 KB116.5 KB0.0 KB505.1 KB 76%18.0 KB
3localhost8.1 KB0.0 KB0.0 KB8.1 KB100%1.3 KB
TOTAL: 33.7 GB505.5 KB0.0 KB3.7 GB 99%10.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 14 04:15:01 - 04:59:59 3910 2.1% 1.4535.7 MB 1.9% 13.56
Jan 14 05:00:00 - 05:59:59 5249 2.8% 1.4656.9 MB 3.0% 16.19
Jan 14 06:00:00 - 06:59:59 5314 2.8% 1.4851.1 MB 2.7% 14.55
Jan 14 07:00:00 - 07:59:59 5461 2.9% 1.5255.9 MB 2.9% 15.91
Jan 14 08:00:00 - 08:59:59 8155 4.3% 2.2770.0 MB 3.7% 19.91
Jan 14 09:00:00 - 09:59:59 7540 4.0% 2.0980.2 MB 4.2% 22.82
Jan 14 10:00:00 - 10:59:59 5959 3.2% 1.6666.4 MB 3.5% 18.89
Jan 14 11:00:00 - 11:59:59 6290 3.3% 1.7564.4 MB 3.4% 18.33
Jan 14 12:00:00 - 12:59:59 5194 2.8% 1.4454.6 MB 2.9% 15.53
Jan 14 13:00:00 - 13:59:59 6780 3.6% 1.8878.8 MB 4.1% 22.41
Jan 14 14:00:00 - 14:59:59 8236 4.4% 2.2994.5 MB 4.9% 26.88
Jan 14 15:00:00 - 15:59:59 8500 4.5% 2.36101.7 MB 5.3% 28.93
Jan 14 16:00:00 - 16:59:59 9567 5.1% 2.6694.5 MB 4.9% 26.87
Jan 14 17:00:00 - 17:59:59 10146 5.4% 2.8298.6 MB 5.2% 28.05
Jan 14 18:00:00 - 18:59:59 7918 4.2% 2.2087.6 MB 4.6% 24.92
Jan 14 19:00:00 - 19:59:59 6059 3.2% 1.6885.0 MB 4.4% 24.19
Jan 14 20:00:00 - 20:59:59 6533 3.5% 1.8181.8 MB 4.3% 23.27
Jan 14 21:00:00 - 21:59:59 9238 4.9% 2.5795.4 MB 5.0% 27.15
Jan 14 22:00:00 - 22:59:59 10340 5.5% 2.87107.0 MB 5.6% 30.43
Jan 14 23:00:00 - 23:59:59 14611 7.8% 4.06117.4 MB 6.1% 33.39
Jan 15 00:00:00 - 00:59:59 16114 8.6% 4.48141.1 MB 7.4% 40.13
Jan 15 01:00:00 - 01:59:59 6067 3.2% 1.6954.9 MB 2.9% 15.63
Jan 15 02:00:00 - 02:59:59 6567 3.5% 1.8264.0 MB 3.3% 18.22
Jan 15 03:00:00 - 03:59:59 7206 3.8% 2.0062.0 MB 3.2% 17.62
Jan 15 04:00:00 - 04:15:02 1463 0.8% 1.6214.3 MB 0.7% 16.27
TOTAL: 24:00:01 188417 100.0% 2.181.9 GB 100.0% 22.69
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 72 0 0 10 0 0 0 0 62
2news.icm.edu.pl 4 0 0 4 0 0 0 0 0
TOTAL: 2 76 0 0 14 0 0 0 0 62

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 31914 238 17526 40 0 8 0%47:59:14
2poznan 40 0 20 0 0 0 0%03:33:20
TOTAL: 2 31954 238 17546 40 0 8 0%51:32:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm394.9 KB804.4 KB1.2 MB0.0 KB/s4.3 KB47:59:14
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:33:20
TOTAL: 2394.9 KB804.4 KB1.2 MB0.0 KB/s4.3 KB51:32:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 12 3233.5 KB 4 0 000:00:25
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 2 18 3233.5 KB 4 6 000:14:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 606 3233.5 KB 4 0 000:12:42
2*.man.lodz.pl2886 00.0 KB 0 6 000:00:40
3*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
5*.stretchoid.com 4 00.0 KB 0 0 000:00:20
6*.ch1.censys-scanner.com 12 00.0 KB 0 0 000:00:16
7*.internet-census.org 14 00.0 KB 0 0 000:00:47
TOTAL: 73526 3233.5 KB 4 6 000:14:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
176.105.139.10 0.004 0.028 0.00000:11:23
172.16.2.4 1.264 2.880 0.00000:00:42
nms2.man.lodz.pl 5.906 13.662 0.00000:00:39
66.61.98.95 0.036 0.056 0.00000:00:25
zl-amsc-nl-gp1-wk146c.internet-census.org 0.004 0.010 0.00000:00:20
azpdsggszjno.stretchoid.com 0.008 0.020 0.00000:00:20
zl-laxd-us-cpp-wk110.internet-census.org 0.008 0.020 0.00000:00:09
sh-chi-us-cpp-wk106.internet-census.org 0.010 0.024 0.00000:00:08
scanner-202.ch1.censys-scanner.com 0.076 0.024 0.00000:00:08
sh-ams-nl-cpp-wk103.internet-census.org 0.002 0.026 0.00000:00:08
scanner-07.ch1.censys-scanner.com 0.074 0.026 0.00000:00:07
80.111.142.213 0.020 0.040 0.00000:00:06
supporting.monitoring.internet-measurement.com 0.006 0.010 0.00000:00:03
147.185.133.215 0.008 0.006 0.00000:00:03
205.210.31.42 0.004 0.010 0.00000:00:00
198.235.24.197 0.004 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.020 0.032 0.00000:00:00
o302.scanner.modat.io 0.004 0.012 0.00000:00:00
TOTAL: 18 7.458 16.896 0.00000:14:50

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 2880
172.16.2.4 576
80.111.142.213 8
scanner-07.ch1.censys-scanner.com 6
scanner-202.ch1.censys-scanner.com 6
azpdsggszjno.stretchoid.com 4
zl-laxd-us-cpp-wk110.internet-census.org 4
sh-ams-nl-cpp-wk103.internet-census.org 4
sh-chi-us-cpp-wk106.internet-census.org 4
176.105.139.10 4
205.210.31.42 2
198.235.24.197 2
supporting.monitoring.internet-measurement.com 2
o302.scanner.modat.io 2
147.185.133.215 2
zl-amsc-nl-gp1-wk146c.internet-census.org 2
TOTAL: 16 3508

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

SystemConn
147.185.133.215 8
scanner-07.ch1.censys-scanner.com 2
scanner-202.ch1.censys-scanner.com 2
azpdsggszjno.stretchoid.com 2
TOTAL: 4 14

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-202.ch1.censys-scanner.com 2 4
scanner-07.ch1.censys-scanner.com 2 4
TOTAL: 2 4 12

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