Daily Usenet report

Sep 30 04:15:02 -- Oct 1 04:15:02

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Sep 30 10:26:59 newsfeed nnrpd[9110]: SERVER perl filter not defined
Sep 30 10:27:50 newsfeed nnrpd[9298]: SERVER perl filter not defined
Sep 30 10:29:49 newsfeed nnrpd[9299]: SERVER perl filter not defined
Sep 30 12:59:15 newsfeed overchan[28475]: input line too long, skipping
Sep 30 13:04:55 newsfeed nnrpd[14456]: SERVER perl filter not defined
Sep 30 13:09:21 newsfeed overchan[28475]: input line too long, skipping
Sep 30 14:14:15 newsfeed overchan[28475]: input line too long, skipping
Sep 30 15:19:54 newsfeed nnrpd[19230]: SERVER perl filter not defined
Sep 30 16:13:09 newsfeed nnrpd[21010]: SERVER perl filter not defined
Sep 30 16:13:24 newsfeed nnrpd[21011]: SERVER perl filter not defined
Sep 30 16:13:43 newsfeed nnrpd[21012]: SERVER perl filter not defined
Sep 30 16:22:08 newsfeed nnrpd[21310]: SERVER perl filter not defined
Sep 30 16:38:18 newsfeed overchan[28475]: input line too long, skipping
Sep 30 19:59:30 newsfeed nnrpd[28733]: SERVER perl filter not defined
Sep 30 20:58:29 newsfeed nnrpd[30756]: SERVER perl filter not defined
Sep 30 21:28:36 newsfeed overchan[28475]: input line too long, skipping
Sep 30 21:52:43 newsfeed nnrpd[32502]: SERVER perl filter not defined
Sep 30 23:39:14 newsfeed nnrpd[3823]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2638386 98.2%295.4 MB 97.9%
innfeed 28366 1.1%3.4 MB 1.1%
innd 14458 0.5%2.5 MB 0.8%
nnrpd 4974 0.2%522.8 KB 0.2%
overchan 6 0.0%1.1 KB 0.0%
controlchan 5 0.0%0.7 KB 0.0%
TOTAL: 62686195 100.0%301.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2609780 99.8%
Negative hits 5505 0.2%
Positive hits 200 0.0%
Cache misses 51 0.0%
TOTAL: 4 2615536 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.632 0.0%116 0.000 22.690 188.500
article cleanup00:00:26.897 0.0%2675752 0.007 0.010 0.015
article logging00:01:22.760 0.1%2676183 0.023 0.031 0.047
article parse00:18:43.485 1.3%67000436 0.011 0.017 0.030
article write00:08:59.388 0.6%2675537 0.123 0.202 0.716
artlog/artcncl00:00:00.004 0.0%116 0.000 0.034 1.000
data move00:01:01.449 0.1%78125215 0.001 0.001 0.001
hisgrep/artcncl00:00:00.703 0.0%106 0.000 6.632 52.667
hishave/artcncl00:00:00.028 0.0%116 0.000 0.241 8.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:25:47.523 1.8%2681710 0.021 0.577 5.388
history sync00:00:00.014 0.0%291 0.000 0.048 0.500
history write01:17:06.641 5.4%2675735 0.149 1.729 8.032
hiswrite/artcncl00:00:00.004 0.0%10 0.000 0.400 2.000
idle17:33:55.048 73.2%62219205 0.394 1.016 3.576
nntp read00:35:22.960 2.5%64676209 0.024 0.033 0.042
overview write00:00:10.672 0.0%2675537 0.003 0.004 0.007
perl filter03:19:45.137 13.9%2675735 3.230 4.479 15.667
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:51.322 0.1%5365891 0.016 0.021 0.027
TOTAL: 24:00:02.53723:44:36.667 98.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.106 0.0%45319 0.000 0.002 0.012
article prepare00:00:00.001 0.0%4756 0.000 0.000 0.031
article read00:00:10.838 0.0%1191 0.000 9.100 627.000
backlog stats00:00:00.094 0.0%115835 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.918 0.0%56881 0.000 0.016 0.053
data write00:00:02.205 0.0%42089 0.020 0.052 0.098
idle23:53:21.779100.0%115835 208.721 742.451 1721.049
status file00:00:07.323 0.0%9781 0.500 0.749 1.050
TOTAL: 23:53:47.83023:53:43.264100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:13.340 60.3%3147 0.000 4.239 136.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.239 1.1%6888 0.000 0.035 0.500
readart00:00:00.000 0.0%38 0.000 0.000 0.000
TOTAL: 00:00:22.13100:00:13.579 61.4%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 192

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 97 26375732637384 0 189 99%65:45:03
2localhost 14 13 13 0 0 100%00:00:00
3news.icm.edu.pl 47 174 10 138 26 5%13:55:47
TOTAL: 3 158 26377602637407 138 215 99%79:40:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl344.4 GB1.7 MB2.2 MB344.4 GB 99%136.9 KB
2news.icm.edu.pl156.3 KB0.0 KB1.2 MB1.3 MB 11%37.1 KB
3localhost23.4 KB0.0 KB0.0 KB23.4 KB100%1.8 KB
TOTAL: 3344.4 GB1.7 MB3.3 MB344.4 GB 99%136.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 04:15:02 - 04:59:59 118054 4.5% 43.7611.2 GB 3.2%4367.19
Sep 30 05:00:00 - 05:59:59 149448 5.7% 41.5121.5 GB 6.2%6263.92
Sep 30 06:00:00 - 06:59:59 184636 7.0% 51.2922.7 GB 6.5%6600.46
Sep 30 07:00:00 - 07:59:59 64131 2.4% 17.8114.5 GB 4.2%4218.76
Sep 30 08:00:00 - 08:59:59 80136 3.0% 22.2613.7 GB 3.9%3994.08
Sep 30 09:00:00 - 09:59:59 65330 2.5% 18.1512.1 GB 3.5%3518.98
Sep 30 10:00:00 - 10:59:59 61298 2.3% 17.0314.7 GB 4.2%4291.36
Sep 30 11:00:00 - 11:59:59 39197 1.5% 10.8911.1 GB 3.2%3244.86
Sep 30 12:00:00 - 12:59:59 33531 1.3% 9.3112.6 GB 3.6%3659.67
Sep 30 13:00:00 - 13:59:59 136423 5.2% 37.9014.2 GB 4.1%4132.64
Sep 30 14:00:00 - 14:59:59 254492 9.6% 70.6917.8 GB 5.1%5186.76
Sep 30 15:00:00 - 15:59:59 137312 5.2% 38.1411.9 GB 3.4%3455.17
Sep 30 16:00:00 - 16:59:59 130983 5.0% 36.3813.0 GB 3.7%3777.09
Sep 30 17:00:00 - 17:59:59 150833 5.7% 41.9015.2 GB 4.4%4435.82
Sep 30 18:00:00 - 18:59:59 114966 4.4% 31.9314.9 GB 4.3%4330.63
Sep 30 19:00:00 - 19:59:59 70585 2.7% 19.6115.0 GB 4.3%4369.01
Sep 30 20:00:00 - 20:59:59 131684 5.0% 36.5815.4 GB 4.4%4489.67
Sep 30 21:00:00 - 21:59:59 177255 6.7% 49.2414.6 GB 4.2%4251.48
Sep 30 22:00:00 - 22:59:59 156800 5.9% 43.5615.0 GB 4.3%4372.48
Sep 30 23:00:00 - 23:59:59 64700 2.5% 17.9715.7 GB 4.5%4569.39
Oct 1 00:00:00 - 00:59:59 40251 1.5% 11.186.9 GB 2.0%2008.29
Oct 1 01:00:00 - 01:59:59 127802 4.8% 35.5012.2 GB 3.5%3544.44
Oct 1 02:00:00 - 02:59:59 74924 2.8% 20.8114.9 GB 4.3%4354.33
Oct 1 03:00:00 - 03:59:59 55044 2.1% 15.2913.3 GB 3.8%3884.02
Oct 1 04:00:00 - 04:15:02 17808 0.7% 19.743.2 GB 0.9%3679.45
TOTAL: 24:00:00 2637623 100.0% 30.53347.3 GB 100.0%4214.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 621 169 0 17 3 0 0 0 432
2news.icm.edu.pl 27 0 0 0 0 0 0 0 27
TOTAL: 2 648 169 0 17 3 0 0 0 459

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 100
it.comp.os.win.windows10 23
comp.mobile.ipad 12
it.tlc.cellulari.android 12
it.comp.os.win.windows7 8
comp.mobile.android 7
de.comp.office-pakete.ms-office.word 3
nl.comp.os.linux.techniek 2
it.comp.dotnet 1
de.rec.sf.startrek 1
TOTAL: 10 169

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
pl.praca.oferowana 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 17
Scoring filter (8) 6
Binary in non-binary group 2
Scoring filter (9) 1
TOTAL: 4 26

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 432
news.icm.edu.pl 1
TOTAL: 2 433
TOTAL: 1 433

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 25561 733 13953 37 1 653 2%23:59:58
2panorama 31616 184 15275 65 5 29284 0%23:59:29
3nask 0 0 0 0 0 9681 0%23:57:50
4poznan 9 0 8 0 0 0 0%01:22:21
5okapi 0 0 0 0 0 1106 0%23:57:51
TOTAL: 5 57186 917 29236 102 6 40724 1%97:17:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.0 MB451.7 KB2.4 MB0.0 KB/s3.2 KB23:59:58
2panorama425.9 KB181.7 KB607.6 KB0.0 KB/s2.4 KB23:59:29
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:22:21
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 52.4 MB633.4 KB3.0 MB0.0 KB/s3.0 KB97:17:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3861.8 KB 16 0 000:00:15
2isvcs01.man.lodz.pl 13 00.0 KB 0 13 000:00:00
TOTAL: 2 301 3861.8 KB 16 13 000:00:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 589 3861.8 KB 16 13 000:00:18
2unresolved 100 00.0 KB 0 0 000:00:02
3*.security.ipip.net 2 00.0 KB 0 0 000:00:00
TOTAL: 3 691 3861.8 KB 16 13 000:00:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.516 3.808 0.00000:00:15
mon.man.lodz.pl 1.032 2.772 0.00000:00:02
80.111.142.213 0.012 0.032 0.00000:00:02
scan-141.security.ipip.net 0.004 0.024 0.00000:00:00
212.51.192.185 0.316 0.956 0.00000:00:00
isvcs01.man.lodz.pl 0.076 0.136 0.00000:00:00
TOTAL: 6 2.956 7.728 0.00000:00:21

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
scan-141.security.ipip.net 2
TOTAL: 4 390

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 8
TOTAL: 1 8

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 2
Host: 212.191.2.21:119 2
Connection: close 2
User-Agent: HTTP Banner Detection (https... 2
TOTAL: 4 8

NNRP client timeouts [Top 20]:

SystemConnPeer
scan-141.security.ipip.net 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 38100.0%
TOTAL: 1 38100.0%

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

NewsgroupCount
1pl.comp.pecet 38
TOTAL: 1 38