Daily Usenet report

Aug 15 04:15:02 -- Aug 16 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Aug 15 07:20:05 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 09:09:03 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 12:40:29 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 13:16:53 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 16:34:50 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 16:49:07 newsfeed nnrpd[2877658]: SERVER perl filter not defined
Aug 15 17:00:04 newsfeed pgpverify[2878414]: pgpverify: /usr/bin/gpg1: no such file
Aug 15 17:00:05 newsfeed pgpverify[2878425]: pgpverify: /usr/bin/gpg1: no such file
Aug 15 17:49:31 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 20:08:46 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 20:08:59 newsfeed overchan[2834809]: input line too long, skipping
Aug 15 20:19:17 newsfeed overchan[2834809]: input line too long, skipping
Aug 16 02:47:34 newsfeed overchan[2834809]: input line too long, skipping
Aug 16 03:12:33 newsfeed overchan[2834809]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 534013 93.8%59.1 MB 93.1%
innfeed 23251 4.1%2.8 MB 4.4%
innd 8378 1.5%1.3 MB 2.0%
nnrpd 3332 0.6%318.4 KB 0.5%
controlchan 23 0.0%4.9 KB 0.0%
overchan 12 0.0%2.0 KB 0.0%
pgpverify 2 0.0%0.5 KB 0.0%
TOTAL: 7 569011 100.0%63.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 528039 99.7%
Negative hits 1517 0.3%
Positive hits 213 0.0%
Cache misses 22 0.0%
TOTAL: 4 529791 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.662 0.0%77 0.000 8.597 140.000
article cleanup00:00:03.839 0.0%533280 0.004 0.007 0.016
article logging00:00:13.072 0.0%534197 0.018 0.024 0.032
article parse00:06:26.385 0.4%109475843 0.003 0.004 0.006
article write00:04:27.371 0.3%533135 0.288 0.502 0.674
artlog/artcncl00:00:00.002 0.0%76 0.000 0.026 1.000
data move00:00:29.151 0.0%113943368 0.000 0.000 0.000
hisgrep/artcncl00:00:00.144 0.0%73 0.000 1.973 15.000
hishave/artcncl00:00:00.005 0.0%77 0.000 0.065 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:23.927 0.2%535190 0.246 0.381 1.029
history sync00:00:00.013 0.0%290 0.000 0.045 0.500
history write00:20:15.764 1.4%533276 0.331 2.280 15.332
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle22:22:31.780 93.2%109346952 0.497 0.737 1.289
nntp read00:21:02.370 1.5%109211568 0.011 0.012 0.015
overview write00:00:01.512 0.0%533135 0.001 0.003 0.005
perl filter00:29:04.574 2.0%533276 2.536 3.271 3.948
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:15.157 0.0%1075972 0.011 0.014 0.018
TOTAL: 24:00:03.17523:48:15.728 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.044 0.0%29910 0.000 0.001 0.011
article prepare00:00:00.001 0.0%8530 0.000 0.000 0.018
article read00:00:09.833 0.0%2140 0.000 4.595 486.667
backlog stats00:00:00.043 0.0%83338 0.000 0.001 0.005
callbacks00:00:00.000 0.0%8 0.000 0.000 0.000
data read00:00:00.374 0.0%39507 0.000 0.009 0.034
data write00:00:00.893 0.0%30229 0.000 0.030 0.071
idle23:56:26.276100.0%83338 625.916 1034.177 2325.841
status file00:00:05.452 0.0%7608 0.438 0.717 5.303
TOTAL: 23:56:44.90023:56:42.916100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:09.517 58.9%2745 0.000 3.467 2251.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.073 0.5%5816 0.000 0.013 0.500
readart00:00:00.000 0.0%12 0.000 0.000 0.000
TOTAL: 00:00:16.15700:00:09.590 59.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
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 137 533240 533105 0 135 99%72:18:03
2news.icm.edu.pl 47 174 5 159 10 2%15:03:33
3localhost 1442 1 1 0 0 100%00:00:00
TOTAL: 3 1626 533415 533111 159 145 99%87:21:36
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl257.0 GB295.8 KB789.4 KB257.0 GB 99%505.4 KB
2news.icm.edu.pl422.6 KB0.0 KB291.2 KB713.8 KB 59%47.6 KB
3localhost1.8 KB0.0 KB0.0 KB1.8 KB100%1.8 KB
TOTAL: 3257.0 GB295.8 KB1.1 MB257.0 GB 99%505.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 15 04:15:02 - 04:59:59 16839 3.2% 6.248.5 GB 3.3%3315.37
Aug 15 05:00:00 - 05:59:59 21660 4.1% 6.0210.5 GB 4.1%3064.75
Aug 15 06:00:00 - 06:59:59 19507 3.7% 5.429.3 GB 3.6%2708.63
Aug 15 07:00:00 - 07:59:59 19878 3.7% 5.5210.6 GB 4.1%3095.18
Aug 15 08:00:00 - 08:59:59 23036 4.3% 6.4011.4 GB 4.4%3309.43
Aug 15 09:00:00 - 09:59:59 20025 3.8% 5.5610.8 GB 4.2%3133.13
Aug 15 10:00:00 - 10:59:59 21345 4.0% 5.9311.0 GB 4.3%3195.92
Aug 15 11:00:00 - 11:59:59 21377 4.0% 5.9410.5 GB 4.1%3068.17
Aug 15 12:00:00 - 12:59:59 22966 4.3% 6.3811.3 GB 4.4%3294.81
Aug 15 13:00:00 - 13:59:59 21564 4.0% 5.9911.3 GB 4.4%3301.62
Aug 15 14:00:00 - 14:59:59 21738 4.1% 6.0411.3 GB 4.4%3300.82
Aug 15 15:00:00 - 15:59:59 21312 4.0% 5.9211.3 GB 4.4%3278.98
Aug 15 16:00:00 - 16:59:59 28432 5.3% 7.9011.1 GB 4.3%3231.91
Aug 15 17:00:00 - 17:59:59 23742 4.5% 6.5911.2 GB 4.4%3271.94
Aug 15 18:00:00 - 18:59:59 26201 4.9% 7.2812.5 GB 4.8%3635.90
Aug 15 19:00:00 - 19:59:59 23492 4.4% 6.5311.3 GB 4.4%3287.57
Aug 15 20:00:00 - 20:59:59 29315 5.5% 8.1411.4 GB 4.4%3321.12
Aug 15 21:00:00 - 21:59:59 23043 4.3% 6.4010.7 GB 4.2%3125.84
Aug 15 22:00:00 - 22:59:59 27707 5.2% 7.7010.3 GB 4.0%3005.57
Aug 15 23:00:00 - 23:59:59 21551 4.0% 5.9911.1 GB 4.3%3239.06
Aug 16 00:00:00 - 00:59:59 18872 3.5% 5.249.6 GB 3.7%2793.85
Aug 16 01:00:00 - 01:59:59 17950 3.4% 4.999.0 GB 3.5%2612.10
Aug 16 02:00:00 - 02:59:59 20344 3.8% 5.6510.1 GB 3.9%2953.12
Aug 16 03:00:00 - 03:59:59 15907 3.0% 4.428.8 GB 3.4%2548.69
Aug 16 04:00:00 - 04:15:02 5068 1.0% 5.622.5 GB 1.0%2943.90
TOTAL: 24:00:00 532871 100.0% 6.17257.5 GB 100.0%3125.02
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 1054 121 0 4 5 0 0 0 924
2news.icm.edu.pl 12 0 0 0 0 0 0 0 12
TOTAL: 2 1066 121 0 4 5 0 0 0 936

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 73
nl.comp.os.linux.techniek 18
comp.sys.raspberry-pi 11
it.tlc.cellulari.android 7
comp.mobile.android 3
alt.comp.software.firefox 3
alt.comp.software.seamonkey 2
de.rec.sf.startrek 2
it.comp.os.win.windows10 1
it.comp.dotnet 1
TOTAL: 10 121

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

GroupsCount
pl.praca.oferowana 5
TOTAL: 1 5

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 12
EMP (md5) 5
TOTAL: 2 17

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 16786 1517 7688 107 0 1 9%23:59:36
2panorama 20631 184 7857 109 17 21830 0%23:59:58
3nask 0 0 0 0 0 7192 0%23:57:47
4okapi 0 0 0 0 0 976 0%23:57:47
5poznan 6 0 4 0 0 0 0%00:50:10
TOTAL: 5 37423 1701 15549 216 17 29999 4%96:45:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm6.8 MB802.5 KB7.6 MB0.1 KB/s4.8 KB23:59:36
2panorama754.1 KB1.6 MB2.4 MB0.0 KB/s8.2 KB23:59:58
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:50:10
TOTAL: 57.5 MB2.4 MB9.9 MB0.0 KB/s5.3 KB96:45:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 290 1213.7 KB 5 0 000:00:09
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 291 1213.7 KB 5 1 000:00:16

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 291 1213.7 KB 5 1 000:00:09
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 103 00.0 KB 0 0 000:00:05
TOTAL: 3 395 1213.7 KB 5 1 000:00:16

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.811 5.545 0.00000:00:09
193.218.118.95 0.005 0.010 0.00000:00:02
80.111.142.213 0.009 0.071 0.00000:00:02
212.51.192.185 0.201 1.666 0.00000:00:01
scanner-07.ch1.censys-scanner.com 0.003 0.021 0.00000:00:00
94.102.61.41 0.006 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.000 0.032 0.00000:00:00
31.43.185.54 0.004 0.014 0.00000:00:00
TOTAL: 8 1.039 7.369 0.00000:00:16

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
31.43.185.54 1
scanner-07.ch1.censys-scanner.com 1
193.218.118.95 1
94.102.61.41 1
TOTAL: 6 104

NNRP unrecognized commands (by host):

SystemConn
94.102.61.41 5
scanner-07.ch1.censys-scanner.com 1
31.43.185.54 1
TOTAL: 3 7

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
Accept: */* 1
EHLO www.censys.io 1
#003 1
Accept-Encoding: gzip 1
Host: 212.191.2.21:119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 7 7

NNRP client timeouts [Top 20]:

SystemConnPeer
31.43.185.54 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 6
2pl.comp.pecet 6
TOTAL: 2 12