Daily Usenet report

Aug 1 04:15:01 -- Aug 2 04:15:02

Unknown entries from news log file:

First 27 / 27 lines (100.0%)

Aug 1 04:35:13 newsfeed overchan[305409]: input line too long, skipping
Aug 1 04:40:17 newsfeed overchan[305409]: input line too long, skipping
Aug 1 07:17:09 newsfeed overchan[305409]: input line too long, skipping
Aug 1 07:20:34 newsfeed overchan[305409]: input line too long, skipping
Aug 1 07:24:31 newsfeed overchan[305409]: input line too long, skipping
Aug 1 07:26:00 newsfeed overchan[305409]: input line too long, skipping
Aug 1 08:44:38 newsfeed overchan[305409]: input line too long, skipping
Aug 1 08:45:54 newsfeed overchan[305409]: input line too long, skipping
Aug 1 09:19:23 newsfeed overchan[305409]: input line too long, skipping
Aug 1 09:21:15 newsfeed overchan[305409]: input line too long, skipping
Aug 1 13:44:29 newsfeed overchan[305409]: input line too long, skipping
Aug 1 15:15:39 newsfeed overchan[305409]: input line too long, skipping
Aug 1 17:00:50 newsfeed overchan[305409]: input line too long, skipping
Aug 1 17:03:52 newsfeed overchan[305409]: input line too long, skipping
Aug 1 17:36:57 newsfeed overchan[305409]: input line too long, skipping
Aug 1 17:38:25 newsfeed overchan[305409]: input line too long, skipping
Aug 1 17:53:45 newsfeed overchan[305409]: input line too long, skipping
Aug 1 17:55:54 newsfeed overchan[305409]: input line too long, skipping
Aug 1 17:58:38 newsfeed overchan[305409]: input line too long, skipping
Aug 1 18:00:07 newsfeed overchan[305409]: input line too long, skipping
Aug 1 18:01:51 newsfeed overchan[305409]: input line too long, skipping
Aug 1 21:09:03 newsfeed overchan[305409]: input line too long, skipping
Aug 1 22:16:17 newsfeed overchan[305409]: input line too long, skipping
Aug 1 22:59:42 newsfeed overchan[305409]: input line too long, skipping
Aug 2 00:27:43 newsfeed overchan[305409]: input line too long, skipping
Aug 2 00:42:47 newsfeed overchan[305409]: input line too long, skipping
Aug 2 02:30:09 newsfeed pgpverify[365931]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 109353 90.7%12.5 MB 91.8%
nnrpd 7685 6.4%751.0 KB 5.4%
innd 2078 1.7%240.5 KB 1.7%
innfeed 1366 1.1%146.7 KB 1.1%
overchan 27 0.0%2.8 KB 0.0%
controlchan 11 0.0%2.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 120521 100.0%13.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 108431 98.8%
Negative hits 967 0.9%
Positive hits 375 0.3%
Cache misses 20 0.0%
TOTAL: 4 109793 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.731 0.0%33 0.000 22.152 93.000
article cleanup00:00:00.586 0.0%108948 0.000 0.005 0.019
article logging00:00:02.420 0.0%109239 0.008 0.022 0.038
article parse00:00:03.511 0.0%593141 0.002 0.006 0.013
article write00:00:16.471 0.0%108796 0.055 0.151 1.398
artlog/artcncl00:00:00.000 0.0%33 0.000 0.000 0.000
data move00:00:00.744 0.0%842069 0.000 0.001 0.003
hisgrep/artcncl00:00:00.268 0.0%33 0.000 8.121 36.500
hishave/artcncl00:00:00.003 0.0%33 0.000 0.091 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:28.854 0.1%110410 0.212 0.805 18.431
history sync00:00:00.014 0.0%375 0.000 0.037 0.500
history write00:11:33.732 0.8%108930 3.752 6.369 33.218
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:45:15.122 98.9%692521 15.714 123.484 406.034
nntp read00:00:08.385 0.0%589541 0.009 0.014 0.025
overview write00:00:00.287 0.0%108796 0.000 0.003 0.008
perl filter00:01:43.946 0.1%108930 0.647 0.954 1.338
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.981 0.0%228567 0.006 0.013 0.024
TOTAL: 24:01:01.30624:00:38.055100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.028 0.0%10957 0.000 0.003 0.053
article prepare00:00:00.000 0.0%156 0.000 0.000 0.000
article read00:00:00.001 0.0%39 0.000 0.026 0.500
backlog stats00:00:00.024 0.0%51225 0.000 0.000 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.234 0.0%26530 0.000 0.009 0.031
data write00:00:00.558 0.0%15667 0.000 0.036 0.099
idle23:57:24.770100.0%51225 893.004 1683.646 3849.205
status file00:00:02.759 0.0%367 0.000 7.518 123.000
TOTAL: 23:57:29.54423:57:28.374100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.884 62.2%4177 0.000 7.394 5477.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.123 0.2%10124 0.000 0.012 0.500
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:00:49.64100:00:31.007 62.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 99 108898 108763 7 128 99%42:51:24
2news.icm.edu.pl 31 417 26 359 32 6%21:18:47
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 131 109315 108789 366 160 99%64:10:11
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.5 GB275.5 KB556.2 KB1.5 GB 99%14.8 KB
2news.icm.edu.pl1.1 MB18.3 KB1.4 MB2.5 MB 42%44.4 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 31.5 GB293.8 KB2.0 MB1.5 GB 99%14.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 1 04:15:01 - 04:59:59 4135 3.8% 1.5356.6 MB 3.6% 21.47
Aug 1 05:00:00 - 05:59:59 3899 3.6% 1.0854.0 MB 3.4% 15.35
Aug 1 06:00:00 - 06:59:59 2204 2.0% 0.6129.4 MB 1.9% 8.35
Aug 1 07:00:00 - 07:59:59 3848 3.5% 1.0761.3 MB 3.9% 17.43
Aug 1 08:00:00 - 08:59:59 5750 5.3% 1.6053.7 MB 3.4% 15.28
Aug 1 09:00:00 - 09:59:59 3604 3.3% 1.0051.7 MB 3.3% 14.71
Aug 1 10:00:00 - 10:59:59 4087 3.8% 1.1460.7 MB 3.9% 17.27
Aug 1 11:00:00 - 11:59:59 6419 5.9% 1.7869.2 MB 4.4% 19.68
Aug 1 12:00:00 - 12:59:59 4753 4.4% 1.3272.6 MB 4.6% 20.64
Aug 1 13:00:00 - 13:59:59 4827 4.4% 1.34151.6 MB 9.6% 43.13
Aug 1 14:00:00 - 14:59:59 3490 3.2% 0.9747.8 MB 3.0% 13.58
Aug 1 15:00:00 - 15:59:59 5989 5.5% 1.6665.8 MB 4.2% 18.72
Aug 1 16:00:00 - 16:59:59 3224 3.0% 0.9054.5 MB 3.5% 15.50
Aug 1 17:00:00 - 17:59:59 3422 3.1% 0.9553.1 MB 3.4% 15.12
Aug 1 18:00:00 - 18:59:59 4132 3.8% 1.1564.2 MB 4.1% 18.27
Aug 1 19:00:00 - 19:59:59 4552 4.2% 1.2652.3 MB 3.3% 14.88
Aug 1 20:00:00 - 20:59:59 7256 6.7% 2.02105.1 MB 6.7% 29.89
Aug 1 21:00:00 - 21:59:59 4870 4.5% 1.3573.3 MB 4.7% 20.84
Aug 1 22:00:00 - 22:59:59 4340 4.0% 1.2161.2 MB 3.9% 17.41
Aug 1 23:00:00 - 23:59:59 3860 3.5% 1.0751.1 MB 3.3% 14.54
Aug 2 00:00:00 - 00:59:59 4271 3.9% 1.1961.2 MB 3.9% 17.41
Aug 2 01:00:00 - 01:59:59 5861 5.4% 1.6394.7 MB 6.0% 26.93
Aug 2 02:00:00 - 02:59:59 5147 4.7% 1.4361.5 MB 3.9% 17.50
Aug 2 03:00:00 - 03:59:59 3986 3.7% 1.1153.5 MB 3.4% 15.21
Aug 2 04:00:00 - 04:15:02 952 0.9% 1.0612.0 MB 0.8% 13.57
TOTAL: 24:00:01 108878 100.0% 1.261.5 GB 100.0% 18.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 418 112 0 16 0 0 0 0 290
2news.icm.edu.pl 24 0 0 2 0 0 0 0 22
TOTAL: 2 442 112 0 18 0 0 0 0 312

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 64
comp.mobile.android 19
it.tlc.cellulari.android 12
alt.comp.software.seamonkey 5
alt.comp.software.firefox 5
comp.sys.raspberry-pi 4
it.discussioni.energia 2
de.rec.sf.startrek 1
TOTAL: 8 112

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 18
Scoring filter (9) 4
TOTAL: 2 22

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15566 34 10772 5 0 0 0%23:59:59
2nask 0 0 0 0 0 7552 0%23:57:48
3panorama 0 0 0 0 0 10965 0%23:57:48
4okapi 0 0 0 0 0 850 0%23:57:48
5poznan 36 0 25 0 0 0 0%03:44:40
TOTAL: 5 15602 34 10797 5 0 19367 0%99:38:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm155.2 KB18.7 KB173.9 KB0.0 KB/s4.5 KB23:59:59
2nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:44:40
TOTAL: 5155.2 KB18.7 KB173.9 KB0.0 KB/s4.5 KB99:38:03
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.8 KB
okapi488.3 KB
TOTAL: 21.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 295 42.8 KB 2 0 000:00:09
TOTAL: 1 295 42.8 KB 2 0 000:00:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1735 42.8 KB 2 0 000:00:23
2unresolved 107 00.0 KB 0 0 000:00:25
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.ip-145-239-154.eu 2 00.0 KB 0 0 000:00:00
TOTAL: 41845 42.8 KB 2 0 000:00:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
188.117.184.26 0.000 0.010 0.00000:00:21
nms2.man.lodz.pl 3.823 5.820 0.00000:00:14
web.man.lodz.pl 0.850 1.229 0.00000:00:09
80.111.142.213 0.022 0.009 0.00000:00:02
212.51.192.185 0.274 0.447 0.00000:00:01
71.6.134.235 0.014 0.009 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.000 0.007 0.00000:00:00
ns31410046.ip-145-239-154.eu 0.009 0.004 0.00000:00:00
162.243.146.72 0.000 0.005 0.00000:00:00
89.248.163.84 0.005 0.005 0.00000:00:00
TOTAL: 10 4.997 7.545 0.00000:00:50

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
71.6.134.235 3
ns31410046.ip-145-239-154.eu 2
188.117.184.26 2
89.248.163.84 1
162.243.146.72 1
scanner-08.ch1.censys-scanner.com 1
TOTAL: 9 1550

NNRP unrecognized commands (by host):

SystemConn
71.6.134.235 9
89.248.163.84 1
162.243.146.72 1
ns31410046.ip-145-239-154.eu 1
scanner-08.ch1.censys-scanner.com 1
TOTAL: 5 13

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
#026#003#001 1
Accept-Encoding: gzip 1
#023#003#023#001#023#002#001 1
Host: 212.191.2.21:119 1
#O#015 1
MGLNDD_212.191.2.21_119 1
#003 1
EHLO www.censys.io 1
1
GET / HTTP/1.1 1
#026#003 1
Accept: */* 1
TOTAL: 13 13

NNRP client timeouts [Top 20]:

SystemConnPeer
89.248.163.84 1 1
TOTAL: 1 1 1

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 2
2pl.comp.pecet 2
TOTAL: 2 4