Daily Usenet report

Aug 14 04:15:01 -- Aug 15 04:15:01

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Aug 14 08:05:57 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 08:06:25 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 08:56:53 newsfeed nnrpd[1183965]: SERVER perl filter not defined
Aug 14 11:47:37 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 18:16:06 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 18:34:00 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 18:36:55 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 18:46:13 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 19:21:41 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 19:27:11 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 19:39:34 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 19:52:30 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 20:05:32 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 20:05:55 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 20:09:22 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 20:41:09 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 22:46:36 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 23:01:02 newsfeed pgpverify[1221566]: pgpverify: /usr/bin/gpg1: no such file
Aug 14 23:41:47 newsfeed overchan[1170947]: input line too long, skipping
Aug 14 23:50:28 newsfeed overchan[1170947]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 216079 95.0%24.0 MB 95.3%
nnrpd 7630 3.4%772.1 KB 3.0%
innd 2374 1.0%296.3 KB 1.1%
innfeed 1289 0.6%143.2 KB 0.6%
overchan 18 0.0%1.8 KB 0.0%
controlchan 12 0.0%2.6 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 227403 100.0%25.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 215013 98.8%
Negative hits 2217 1.0%
Positive hits 296 0.1%
Cache misses 40 0.0%
TOTAL: 4 217566 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.489 0.0%55 0.000 27.073 57.900
article cleanup00:00:01.528 0.0%216262 0.000 0.007 0.017
article logging00:00:05.503 0.0%216539 0.004 0.025 0.052
article parse00:00:09.473 0.0%1152443 0.002 0.008 0.016
article write00:00:30.489 0.0%216155 0.070 0.141 0.927
artlog/artcncl00:00:00.000 0.0%47 0.000 0.000 0.000
data move00:00:01.701 0.0%1640596 0.000 0.001 0.003
hisgrep/artcncl00:00:00.586 0.0%53 0.000 11.057 33.000
hishave/artcncl00:00:00.125 0.0%55 0.000 2.273 6.600
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:13:05.291 0.9%218758 0.437 3.590 24.787
history sync00:00:00.018 0.0%311 0.000 0.058 1.000
history write00:22:36.680 1.6%216249 1.902 6.274 27.048
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:17:54.983 97.0%1309814 15.059 64.036 420.819
nntp read00:00:20.917 0.0%1130211 0.010 0.019 0.030
overview write00:00:00.853 0.0%216155 0.000 0.004 0.014
perl filter00:04:36.400 0.3%216249 0.852 1.278 1.755
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.265 0.0%442934 0.011 0.016 0.027
TOTAL: 24:00:24.63223:59:33.301 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%10611 0.000 0.002 0.027
article prepare00:00:00.000 0.0%324 0.000 0.000 0.000
article read00:00:00.005 0.0%81 0.000 0.062 1.000
backlog stats00:00:00.035 0.0%54028 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.305 0.0%27156 0.000 0.011 0.045
data write00:00:00.802 0.0%16661 0.000 0.048 0.144
idle23:57:52.506100.0%54028 852.509 1596.811 4765.405
status file00:00:00.332 0.0%337 0.000 0.985 9.429
TOTAL: 23:57:54.94423:57:54.008100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.114 34.9%4170 0.000 2.425 868.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.150 0.5%10077 0.000 0.015 0.667
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:00:28.95800:00:10.264 35.4%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newgroups-request@fido7.ru001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 103 215670 215587 2 81 99%44:25:47
2news.icm.edu.pl 37 300 15 259 26 5%17:15:44
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 142 215971 215603 261 107 99%61:41:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl3.1 GB276.9 KB471.3 KB3.1 GB 99%15.0 KB
2news.icm.edu.pl473.1 KB40.3 KB750.9 KB1.2 MB 37%30.8 KB
3localhost1.5 KB0.0 KB0.0 KB1.5 KB100%1.5 KB
TOTAL: 33.1 GB317.2 KB1.2 MB3.1 GB 99%15.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 14 04:15:01 - 04:59:59 12239 5.7% 4.53184.1 MB 5.8% 69.84
Aug 14 05:00:00 - 05:59:59 19954 9.3% 5.54288.0 MB 9.1% 81.93
Aug 14 06:00:00 - 06:59:59 21373 9.9% 5.94275.2 MB 8.7% 78.27
Aug 14 07:00:00 - 07:59:59 25453 11.8% 7.07342.0 MB 10.8% 97.29
Aug 14 08:00:00 - 08:59:59 16640 7.7% 4.62255.0 MB 8.0% 72.53
Aug 14 09:00:00 - 09:59:59 25582 11.9% 7.11338.2 MB 10.7% 96.21
Aug 14 10:00:00 - 10:59:59 18490 8.6% 5.14293.0 MB 9.2% 83.35
Aug 14 11:00:00 - 11:59:59 8452 3.9% 2.35129.3 MB 4.1% 36.78
Aug 14 12:00:00 - 12:59:59 5016 2.3% 1.39125.7 MB 4.0% 35.75
Aug 14 13:00:00 - 13:59:59 3329 1.5% 0.9233.8 MB 1.1% 9.62
Aug 14 14:00:00 - 14:59:59 4167 1.9% 1.1665.0 MB 2.0% 18.48
Aug 14 15:00:00 - 15:59:59 8212 3.8% 2.28124.9 MB 3.9% 35.54
Aug 14 16:00:00 - 16:59:59 6062 2.8% 1.6885.7 MB 2.7% 24.39
Aug 14 17:00:00 - 17:59:59 2753 1.3% 0.7633.7 MB 1.1% 9.59
Aug 14 18:00:00 - 18:59:59 2276 1.1% 0.6327.5 MB 0.9% 7.82
Aug 14 19:00:00 - 19:59:59 4914 2.3% 1.36100.0 MB 3.2% 28.43
Aug 14 20:00:00 - 20:59:59 4697 2.2% 1.3076.4 MB 2.4% 21.74
Aug 14 21:00:00 - 21:59:59 4477 2.1% 1.2462.5 MB 2.0% 17.77
Aug 14 22:00:00 - 22:59:59 3355 1.6% 0.9343.8 MB 1.4% 12.45
Aug 14 23:00:00 - 23:59:59 3365 1.6% 0.9363.0 MB 2.0% 17.92
Aug 15 00:00:00 - 00:59:59 3137 1.5% 0.8743.0 MB 1.4% 12.23
Aug 15 01:00:00 - 01:59:59 4107 1.9% 1.1473.2 MB 2.3% 20.81
Aug 15 02:00:00 - 02:59:59 3663 1.7% 1.0249.5 MB 1.6% 14.07
Aug 15 03:00:00 - 03:59:59 3173 1.5% 0.8841.2 MB 1.3% 11.71
Aug 15 04:00:00 - 04:15:01 767 0.4% 0.8515.8 MB 0.5% 17.95
TOTAL: 24:00:00 215653 100.0% 2.503.1 GB 100.0% 37.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 357 71 0 10 0 0 0 0 276
2news.icm.edu.pl 22 0 0 3 0 0 0 0 19
TOTAL: 2 379 71 0 13 0 0 0 0 295

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 47
comp.mobile.android 10
alt.comp.software.seamonkey 8
alt.comp.software.firefox 2
comp.sys.raspberry-pi 2
de.rec.sf.startrek 1
it.comp.os.win.windows10 1
TOTAL: 7 71

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 16577 40 10388 41 0 0 0%23:59:39
2nask 0 0 0 0 0 7729 0%23:57:48
3panorama 0 0 0 0 0 10618 0%23:57:48
4poznan 15 0 10 0 0 0 0%01:42:25
5okapi 0 0 0 0 0 896 0%23:57:48
TOTAL: 5 16592 40 10398 41 0 19243 0%97:35:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm125.1 KB797.9 KB923.0 KB0.0 KB/s11.4 KB23:59:39
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:42:25
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 5125.1 KB797.9 KB923.0 KB0.0 KB/s11.4 KB97:35:28
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 42.9 KB 2 0 000:00:09
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 42.9 KB 2 1 000:00:29

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1728 42.9 KB 2 1 000:00:24
2unresolved 103 00.0 KB 0 0 000:00:04
3*.shodan.io 1 00.0 KB 0 0 000:00:01
TOTAL: 31832 42.9 KB 2 1 000:00:29

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 5.110 9.062 0.00000:00:14
web.man.lodz.pl 0.983 1.835 0.00000:00:09
80.111.142.213 0.027 0.025 0.00000:00:02
census6.shodan.io 0.004 0.007 0.00000:00:01
212.51.192.185 0.314 0.665 0.00000:00:01
192.241.205.27 0.000 0.012 0.00000:00:00
80.66.88.204 0.006 0.006 0.00000:00:00
45.227.254.8 0.006 0.006 0.00000:00:00
isvcs01.man.lodz.pl 0.004 0.013 0.00000:00:00
TOTAL: 9 6.454 11.631 0.00000:00:29

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1439
212.51.192.185 96
80.111.142.213 4
census6.shodan.io 1
192.241.205.27 1
45.227.254.8 1
80.66.88.204 1
TOTAL: 7 1543

NNRP unrecognized commands (by host):

SystemConn
45.227.254.8 1
192.241.205.27 1
80.66.88.204 1
TOTAL: 3 3

NNRP unrecognized commands (by command):

CommandCount
#003 2
MGLNDD_212.191.2.21_119 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.8 1 1
80.66.88.204 1 1
TOTAL: 2 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 4
TOTAL: 1 4
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>