Daily Usenet report

Jun 27 04:15:01 -- Jun 28 04:15:23

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Jun 27 06:26:12 newsfeed overchan[23504]: input line too long, skipping
Jun 27 09:34:43 newsfeed nnrpd[8873]: SERVER perl filter not defined
Jun 27 13:02:41 newsfeed overchan[23504]: input line too long, skipping
Jun 27 13:15:17 newsfeed overchan[23504]: input line too long, skipping
Jun 27 15:02:04 newsfeed overchan[23504]: input line too long, skipping
Jun 27 15:09:24 newsfeed overchan[23504]: input line too long, skipping
Jun 27 17:30:15 newsfeed overchan[23504]: input line too long, skipping
Jun 27 17:35:25 newsfeed overchan[23504]: input line too long, skipping
Jun 27 17:37:09 newsfeed overchan[23504]: input line too long, skipping
Jun 27 18:04:42 newsfeed nnrpd[23827]: SERVER perl filter not defined
Jun 27 18:05:54 newsfeed nnrpd[24041]: SERVER perl filter not defined
Jun 27 18:56:22 newsfeed overchan[23504]: input line too long, skipping
Jun 27 19:06:51 newsfeed overchan[23504]: input line too long, skipping
Jun 28 00:48:36 newsfeed nnrpd[21723]: SERVER perl filter not defined
Jun 28 02:18:17 newsfeed overchan[23504]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 602050 97.7%65.6 MB 97.4%
innd 8792 1.4%1.2 MB 1.8%
nnrpd 4220 0.7%398.7 KB 0.6%
innfeed 1324 0.2%171.2 KB 0.2%
overchan 12 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 616399 100.0%67.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 598708 99.4%
Negative hits 3120 0.5%
Positive hits 286 0.0%
Cache misses 27 0.0%
TOTAL: 4 602141 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.799 0.0%72 0.000 38.875 2144.000
article cleanup00:00:04.809 0.0%601472 0.004 0.008 0.012
article logging00:00:15.473 0.0%601860 0.019 0.026 0.035
article parse00:08:39.265 0.6%73963992 0.006 0.007 0.010
article write00:04:48.270 0.3%601321 0.271 0.479 4.916
artlog/artcncl00:00:00.001 0.0%72 0.000 0.014 1.000
data move00:00:28.077 0.0%78778227 0.000 0.000 0.000
hisgrep/artcncl00:00:01.513 0.0%71 0.000 21.310 1359.000
hishave/artcncl00:00:00.003 0.0%72 0.000 0.042 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:32.430 0.2%604966 0.098 0.351 17.064
history sync00:00:00.019 0.0%290 0.000 0.066 1.000
history write00:04:47.294 0.3%601446 0.173 0.478 23.162
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
idle22:27:56.828 93.6%73845890 0.731 1.095 1.981
nntp read00:20:11.004 1.4%73684902 0.015 0.016 0.020
overview write00:00:01.811 0.0%601321 0.001 0.003 0.005
perl filter00:37:54.689 2.6%601446 2.889 3.782 4.519
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:15.525 0.0%1213051 0.009 0.013 0.017
TOTAL: 24:00:06.91823:48:59.811 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%10403 0.000 0.002 0.031
article prepare00:00:00.001 0.0%3440 0.000 0.000 0.036
article read00:00:00.029 0.0%860 0.000 0.034 1.000
backlog stats00:00:00.047 0.0%60712 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.310 0.0%29430 0.000 0.011 0.038
data write00:00:00.769 0.0%19191 0.000 0.040 0.120
idle23:56:41.763100.0%60712 791.768 1419.847 3452.052
status file00:00:18.965 0.0%332 0.000 57.123 6320.000
TOTAL: 23:57:03.00823:57:01.910100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.444 67.1%3072 0.000 6.329 9602.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.090 0.3%6791 0.000 0.013 0.500
readart00:00:00.000 0.0%38 0.000 0.000 0.000
TOTAL: 00:00:28.98300:00:19.534 67.4%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 190

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 153 601604 601474 1 129 99%77:17:05
2news.icm.edu.pl 47 273 26 217 30 9%14:43:31
3localhost 1445 4 4 0 0 100%00:00:00
TOTAL: 3 1645 601881 601504 218 159 99%92:00:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl267.4 GB1.5 MB1.7 MB267.4 GB 99%466.1 KB
2news.icm.edu.pl1.5 MB49.9 KB1.1 MB2.6 MB 56%48.1 KB
3localhost5.8 KB0.0 KB0.0 KB5.8 KB100%1.4 KB
TOTAL: 3267.4 GB1.5 MB2.8 MB267.4 GB 99%466.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 27 04:15:01 - 04:59:59 15779 2.6% 5.857.8 GB 2.9%3042.03
Jun 27 05:00:00 - 05:59:59 20642 3.4% 5.7310.9 GB 4.1%3175.42
Jun 27 06:00:00 - 06:59:59 21329 3.5% 5.9210.9 GB 4.1%3183.76
Jun 27 07:00:00 - 07:59:59 19982 3.3% 5.5510.0 GB 3.7%2924.23
Jun 27 08:00:00 - 08:59:59 21829 3.6% 6.0611.8 GB 4.4%3435.93
Jun 27 09:00:00 - 09:59:59 21824 3.6% 6.0611.2 GB 4.2%3255.10
Jun 27 10:00:00 - 10:59:59 33087 5.5% 9.1910.8 GB 4.0%3147.64
Jun 27 11:00:00 - 11:59:59 28212 4.7% 7.8410.0 GB 3.7%2904.53
Jun 27 12:00:00 - 12:59:59 20679 3.4% 5.749.6 GB 3.6%2787.36
Jun 27 13:00:00 - 13:59:59 22710 3.8% 6.3110.8 GB 4.0%3135.06
Jun 27 14:00:00 - 14:59:59 24848 4.1% 6.9013.2 GB 4.9%3830.62
Jun 27 15:00:00 - 15:59:59 26502 4.4% 7.3612.6 GB 4.7%3677.61
Jun 27 16:00:00 - 16:59:59 36037 6.0% 10.0113.2 GB 4.9%3852.11
Jun 27 17:00:00 - 17:59:59 27395 4.6% 7.6113.3 GB 5.0%3874.64
Jun 27 18:00:00 - 18:59:59 23809 4.0% 6.6111.6 GB 4.3%3365.03
Jun 27 19:00:00 - 19:59:59 27258 4.5% 7.5710.2 GB 3.8%2980.31
Jun 27 20:00:00 - 20:59:59 25719 4.3% 7.1411.6 GB 4.3%3382.83
Jun 27 21:00:00 - 21:59:59 25055 4.2% 6.9612.9 GB 4.8%3764.13
Jun 27 22:00:00 - 22:59:59 21271 3.5% 5.9110.9 GB 4.0%3161.74
Jun 27 23:00:00 - 23:59:59 21585 3.6% 6.0010.8 GB 4.0%3141.48
Jun 28 00:00:00 - 00:59:59 20563 3.4% 5.7110.4 GB 3.9%3017.03
Jun 28 01:00:00 - 01:59:59 27380 4.6% 7.6110.5 GB 3.9%3054.11
Jun 28 02:00:00 - 02:59:59 33636 5.6% 9.3410.6 GB 4.0%3097.31
Jun 28 03:00:00 - 03:59:59 28317 4.7% 7.8710.0 GB 3.7%2908.86
Jun 28 04:00:00 - 04:15:23 5993 1.0% 6.492.7 GB 1.0%3076.25
TOTAL: 24:00:22 601441 100.0% 6.96268.2 GB 100.0%3254.43
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 518 105 0 24 0 0 0 0 389
2news.icm.edu.pl 19 0 0 2 0 0 0 0 17
TOTAL: 2 537 105 0 26 0 0 0 0 406

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 47
comp.mobile.android 22
it.comp.os.win.windows10 17
alt.comp.software.seamonkey 7
it.tlc.cellulari.android 5
comp.sys.raspberry-pi 4
de.rec.sf.startrek 2
it.comp.virtualizzazione 1
TOTAL: 8 105

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 17
TOTAL: 1 17

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18293 834 9455 26 0 0 4%23:51:33
2panorama 0 0 0 0 0 10467 0%24:09:54
3okapi 0 0 0 0 0 437 0%23:57:51
4nask 0 0 0 0 0 7125 0%23:57:50
5poznan 22 0 13 0 0 0 0%02:10:50
TOTAL: 5 18315 834 9468 26 0 18029 4%98:07:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.8 MB69.4 KB2.9 MB0.0 KB/s3.4 KB23:51:33
2panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:54
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:10:50
TOTAL: 52.8 MB69.4 KB2.9 MB0.0 KB/s3.4 KB98:07:58
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
TOTAL: 1976.7 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3841.9 KB 17 0 000:00:10
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 3841.9 KB 17 4 000:00:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 580 3841.9 KB 17 4 000:00:14
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3*.census.shodan.io 1 00.0 KB 0 0 000:00:01
4unresolved 101 00.0 KB 0 0 000:00:12
TOTAL: 4 683 3841.9 KB 17 4 000:00:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.847 1.635 0.00000:00:10
192.241.213.75 0.005 0.005 0.00000:00:09
mon.man.lodz.pl 0.814 1.516 0.00000:00:03
80.111.142.213 0.005 0.029 0.00000:00:01
purple.census.shodan.io 0.003 0.004 0.00000:00:01
scan-141.security.ipip.net 0.007 0.000 0.00000:00:00
212.51.192.185 0.237 0.541 0.00000:00:00
isvcs01.man.lodz.pl 0.018 0.028 0.00000:00:00
TOTAL: 8 1.936 3.758 0.00000:00:29

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
192.241.213.75 1
scan-141.security.ipip.net 1
purple.census.shodan.io 1
TOTAL: 6 391

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 38100.0%
TOTAL: 1 38100.0%

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

NewsgroupCount
1pl.comp.pecet 30
2pl.comp.os.ms-windows.winnt 8
TOTAL: 2 38