Daily Usenet report

Sep 18 04:15:01 -- Sep 19 04:15:01

Unknown entries from news log file:

First 22 / 22 lines (100.0%)

Sep 18 06:23:15 newsfeed nnrpd[29654]: SERVER perl filter not defined
Sep 18 06:24:07 newsfeed nnrpd[29662]: SERVER perl filter not defined
Sep 18 07:48:02 newsfeed nnrpd[33740]: SERVER perl filter not defined
Sep 18 09:52:05 newsfeed nnrpd[39104]: SERVER perl filter not defined
Sep 18 10:38:24 newsfeed nnrpd[41228]: SERVER perl filter not defined
Sep 18 11:10:28 newsfeed overchan[23822]: input line too long, skipping
Sep 18 12:15:16 newsfeed overchan[23822]: input line too long, skipping
Sep 18 13:10:35 newsfeed nnrpd[47442]: SERVER perl filter not defined
Sep 18 15:50:15 newsfeed overchan[23822]: input line too long, skipping
Sep 18 16:06:12 newsfeed nnrpd[55191]: SERVER perl filter not defined
Sep 18 16:09:00 newsfeed overchan[23822]: input line too long, skipping
Sep 18 16:23:52 newsfeed overchan[23822]: input line too long, skipping
Sep 18 16:33:10 newsfeed overchan[23822]: input line too long, skipping
Sep 18 16:36:08 newsfeed overchan[23822]: input line too long, skipping
Sep 18 19:18:17 newsfeed nnrpd[63547]: SERVER perl filter not defined
Sep 18 19:19:11 newsfeed nnrpd[63555]: SERVER perl filter not defined
Sep 18 19:52:24 newsfeed overchan[23822]: input line too long, skipping
Sep 18 20:27:33 newsfeed nnrpd[66595]: SERVER perl filter not defined
Sep 18 20:28:06 newsfeed overchan[23822]: input line too long, skipping
Sep 18 21:09:33 newsfeed nnrpd[68372]: SERVER perl filter not defined
Sep 19 00:18:59 newsfeed overchan[23822]: input line too long, skipping
Sep 19 00:19:12 newsfeed overchan[23822]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 116773 89.9%13.0 MB 90.6%
nnrpd 7621 5.9%751.2 KB 5.1%
innd 4118 3.2%486.8 KB 3.3%
innfeed 1305 1.0%146.1 KB 1.0%
overchan 12 0.0%1.3 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 129830 100.0%14.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 115865 96.6%
Negative hits 3123 2.6%
Positive hits 892 0.7%
Cache misses 16 0.0%
TOTAL: 4 119896 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.438 0.0%30 0.000 14.600 33.000
article cleanup00:00:00.815 0.0%116120 0.000 0.007 0.018
article logging00:00:03.055 0.0%116127 0.011 0.026 0.041
article parse00:00:03.846 0.0%486376 0.004 0.008 0.015
article write00:00:17.788 0.0%113733 0.048 0.156 1.532
artlog/artcncl00:00:00.001 0.0%30 0.000 0.033 0.111
data move00:00:00.714 0.0%620729 0.000 0.001 0.003
hisgrep/artcncl00:00:00.188 0.0%30 0.000 6.267 14.556
hishave/artcncl00:00:00.145 0.0%30 0.000 4.833 10.556
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:15:20.570 1.1%120097 2.461 7.665 14.259
history sync00:00:00.021 0.0%371 0.000 0.057 0.500
history write00:15:50.073 1.1%116095 3.938 8.184 14.405
idle23:16:50.744 97.6%571574 16.716 146.631 388.187
nntp read00:00:08.462 0.0%475226 0.011 0.018 0.032
overview write00:00:00.338 0.0%113733 0.000 0.003 0.009
perl filter00:01:54.411 0.1%116095 0.714 0.985 1.585
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:03.966 0.0%238821 0.009 0.017 0.027
TOTAL: 23:50:57.58823:50:35.575100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%11354 0.000 0.003 0.040
article prepare00:00:00.000 0.0%84 0.000 0.000 0.000
article read00:00:00.001 0.0%21 0.000 0.048 1.000
backlog stats00:00:00.036 0.0%46687 0.000 0.001 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.260 0.0%25265 0.000 0.010 0.048
data write00:00:00.629 0.0%14078 0.000 0.045 0.113
idle23:50:00.189100.0%46687 923.502 1837.775 4352.812
status file00:00:00.196 0.0%338 0.000 0.580 2.286
TOTAL: 23:50:02.28323:50:01.342100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:39:45.408 99.4%4280 0.000 1398.460279332.875
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.977 0.0%10311 0.000 0.192 26.864
readart00:00:00.342 0.0%32 0.000 10.688 40.000
TOTAL: 01:40:20.49301:39:47.727 99.5%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 61 114419 114251 5 163 99%39:27:07
2news.icm.edu.pl 7 3088 34 862 2192 1%23:29:59
3localhost 12 11 11 0 0 100%00:00:00
TOTAL: 3 80 117518 114296 867 2355 97%62:57:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1016.4 MB210.7 KB933.8 KB1017.6 MB 99%9.1 KB
2news.icm.edu.pl1.1 MB179.4 KB34.8 MB36.0 MB 3%16.6 KB
3localhost17.2 KB0.0 KB0.0 KB17.2 KB100%1.6 KB
TOTAL: 31017.6 MB390.1 KB35.7 MB1.0 GB 96%9.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 18 04:15:01 - 04:59:59 2670 2.3% 0.9922.2 MB 2.2% 8.41
Sep 18 05:00:00 - 05:59:59 4603 4.0% 1.2844.5 MB 4.4% 12.65
Sep 18 06:00:00 - 06:59:59 4344 3.8% 1.2147.0 MB 4.6% 13.37
Sep 18 07:00:00 - 07:59:59 3585 3.1% 1.0032.8 MB 3.2% 9.33
Sep 18 08:00:00 - 08:59:59 4701 4.1% 1.3139.9 MB 3.9% 11.36
Sep 18 09:00:00 - 09:59:59 5509 4.8% 1.5344.2 MB 4.3% 12.56
Sep 18 10:00:00 - 10:59:59 5027 4.4% 1.4039.4 MB 3.9% 11.21
Sep 18 11:00:00 - 11:59:59 5342 4.7% 1.4840.4 MB 4.0% 11.49
Sep 18 12:00:00 - 12:59:59 5063 4.4% 1.4133.3 MB 3.3% 9.47
Sep 18 13:00:00 - 13:59:59 7245 6.3% 2.01135.4 MB 13.3% 38.51
Sep 18 14:00:00 - 14:59:59 6171 5.4% 1.7147.7 MB 4.7% 13.56
Sep 18 15:00:00 - 15:59:59 4716 4.1% 1.3136.3 MB 3.6% 10.32
Sep 18 16:00:00 - 16:59:59 4195 3.7% 1.1745.8 MB 4.5% 13.02
Sep 18 17:00:00 - 17:59:59 4753 4.2% 1.3234.8 MB 3.4% 9.89
Sep 18 18:00:00 - 18:59:59 5137 4.5% 1.4334.2 MB 3.4% 9.72
Sep 18 19:00:00 - 19:59:59 4903 4.3% 1.3637.3 MB 3.7% 10.60
Sep 18 20:00:00 - 20:59:59 4390 3.8% 1.2237.9 MB 3.7% 10.79
Sep 18 21:00:00 - 21:59:59 4612 4.0% 1.2831.6 MB 3.1% 8.98
Sep 18 22:00:00 - 22:59:59 4978 4.4% 1.3843.8 MB 4.3% 12.45
Sep 18 23:00:00 - 23:59:59 4827 4.2% 1.3439.7 MB 3.9% 11.31
Sep 19 00:00:00 - 00:59:59 4782 4.2% 1.3338.8 MB 3.8% 11.03
Sep 19 01:00:00 - 01:59:59 4654 4.1% 1.2942.5 MB 4.2% 12.08
Sep 19 02:00:00 - 02:59:59 3615 3.2% 1.0032.5 MB 3.2% 9.24
Sep 19 03:00:00 - 03:59:59 3489 3.1% 0.9726.4 MB 2.6% 7.52
Sep 19 04:00:00 - 04:15:01 1005 0.9% 1.129.6 MB 0.9% 10.91
TOTAL: 24:00:00 114316 100.0% 1.321017.8 MB 100.0% 12.06
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 2257 0 0 12 0 0 0 0 2245
2newsfeed.pionier.net.pl 170 135 0 13 0 0 0 0 22
TOTAL: 2 2427 135 0 25 0 0 0 0 2267

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 65
comp.sys.raspberry-pi 53
it.tlc.cellulari.android 5
comp.mobile.android 5
alt.comp.software.seamonkey 4
de.comp.lang.vbclassic 2
it.comp.os.win.windows10 1
TOTAL: 7 135

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 2155
Scoring filter (8) 70
Scoring filter (9) 18
EMP (md5) 16
Scoring filter (12) 1
TOTAL: 5 2260

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 13943 11 11159 10 0 1 0%23:59:57
2okapi 0 0 0 0 0 730 0%23:57:48
3nask 0 0 0 0 0 7701 0%23:57:48
4poznan 26 0 20 0 0 0 0%02:27:43
5panorama 0 0 0 0 0 11408 0%23:57:48
TOTAL: 5 13969 11 11179 10 0 19840 0%98:21:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm38.5 KB21.7 KB60.2 KB0.0 KB/s2.9 KB23:59:57
2okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:27:43
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 538.5 KB21.7 KB60.2 KB0.0 KB/s2.9 KB98:21:04
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
TOTAL: 1976.7 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1staticline60896.toya.net.pl 24 1725.2 KB 17 0 000:00:11
2212.191.31.18 1 68.4 KB 1 0 000:30:00
3pc-mstarzak.cm.p.lodz.pl 1 58.0 KB 1 0 000:31:40
4pc-212-191-92-131.p.lodz.pl 2 46.1 KB 1 0 000:37:24
5isvcs01.man.lodz.pl 11 00.0 KB 0 11 000:00:00
TOTAL: 5 39 3247.6 KB 20 11 001:40:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.toya.net.pl 24 1725.2 KB 17 0 000:00:11
2unresolved 103 68.4 KB 1 0 000:30:24
3*.cm.p.lodz.pl 1 58.0 KB 1 0 000:31:40
4*.p.lodz.pl 2 46.1 KB 1 0 000:37:24
5*.man.lodz.pl1667 00.0 KB 0 11 000:00:39
6*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 61798 3247.6 KB 20 11 001:40:20

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-191-92-131.p.lodz.pl 0.025 0.014 0.00000:37:24
pc-mstarzak.cm.p.lodz.pl 0.000 0.009 0.00000:31:40
212.191.31.18 0.005 0.009 0.00000:30:00
nms2.man.lodz.pl 2.578 3.537 0.00000:00:20
web.man.lodz.pl 0.990 1.346 0.00000:00:12
staticline60896.toya.net.pl 0.134 0.106 0.00000:00:11
172.104.75.183 0.006 0.000 0.00000:00:10
107.170.253.37 0.000 0.009 0.00000:00:09
nms1.man.lodz.pl 2.253 3.065 0.00000:00:06
80.111.142.213 0.013 0.026 0.00000:00:02
212.51.192.185 0.348 0.522 0.00000:00:02
isvcs01.man.lodz.pl 0.067 0.086 0.00000:00:00
66.210.203.35.bc.googleusercontent.com 0.000 0.006 0.00000:00:00
TOTAL: 13 6.419 8.735 0.00001:40:20

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 692
nms1.man.lodz.pl 677
web.man.lodz.pl 287
212.51.192.185 96
80.111.142.213 4
107.170.253.37 1
66.210.203.35.bc.googleusercontent.com 1
172.104.75.183 1
TOTAL: 8 1759

NNRP unrecognized commands (by host):

SystemConn
66.210.203.35.bc.googleusercontent.com 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 1
User-Agent: Expanse, a Palo Alto Network... 1
GET / HTTP/1.1 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
212.191.31.18 1 0
pc-212-191-92-131.p.lodz.pl 1 0
pc-mstarzak.cm.p.lodz.pl 1 0
TOTAL: 3 3 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 27 84.4%
2pl 5 15.6%
TOTAL: 2 32100.0%

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

NewsgroupCount
1lodman.info 27
2pl.rec.telewizja 5
TOTAL: 2 32