Daily Usenet report

May 26 04:15:01 -- May 27 04:15:01

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

May 26 11:32:55 newsfeed nnrpd[1191190]: SERVER perl filter not defined
May 26 11:32:55 newsfeed nnrpd[1191190]: SERVER perl filter not defined
May 26 11:40:50 newsfeed nnrpd[1192275]: SERVER perl filter not defined
May 26 11:40:50 newsfeed nnrpd[1192275]: SERVER perl filter not defined
May 26 15:16:48 newsfeed nnrpd[1217920]: SERVER perl filter not defined
May 26 15:16:48 newsfeed nnrpd[1217920]: SERVER perl filter not defined
May 26 21:15:06 newsfeed nnrpd[1261109]: SERVER perl filter not defined
May 26 21:15:06 newsfeed nnrpd[1261109]: SERVER perl filter not defined
May 26 21:30:21 newsfeed nnrpd[1263188]: SERVER perl filter not defined
May 26 21:30:21 newsfeed nnrpd[1263188]: SERVER perl filter not defined
May 27 00:07:09 newsfeed nnrpd[1281891]: SERVER perl filter not defined
May 27 00:07:09 newsfeed nnrpd[1281891]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 111909 75.8%12.4 MB 78.6%
innd 18778 12.7%1.8 MB 11.3%
nnrpd 15790 10.7%1.5 MB 9.3%
innfeed 1238 0.8%136.8 KB 0.8%
overchan 2 0.0%0.1 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 6 147719 100.0%15.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 223250 99.6%
Negative hits 776 0.3%
Positive hits 140 0.1%
Cache misses 2 0.0%
TOTAL: 4 224168 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.018 0.0%62 0.000 0.290 2.000
article cleanup00:00:00.706 0.0%223658 0.000 0.003 0.011
article logging00:00:03.934 0.0%223692 0.007 0.018 0.034
article parse00:00:03.730 0.0%656210 0.001 0.006 0.011
article write00:00:09.996 0.0%223646 0.025 0.045 0.110
artlog/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
data move00:00:00.696 0.0%938958 0.000 0.001 0.002
hisgrep/artcncl00:00:00.004 0.0%92 0.000 0.043 0.500
hishave/artcncl00:00:00.000 0.0%30 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:10.578 0.0%224542 0.001 0.047 0.714
history sync00:00:00.030 0.0%596 0.000 0.050 0.500
history write00:00:30.850 0.0%223652 0.040 0.138 0.715
idle47:56:50.256 99.9%830332 86.584 207.881 620.533
nntp read00:00:06.614 0.0%628744 0.004 0.011 0.020
overview write00:00:00.346 0.0%223646 0.000 0.002 0.008
perl filter00:02:03.734 0.1%223652 0.404 0.553 0.873
python filter00:00:00.060 0.0%223664 0.000 0.000 0.003
site send00:00:03.272 0.0%462326 0.001 0.007 0.017
TOTAL: 48:00:35.30448:00:04.824100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%15014 0.000 0.001 0.067
article prepare00:00:00.000 0.0%1352 0.000 0.000 0.000
article read00:00:00.004 0.0%338 0.000 0.012 1.000
backlog stats00:00:00.016 0.0%82614 0.000 0.000 0.012
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.322 0.0%40024 0.000 0.008 0.065
data write00:00:00.802 0.0%24926 0.000 0.032 0.125
idle47:58:25.776100.0%82614 701.209 2090.515 7165.929
status file00:00:00.120 0.0%318 0.000 0.377 4.000
TOTAL: 47:58:27.91447:58:27.060100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:50.514 72.2%8838 1.000 12.504 5042.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.244 0.2%29910 0.000 0.008 0.500
readart00:00:00.000 0.0%16 0.000 0.000 0.000
TOTAL: 00:02:32.98400:01:50.758 72.4%----

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 148 223920 223912 2 6 99%72:37:52
2localhost 14 12 12 0 0 100%00:00:00
3news.icm.edu.pl 60 112 6 100 6 5%13:23:22
TOTAL: 3 222 224044 223930 102 12 99%86:01:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.9 GB61.8 KB0.0 KB1.9 GB 99%9.0 KB
2news.icm.edu.pl230.1 KB0.0 KB73.7 KB303.8 KB 75%25.3 KB
3localhost18.3 KB0.0 KB0.0 KB18.3 KB100%1.5 KB
TOTAL: 31.9 GB61.8 KB73.7 KB1.9 GB 99%9.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 26 04:15:01 - 04:59:59 1898 1.7% 0.7016.3 MB 1.7% 6.20
May 26 05:00:00 - 05:59:59 2807 2.5% 0.7825.0 MB 2.5% 7.11
May 26 06:00:00 - 06:59:59 3884 3.5% 1.0830.5 MB 3.1% 8.66
May 26 07:00:00 - 07:59:59 4516 4.0% 1.2535.8 MB 3.6% 10.19
May 26 08:00:00 - 08:59:59 6007 5.4% 1.6753.2 MB 5.4% 15.14
May 26 09:00:00 - 09:59:59 6404 5.7% 1.7846.6 MB 4.7% 13.26
May 26 10:00:00 - 10:59:59 7277 6.5% 2.0255.2 MB 5.6% 15.71
May 26 11:00:00 - 11:59:59 5504 4.9% 1.5349.3 MB 5.0% 14.02
May 26 12:00:00 - 12:59:59 3770 3.4% 1.0537.9 MB 3.8% 10.78
May 26 13:00:00 - 13:59:59 4118 3.7% 1.1433.6 MB 3.4% 9.55
May 26 14:00:00 - 14:59:59 3879 3.5% 1.0833.5 MB 3.4% 9.53
May 26 15:00:00 - 15:59:59 4247 3.8% 1.1834.5 MB 3.5% 9.81
May 26 16:00:00 - 16:59:59 6668 6.0% 1.8557.1 MB 5.8% 16.26
May 26 17:00:00 - 17:59:59 4549 4.1% 1.2638.7 MB 3.9% 11.01
May 26 18:00:00 - 18:59:59 4200 3.8% 1.1735.6 MB 3.6% 10.12
May 26 19:00:00 - 19:59:59 4147 3.7% 1.1534.4 MB 3.5% 9.79
May 26 20:00:00 - 20:59:59 4817 4.3% 1.3446.0 MB 4.7% 13.07
May 26 21:00:00 - 21:59:59 5375 4.8% 1.4949.5 MB 5.0% 14.09
May 26 22:00:00 - 22:59:59 5167 4.6% 1.4456.2 MB 5.7% 15.99
May 26 23:00:00 - 23:59:59 5652 5.1% 1.5755.6 MB 5.6% 15.83
May 27 00:00:00 - 00:59:59 5844 5.2% 1.6251.1 MB 5.2% 14.54
May 27 01:00:00 - 01:59:59 3383 3.0% 0.9429.1 MB 3.0% 8.28
May 27 02:00:00 - 02:59:59 3456 3.1% 0.9634.2 MB 3.5% 9.72
May 27 03:00:00 - 03:59:59 3733 3.3% 1.0441.4 MB 4.2% 11.76
May 27 04:00:00 - 04:15:01 569 0.5% 0.635.3 MB 0.5% 6.03
TOTAL: 24:00:00 111871 100.0% 1.29985.6 MB 100.0% 11.68
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 20 0 0 3 0 0 0 0 17
2news.icm.edu.pl 3 0 0 0 0 0 0 0 3
TOTAL: 2 23 0 0 3 0 0 0 0 20

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 6
TOTAL: 1 6

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 26048 200 14670 138 0 2 0%47:59:56
2poznan 14 0 8 0 0 0 0%01:29:38
TOTAL: 2 26062 200 14678 138 0 2 0%49:29:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm577.4 KB3.2 MB3.7 MB0.0 KB/s11.3 KB47:59:56
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:29:38
TOTAL: 2577.4 KB3.2 MB3.7 MB0.0 KB/s11.3 KB49:29:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172.16.2.4 576 1632.0 KB 8 0 000:00:46
2isvcs01.man.lodz.pl 12 00.0 KB 0 12 000:00:00
TOTAL: 2 588 1632.0 KB 8 12 000:02:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 586 1632.0 KB 8 0 000:00:53
2*.172.132.66.censys-scanner.com 8 00.0 KB 0 0 000:00:11
3*.man.lodz.pl2892 00.0 KB 0 12 000:00:39
4*.scanner.modat.io 2 00.0 KB 0 0 000:00:00
5*.internet-census.org 12 00.0 KB 0 0 000:00:42
6*.probe.onyphe.net 4 00.0 KB 0 0 000:00:07
TOTAL: 63504 1632.0 KB 8 12 000:02:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.16.2.4 1.662 2.976 0.00000:00:46
nms2.man.lodz.pl 7.914 14.100 0.00000:00:39
zl-amsc-nl-gp1-wk129b.internet-census.org 0.004 0.010 0.00000:00:20
96.172.132.66.censys-scanner.com 0.066 0.038 0.00000:00:10
80.111.142.213 0.022 0.046 0.00000:00:06
chaya.probe.onyphe.net 0.006 0.010 0.00000:00:06
zl-laxd-us-cpp-wk111.internet-census.org 0.006 0.008 0.00000:00:04
sh-chi-us-cpp-wk105.internet-census.org 0.006 0.010 0.00000:00:04
sh-chi-us-cpp-wk107.internet-census.org 0.008 0.006 0.00000:00:04
sh-ams-nl-cpp-wk103.internet-census.org 0.010 0.008 0.00000:00:04
sh-ams-nl-cpp-wk104.internet-census.org 0.002 0.014 0.00000:00:04
134.172.132.66.censys-scanner.com 0.068 0.010 0.00000:00:01
brady.probe.onyphe.net 0.008 0.006 0.00000:00:01
isvcs01.man.lodz.pl 0.040 0.076 0.00000:00:00
147.185.132.13 0.002 0.014 0.00000:00:00
o329.scanner.modat.io 0.006 0.006 0.00000:00:00
TOTAL: 16 9.830 17.338 0.00000:02:33

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 2880
80.111.142.213 8
96.172.132.66.censys-scanner.com 6
chaya.probe.onyphe.net 2
sh-chi-us-cpp-wk105.internet-census.org 2
o329.scanner.modat.io 2
147.185.132.13 2
zl-amsc-nl-gp1-wk129b.internet-census.org 2
zl-laxd-us-cpp-wk111.internet-census.org 2
sh-ams-nl-cpp-wk104.internet-census.org 2
134.172.132.66.censys-scanner.com 2
sh-ams-nl-cpp-wk103.internet-census.org 2
sh-chi-us-cpp-wk107.internet-census.org 2
brady.probe.onyphe.net 2
TOTAL: 14 2916

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

SystemConn
brady.probe.onyphe.net 4
96.172.132.66.censys-scanner.com 2
134.172.132.66.censys-scanner.com 2
TOTAL: 3 8

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

CommandCount
EHLO www.censys.io 4
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 2
#026#003#003#002a#001 2
TOTAL: 3 8

NNRP client timeouts [Top 20]:

SystemConnPeer
96.172.132.66.censys-scanner.com 2 4
TOTAL: 1 2 6

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1pl 16100.0%
TOTAL: 1 16100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 16
TOTAL: 1 16