Daily Usenet report

May 1 04:15:01 -- May 2 04:15:02

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

May 1 11:30:02 newsfeed pgpverify[452992]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[452992]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453001]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453001]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453010]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453010]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453019]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453019]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453028]: pgpverify: verification failed
May 1 11:30:02 newsfeed pgpverify[453028]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454752]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454752]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454761]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454761]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454770]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454770]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454779]: pgpverify: verification failed
May 1 11:45:02 newsfeed pgpverify[454779]: pgpverify: verification failed
May 2 00:45:01 newsfeed pgpverify[85950]: pgpverify: verification failed
May 2 00:45:01 newsfeed pgpverify[85950]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 145013 79.7%16.2 MB 82.5%
innd 19646 10.8%1.8 MB 9.4%
nnrpd 15930 8.8%1.4 MB 7.3%
innfeed 1298 0.7%150.3 KB 0.7%
controlchan 24 0.0%2.4 KB 0.0%
pgpverify 20 0.0%2.0 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 181933 100.0%19.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 287204 99.7%
Negative hits 622 0.2%
Positive hits 174 0.1%
Cache misses 10 0.0%
TOTAL: 4 288010 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.048 0.0%160 0.000 0.300 3.000
article cleanup00:00:00.866 0.0%289730 0.000 0.003 0.011
article logging00:00:36.354 0.0%289806 0.005 0.125 17.291
article parse00:00:04.994 0.0%874696 0.003 0.006 0.009
article write00:00:15.914 0.0%289724 0.018 0.055 1.669
artlog/artcncl00:00:00.002 0.0%38 0.000 0.053 1.000
data move00:00:00.552 0.0%1238172 0.000 0.000 0.002
hisgrep/artcncl00:00:00.012 0.0%198 0.000 0.061 1.000
hishave/artcncl00:00:00.000 0.0%38 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:22.336 0.0%290492 0.001 0.077 0.674
history sync00:00:00.016 0.0%716 0.000 0.022 0.500
history write00:00:49.942 0.0%289724 0.053 0.172 0.768
idle47:33:25.574 99.7%1092914 57.385 156.651 294.667
nntp read00:00:07.850 0.0%836228 0.006 0.009 0.015
overview write00:00:00.406 0.0%289724 0.000 0.001 0.005
perl filter00:02:29.058 0.1%289724 0.391 0.514 0.691
python filter00:00:00.068 0.0%289724 0.000 0.000 0.002
site send00:00:03.822 0.0%592748 0.003 0.006 0.015
TOTAL: 47:41:30.85247:38:17.814 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.010 0.0%13262 0.000 0.001 0.023
article prepare00:00:00.000 0.0%728 0.000 0.000 0.000
article read00:00:00.002 0.0%182 0.000 0.011 0.500
backlog stats00:00:00.028 0.0%79592 0.000 0.000 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.342 0.0%37420 0.000 0.009 0.038
data write00:00:00.792 0.0%24008 0.000 0.033 0.152
idle47:39:33.484100.0%79592 897.237 2155.662 6468.022
status file00:00:00.200 0.0%346 0.000 0.578 4.000
TOTAL: 47:39:35.71647:39:34.858100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:27.656 85.4%8870 1.000 23.411 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.212 0.1%30156 0.000 0.007 0.500
readart00:00:00.006 0.0%20 0.000 0.300 0.375
TOTAL: 00:04:03.06200:03:27.874 85.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
moderator@dana.de0002000
TOTAL0002000

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 128 289478 289470 2 6 99%62:57:38
2news.icm.edu.pl 80 144 6 138 0 4%16:07:58
3localhost 2 0 0 0 0 0%00:00:00
TOTAL: 3 210 289622 289476 140 6 99%79:05:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.5 GB51.3 KB0.0 KB2.5 GB 99%9.1 KB
2news.icm.edu.pl324.3 KB0.0 KB0.0 KB324.3 KB100%54.1 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 32.5 GB51.3 KB0.0 KB2.5 GB 99%9.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 1 04:15:01 - 04:59:59 6631 4.6% 2.4648.6 MB 3.8% 18.45
May 1 05:00:00 - 05:59:59 5052 3.5% 1.4043.9 MB 3.4% 12.50
May 1 06:00:00 - 06:59:59 5509 3.8% 1.5344.3 MB 3.5% 12.59
May 1 07:00:00 - 07:59:59 4666 3.2% 1.3047.8 MB 3.7% 13.60
May 1 08:00:00 - 08:59:59 7111 4.9% 1.9858.5 MB 4.6% 16.63
May 1 09:00:00 - 09:59:59 8241 5.7% 2.2965.2 MB 5.1% 18.54
May 1 10:00:00 - 10:59:59 6599 4.6% 1.8360.2 MB 4.7% 17.12
May 1 11:00:00 - 11:59:59 6454 4.5% 1.7961.5 MB 4.8% 17.48
May 1 12:00:00 - 12:59:59 5198 3.6% 1.4451.2 MB 4.0% 14.56
May 1 13:00:00 - 13:59:59 6922 4.8% 1.9254.1 MB 4.2% 15.38
May 1 14:00:00 - 14:59:59 5612 3.9% 1.5653.0 MB 4.1% 15.08
May 1 15:00:00 - 15:59:59 8315 5.7% 2.3161.4 MB 4.8% 17.46
May 1 16:00:00 - 16:59:59 5853 4.0% 1.6355.3 MB 4.3% 15.73
May 1 17:00:00 - 17:59:59 8523 5.9% 2.3771.7 MB 5.6% 20.39
May 1 18:00:00 - 18:59:59 6250 4.3% 1.7456.3 MB 4.4% 16.01
May 1 19:00:00 - 19:59:59 4889 3.4% 1.3645.0 MB 3.5% 12.80
May 1 20:00:00 - 20:59:59 4446 3.1% 1.2443.0 MB 3.4% 12.23
May 1 21:00:00 - 21:59:59 4013 2.8% 1.1141.2 MB 3.2% 11.72
May 1 22:00:00 - 22:59:59 6986 4.8% 1.9481.0 MB 6.3% 23.05
May 1 23:00:00 - 23:59:59 4551 3.1% 1.2648.1 MB 3.7% 13.68
May 2 00:00:00 - 00:59:59 4767 3.3% 1.3242.8 MB 3.3% 12.17
May 2 01:00:00 - 01:59:59 6280 4.3% 1.7446.0 MB 3.6% 13.08
May 2 02:00:00 - 02:59:59 5493 3.8% 1.5346.1 MB 3.6% 13.10
May 2 03:00:00 - 03:59:59 5024 3.5% 1.4044.4 MB 3.5% 12.64
May 2 04:00:00 - 04:15:02 1566 1.1% 1.7412.1 MB 0.9% 13.79
TOTAL: 24:00:01 144951 100.0% 1.681.3 GB 100.0% 15.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 43 0 0 3 0 0 0 0 40
TOTAL: 1 43 0 0 3 0 0 0 0 40

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 24632 174 13168 10 0 0 0%47:52:40
2poznan 12 0 8 0 0 0 0%02:00:10
TOTAL: 2 24644 174 13176 10 0 0 0%49:52:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm712.5 KB37.9 KB750.4 KB0.0 KB/s4.1 KB47:52:40
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:00:10
TOTAL: 2712.5 KB37.9 KB750.4 KB0.0 KB/s4.1 KB49:52:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 32 1631.2 KB 2 0 000:00:37
2172.16.2.4 576 46.8 KB 2 0 000:00:40
TOTAL: 2 608 2038.0 KB 4 0 000:04:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 628 2038.0 KB 4 0 000:02:23
2*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
3*.internet-census.org 14 00.0 KB 0 0 000:00:46
4*.man.lodz.pl2876 00.0 KB 0 0 000:00:29
5*.stretchoid.com 4 00.0 KB 0 0 000:00:20
TOTAL: 53524 2038.0 KB 4 0 000:04:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
80.111.142.213 0.020 0.046 0.00000:00:41
172.16.2.4 1.476 2.836 0.00000:00:40
66.61.98.95 0.074 0.160 0.00000:00:37
nms2.man.lodz.pl 7.058 13.050 0.00000:00:29
47.254.46.95 0.016 0.038 0.00000:00:24
azpdesec06bz.stretchoid.com 0.010 0.018 0.00000:00:20
zl-amsc-nl-gp1-wk128c.internet-census.org 0.008 0.008 0.00000:00:20
zl-laxd-us-cpp-wk110.internet-census.org 0.004 0.030 0.00000:00:09
sh-ams-nl-cpp-wk103.internet-census.org 0.006 0.022 0.00000:00:08
sh-chi-us-cpp-wk105.internet-census.org 0.004 0.012 0.00000:00:04
sh-chi-us-cpp-wk107.internet-census.org 0.004 0.010 0.00000:00:04
stable.monitoring.internet-measurement.com 0.002 0.012 0.00000:00:03
69.5.169.200 0.008 0.006 0.00000:00:00
31.14.254.109 0.006 0.008 0.00000:00:00
TOTAL: 14 8.696 16.256 0.00000:04:04

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 2876
80.111.142.213 8
47.254.46.95 8
sh-ams-nl-cpp-wk103.internet-census.org 4
zl-laxd-us-cpp-wk110.internet-census.org 4
azpdesec06bz.stretchoid.com 4
31.14.254.109 2
sh-chi-us-cpp-wk105.internet-census.org 2
sh-chi-us-cpp-wk107.internet-census.org 2
zl-amsc-nl-gp1-wk128c.internet-census.org 2
stable.monitoring.internet-measurement.com 2
69.5.169.200 2
TOTAL: 12 2916

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

SystemConn
47.254.46.95 14
azpdesec06bz.stretchoid.com 2
TOTAL: 2 16

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

CommandCount
#023#001#023#002#023#003#001 2
À#024 2
Accept: */* 2
GET / HTTP/1.1 2
Host: 212.191.2.21:119 2
User-Agent: curl/7.64.1 2
#026#003#001 2
MGLNDD_212.191.2.21_119 2
TOTAL: 8 16

NNRP client timeouts [Top 20]:

SystemConnPeer
47.254.46.95 6 8
69.5.169.200 2 2
TOTAL: 2 8 12

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 16 80.0%
2pl 4 20.0%
TOTAL: 2 20100.0%

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

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