Daily Usenet report

Dec 31 04:15:01 -- Jan 1 04:15:01

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Dec 31 11:01:07 newsfeed nnrpd[3296685]: SERVER perl filter not defined
Dec 31 11:01:07 newsfeed nnrpd[3296685]: SERVER perl filter not defined
Dec 31 11:32:03 newsfeed nnrpd[3300264]: SERVER perl filter not defined
Dec 31 11:32:03 newsfeed nnrpd[3300264]: SERVER perl filter not defined
Dec 31 11:33:24 newsfeed nnrpd[3300529]: SERVER perl filter not defined
Dec 31 11:33:24 newsfeed nnrpd[3300529]: SERVER perl filter not defined
Dec 31 13:25:30 newsfeed nnrpd[3313940]: SERVER perl filter not defined
Dec 31 13:25:30 newsfeed nnrpd[3313940]: SERVER perl filter not defined
Dec 31 13:26:54 newsfeed nnrpd[3313952]: SERVER perl filter not defined
Dec 31 13:26:54 newsfeed nnrpd[3313952]: SERVER perl filter not defined
Dec 31 15:12:52 newsfeed nnrpd[3326659]: SERVER perl filter not defined
Dec 31 15:12:52 newsfeed nnrpd[3326659]: SERVER perl filter not defined
Dec 31 16:01:27 newsfeed nnrpd[3332428]: SERVER perl filter not defined
Dec 31 16:01:27 newsfeed nnrpd[3332428]: SERVER perl filter not defined
Jan 1 01:04:02 newsfeed pgpverify[3397263]: pgpverify: verification failed
Jan 1 01:04:02 newsfeed pgpverify[3397263]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 209481 83.6%22.9 MB 85.2%
innd 23098 9.2%2.2 MB 8.3%
nnrpd 16430 6.6%1.6 MB 5.8%
innfeed 1490 0.6%173.7 KB 0.6%
controlchan 44 0.0%10.8 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 250547 100.0%26.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 417138 99.7%
Negative hits 836 0.2%
Positive hits 224 0.1%
Cache misses 4 0.0%
TOTAL: 4 418202 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.018 0.0%84 0.000 0.214 1.500
article cleanup00:00:01.152 0.0%419612 0.000 0.003 0.007
article logging00:00:05.174 0.0%419778 0.007 0.012 0.020
article parse00:00:06.730 0.0%1311234 0.003 0.005 0.008
article write00:00:13.092 0.0%419578 0.014 0.031 0.225
artlog/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:01.158 0.0%1806650 0.000 0.001 0.002
hisgrep/artcncl00:00:00.004 0.0%94 0.000 0.043 0.333
hishave/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.308 0.0%420634 0.000 0.003 0.010
history sync00:00:00.022 0.0%744 0.000 0.030 0.500
history write00:00:26.566 0.0%419580 0.032 0.063 0.176
idle47:52:14.550 99.7%1612820 63.289 106.853 230.904
nntp read00:00:10.424 0.0%1242418 0.005 0.008 0.013
overview write00:00:00.604 0.0%419578 0.000 0.001 0.006
perl filter00:03:30.844 0.1%419580 0.385 0.503 0.663
python filter00:00:00.080 0.0%419594 0.000 0.000 0.002
site send00:00:05.954 0.0%858092 0.002 0.007 0.011
TOTAL: 48:01:43.97047:56:57.680 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%18920 0.000 0.001 0.040
article prepare00:00:00.000 0.0%1904 0.000 0.000 0.000
article read00:00:00.012 0.0%476 0.000 0.025 1.000
backlog stats00:00:00.022 0.0%102992 0.000 0.000 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.302 0.0%51808 0.000 0.006 0.026
data write00:00:00.814 0.0%31898 0.000 0.026 0.068
idle47:57:31.562100.0%102992 548.523 1676.359 4438.596
status file00:00:00.296 0.0%414 0.000 0.715 4.000
TOTAL: 47:57:33.88247:57:33.034100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:01.540 79.7%9134 0.000 19.875 10024.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.354 0.2%30694 0.000 0.012 0.500
readart00:00:00.000 0.0%28 0.000 0.000 0.000
TOTAL: 00:03:47.89400:03:01.894 79.8%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 296
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 384

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org002002
us-control@lists.killfile.org000200
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 186 418606 418566 12 28 99%76:11:56
2news.icm.edu.pl 110 224 40 178 6 17%28:11:02
3localhost 16 14 14 0 0 100%00:00:00
TOTAL: 3 312 418844 418620 190 34 99%104:22:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.4 GB902.7 KB0.0 KB3.4 GB 99%8.6 KB
2news.icm.edu.pl1.9 MB142.5 KB36.7 KB2.0 MB 91%45.1 KB
3localhost19.6 KB0.0 KB0.0 KB19.6 KB100%1.4 KB
TOTAL: 33.5 GB1.0 MB36.7 KB3.5 GB 99%8.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 31 04:15:01 - 04:59:59 4458 2.1% 1.6531.8 MB 1.8% 12.05
Dec 31 05:00:00 - 05:59:59 5527 2.6% 1.5439.4 MB 2.2% 11.20
Dec 31 06:00:00 - 06:59:59 5905 2.8% 1.6448.1 MB 2.7% 13.68
Dec 31 07:00:00 - 07:59:59 6637 3.2% 1.8449.5 MB 2.8% 14.07
Dec 31 08:00:00 - 08:59:59 7085 3.4% 1.9759.8 MB 3.4% 17.02
Dec 31 09:00:00 - 09:59:59 10890 5.2% 3.0284.7 MB 4.8% 24.11
Dec 31 10:00:00 - 10:59:59 8424 4.0% 2.3478.6 MB 4.4% 22.35
Dec 31 11:00:00 - 11:59:59 8379 4.0% 2.3368.9 MB 3.9% 19.61
Dec 31 12:00:00 - 12:59:59 10219 4.9% 2.8479.3 MB 4.5% 22.55
Dec 31 13:00:00 - 13:59:59 8674 4.1% 2.4180.1 MB 4.5% 22.78
Dec 31 14:00:00 - 14:59:59 8308 4.0% 2.3189.8 MB 5.1% 25.53
Dec 31 15:00:00 - 15:59:59 9950 4.8% 2.7669.3 MB 3.9% 19.72
Dec 31 16:00:00 - 16:59:59 8104 3.9% 2.2562.8 MB 3.6% 17.87
Dec 31 17:00:00 - 17:59:59 9864 4.7% 2.7495.0 MB 5.4% 27.03
Dec 31 18:00:00 - 18:59:59 9964 4.8% 2.7794.7 MB 5.4% 26.95
Dec 31 19:00:00 - 19:59:59 8207 3.9% 2.2868.3 MB 3.9% 19.42
Dec 31 20:00:00 - 20:59:59 7561 3.6% 2.1067.6 MB 3.8% 19.23
Dec 31 21:00:00 - 21:59:59 10268 4.9% 2.8577.8 MB 4.4% 22.12
Dec 31 22:00:00 - 22:59:59 11469 5.5% 3.1999.6 MB 5.6% 28.33
Dec 31 23:00:00 - 23:59:59 10282 4.9% 2.8682.1 MB 4.6% 23.35
Jan 1 00:00:00 - 00:59:59 11037 5.3% 3.0789.4 MB 5.1% 25.44
Jan 1 01:00:00 - 01:59:59 11124 5.3% 3.09102.4 MB 5.8% 29.12
Jan 1 02:00:00 - 02:59:59 8203 3.9% 2.2866.0 MB 3.7% 18.77
Jan 1 03:00:00 - 03:59:59 7572 3.6% 2.1070.1 MB 4.0% 19.94
Jan 1 04:00:00 - 04:15:01 1265 0.6% 1.4012.8 MB 0.7% 14.49
TOTAL: 24:00:00 209376 100.0% 2.421.7 GB 100.0% 20.95
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 97 0 0 14 0 0 0 0 83
2news.icm.edu.pl 3 0 0 2 0 0 0 0 1
TOTAL: 2 100 0 0 16 0 0 0 0 84

INND Perl filter [Top 20]:

ReasonCount
Scoring filter (8) 2
TOTAL: 1 2

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 34436 458 18408 18 0 0 1%47:59:52
2poznan 70 0 40 0 0 0 0%06:34:04
TOTAL: 2 34506 458 18448 18 0 0 1%54:33:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm915.1 KB65.5 KB980.6 KB0.0 KB/s2.1 KB47:59:52
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s006:34:04
TOTAL: 2915.1 KB65.5 KB980.6 KB0.0 KB/s2.1 KB54:33:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
166.61.98.95 40 2828.9 KB 8 0 000:00:59
2isvcs01.man.lodz.pl 14 00.0 KB 0 14 000:00:00
TOTAL: 2 54 2828.9 KB 8 14 000:03:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 636 2828.9 KB 8 0 000:01:51
2*.man.lodz.pl2894 00.0 KB 0 14 000:00:24
3*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
4*.academyforinternetresearch.org 126 00.0 KB 0 0 000:01:13
5*.stretchoid.com 4 00.0 KB 0 0 000:00:20
TOTAL: 53662 2828.9 KB 8 14 000:03:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
prod50client01.academyforinternetresearch.org 3.770 0.684 0.00000:01:13
66.61.98.95 0.092 0.208 0.00000:00:59
172.16.2.4 1.190 2.944 0.00000:00:33
nms1.man.lodz.pl 5.756 13.366 0.00000:00:23
azpdwsb51uo6.stretchoid.com 0.008 0.018 0.00000:00:20
205.210.31.156 0.002 0.012 0.00000:00:08
80.111.142.213 0.010 0.050 0.00000:00:05
205.210.31.98 0.006 0.008 0.00000:00:03
162.142.125.121 0.060 0.016 0.00000:00:00
isvcs01.man.lodz.pl 0.040 0.078 0.00000:00:00
o306.scanner.modat.io 0.004 0.010 0.00000:00:00
80.94.95.55 0.002 0.012 0.00000:00:00
141.98.83.86 0.002 0.012 0.00000:00:00
193.29.13.13 0.004 0.010 0.00000:00:00
TOTAL: 14 10.946 17.428 0.00000:03:49

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
172.16.2.4 576
prod50client01.academyforinternetresearch.org 126
80.111.142.213 8
azpdwsb51uo6.stretchoid.com 4
141.98.83.86 2
o306.scanner.modat.io 2
205.210.31.156 2
205.210.31.98 2
193.29.13.13 2
162.142.125.121 2
80.94.95.55 2
TOTAL: 12 3608

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

SystemConn
162.142.125.121 2
193.29.13.13 2
80.94.95.55 2
azpdwsb51uo6.stretchoid.com 2
141.98.83.86 2
TOTAL: 5 10

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
prod50client01.academyforinternetresearch.org 2 2
141.98.83.86 2 2
193.29.13.13 2 2
80.94.95.55 2 2
TOTAL: 4 8 12

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 28100.0%
TOTAL: 1 28100.0%

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

NewsgroupCount
1lodman.info 28
TOTAL: 1 28